builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1500473344.25 results: success (0) revision: a1ea69a3a0a760036e047f6ff89897aa7ffd4e53 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-19 07:09:04.249093) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-19 07:09:04.249532) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-19 07:09:04.252837) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-19 07:09:04.285666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-19 07:09:04.285936) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-19 07:09:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.2M=0s 2017-07-19 07:09:04 (34.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.183523 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-19 07:09:04.491060) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-19 07:09:04.491374) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.083418 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-19 07:09:04.586213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-19 07:09:04.586537) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a1ea69a3a0a760036e047f6ff89897aa7ffd4e53 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev a1ea69a3a0a760036e047f6ff89897aa7ffd4e53 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-19 07:09:04,710 truncating revision to first 12 chars 2017-07-19 07:09:04,710 Setting DEBUG logging. 2017-07-19 07:09:04,710 attempt 1/10 2017-07-19 07:09:04,710 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a1ea69a3a0a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-19 07:09:05,833 unpacking tar archive at: mozilla-central-a1ea69a3a0a7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.456673 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-19 07:09:06.058396) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-19 07:09:06.061704) ========= script_repo_revision: a1ea69a3a0a760036e047f6ff89897aa7ffd4e53 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-19 07:09:06.062065) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-19 07:09:06.062343) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-19 07:09:06.071169) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-07-19 07:09:06.071429) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:09:06 INFO - MultiFileLogger online at 20170719 07:09:06 in /builds/slave/test 07:09:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:09:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:09:06 INFO - {'append_to_log': False, 07:09:06 INFO - 'base_work_dir': '/builds/slave/test', 07:09:06 INFO - 'blob_upload_branch': 'Firefox', 07:09:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:09:06 INFO - 'branch': 'Firefox', 07:09:06 INFO - 'buildbot_json_path': 'buildprops.json', 07:09:06 INFO - 'code_coverage': False, 07:09:06 INFO - 'config_files': ('talos/linux_config.py',), 07:09:06 INFO - 'default_actions': ('clobber', 07:09:06 INFO - 'read-buildbot-config', 07:09:06 INFO - 'download-and-extract', 07:09:06 INFO - 'populate-webroot', 07:09:06 INFO - 'create-virtualenv', 07:09:06 INFO - 'install', 07:09:06 INFO - 'setup-mitmproxy', 07:09:06 INFO - 'run-tests'), 07:09:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:09:06 INFO - 'disable_ccov_upload': False, 07:09:06 INFO - 'download_minidump_stackwalk': True, 07:09:06 INFO - 'download_symbols': 'ondemand', 07:09:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:09:06 INFO - 'tooltool.py': '/tools/tooltool.py', 07:09:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:09:06 INFO - '/tools/misc-python/virtualenv.py')}, 07:09:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:09:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:09:06 INFO - 'gecko_profile': False, 07:09:06 INFO - 'gecko_profile_interval': 0, 07:09:06 INFO - 'installer_path': 'installer.exe', 07:09:06 INFO - 'log_level': 'info', 07:09:06 INFO - 'log_name': 'talos', 07:09:06 INFO - 'log_to_console': True, 07:09:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:09:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:09:06 INFO - 'opt_config_files': (), 07:09:06 INFO - 'pip_index': False, 07:09:06 INFO - 'suite': 'dromaeojs-e10s', 07:09:06 INFO - 'system_bits': '32', 07:09:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:09:06 INFO - 'title': 'talos-linux64-ix-037', 07:09:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:09:06 INFO - 'use_talos_json': True, 07:09:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:09:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:09:06 INFO - 'work_dir': 'build'} 07:09:06 INFO - [mozharness: 2017-07-19 14:09:06.394949Z] Running clobber step. 07:09:06 INFO - Running pre-action listener: _resource_record_pre_action 07:09:06 INFO - Running main action method: clobber 07:09:06 INFO - rmtree: /builds/slave/test/build 07:09:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:09:08 INFO - Running post-action listener: _resource_record_post_action 07:09:08 INFO - [mozharness: 2017-07-19 14:09:08.564364Z] Finished clobber step (success) 07:09:08 INFO - [mozharness: 2017-07-19 14:09:08.564534Z] Running read-buildbot-config step. 07:09:08 INFO - Running pre-action listener: _resource_record_pre_action 07:09:08 INFO - Running main action method: read_buildbot_config 07:09:08 INFO - Using buildbot properties: 07:09:08 INFO - { 07:09:08 INFO - "project": "", 07:09:08 INFO - "product": "firefox", 07:09:08 INFO - "who": "ryanvm@gmail.com", 07:09:08 INFO - "installer_path": "public/build/target.tar.bz2", 07:09:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 07:09:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:09:08 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 07:09:08 INFO - "stage_platform": "linux64-stylosequential", 07:09:08 INFO - "basedir": "/builds/slave/test", 07:09:08 INFO - "buildnumber": 109, 07:09:08 INFO - "platform": "ubuntu64_hw_styloseq", 07:09:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:09:08 INFO - "slavebuilddir": "test", 07:09:08 INFO - "taskId": "TuuFlYgzRUm27fK9O3HWgQ", 07:09:08 INFO - "branch": "mozilla-central", 07:09:08 INFO - "script_repo_revision": "production", 07:09:08 INFO - "revision": "a1ea69a3a0a760036e047f6ff89897aa7ffd4e53", 07:09:08 INFO - "slavename": "talos-linux64-ix-037", 07:09:08 INFO - "repo_path": "mozilla-central" 07:09:08 INFO - } 07:09:08 INFO - Finding installer, test and symbols from parent task. 07:09:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TuuFlYgzRUm27fK9O3HWgQ'}, attempt #1 07:09:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TuuFlYgzRUm27fK9O3HWgQ'}, attempt #1 07:09:09 INFO - Task dependencies: Q1PdNsqnTLOSjELWpWPYXw 07:09:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw'}, attempt #1 07:09:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.tar.bz2 07:09:09 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/test_packages.json 07:09:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.crashreporter-symbols.zip 07:09:09 INFO - Running post-action listener: _resource_record_post_action 07:09:09 INFO - [mozharness: 2017-07-19 14:09:09.972036Z] Finished read-buildbot-config step (success) 07:09:09 INFO - [mozharness: 2017-07-19 14:09:09.972259Z] Running download-and-extract step. 07:09:09 INFO - Running pre-action listener: _resource_record_pre_action 07:09:09 INFO - Running main action method: download_and_extract 07:09:09 INFO - mkdir: /builds/slave/test/build/tests 07:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:09 INFO - trying https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.test_packages.json 07:09:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:09:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:09:10 INFO - Downloaded 989 bytes. 07:09:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:09:10 INFO - Using the following test package requirements: 07:09:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:09:10 INFO - u'common': [u'target.common.tests.zip'], 07:09:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:09:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:09:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:09:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:09:10 INFO - u'mozbase': [u'target.common.tests.zip'], 07:09:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:09:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:09:10 INFO - u'web-platform': [u'target.common.tests.zip', 07:09:10 INFO - u'target.web-platform.tests.tar.gz'], 07:09:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:09:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:09:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.common.tests.zip 07:09:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:09:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.common.tests.zip into memory 07:09:11 INFO - Content-Length response header: 72754703 07:09:11 INFO - Bytes received: 72754703 07:09:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:09:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.common.tests.zip 07:09:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:09:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.common.tests.zip into memory 07:09:24 INFO - Content-Length response header: 72754703 07:09:24 INFO - Bytes received: 72754703 07:09:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.talos.tests.zip 07:09:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:09:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.talos.tests.zip into memory 07:09:38 INFO - Content-Length response header: 14498903 07:09:38 INFO - Bytes received: 14498903 07:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:38 INFO - trying https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.tar.bz2 07:09:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:09:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:09:39 INFO - Downloaded 61917293 bytes. 07:09:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.tar.bz2 07:09:39 INFO - mkdir: /builds/slave/test/properties 07:09:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:09:39 INFO - Writing to file /builds/slave/test/properties/build_url 07:09:39 INFO - Contents: 07:09:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.tar.bz2 07:09:39 INFO - Running post-action listener: _resource_record_post_action 07:09:39 INFO - Running post-action listener: set_extra_try_arguments 07:09:39 INFO - [mozharness: 2017-07-19 14:09:39.501595Z] Finished download-and-extract step (success) 07:09:39 INFO - [mozharness: 2017-07-19 14:09:39.501693Z] Running populate-webroot step. 07:09:39 INFO - Running pre-action listener: _resource_record_pre_action 07:09:39 INFO - Running main action method: populate_webroot 07:09:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:09:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:09:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:09:39 INFO - '--tppagecycles', 07:09:39 INFO - '7'], 07:09:39 INFO - 'tests': ['tsvgm']}}, 07:09:39 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:09:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:09:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:09:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:09:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:09:39 INFO - 'talos_options': ['--disable-e10s'], 07:09:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:09:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:09:39 INFO - 'talos_options': ['--disable-e10s'], 07:09:39 INFO - 'tests': ['damp', 'tps']}, 07:09:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:09:39 INFO - 'tests': ['damp', 'tps']}, 07:09:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:09:39 INFO - 'tests': ['dromaeo_dom']}, 07:09:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:09:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:09:39 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 07:09:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:09:39 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:09:39 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:09:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:09:39 INFO - 'tests': ['a11yr', 07:09:39 INFO - 'ts_paint', 07:09:39 INFO - 'tpaint', 07:09:39 INFO - 'sessionrestore', 07:09:39 INFO - 'sessionrestore_no_auto_restore', 07:09:39 INFO - 'tabpaint']}, 07:09:39 INFO - 'other-e10s': {'tests': ['a11yr', 07:09:39 INFO - 'ts_paint', 07:09:39 INFO - 'tpaint', 07:09:39 INFO - 'sessionrestore', 07:09:39 INFO - 'sessionrestore_many_windows', 07:09:39 INFO - 'sessionrestore_no_auto_restore', 07:09:39 INFO - 'tabpaint']}, 07:09:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:09:39 INFO - 'ts_paint', 07:09:39 INFO - 'tpaint', 07:09:39 INFO - 'sessionrestore', 07:09:39 INFO - 'sessionrestore_many_windows', 07:09:39 INFO - 'sessionrestore_no_auto_restore', 07:09:39 INFO - 'tabpaint']}, 07:09:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:09:39 INFO - 'ts_paint', 07:09:39 INFO - 'tpaint', 07:09:39 INFO - 'sessionrestore', 07:09:39 INFO - 'sessionrestore_many_windows', 07:09:39 INFO - 'sessionrestore_no_auto_restore', 07:09:39 INFO - 'tabpaint']}, 07:09:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:09:39 INFO - 'tests': ['a11yr', 07:09:39 INFO - 'ts_paint', 07:09:39 INFO - 'tpaint', 07:09:39 INFO - 'sessionrestore', 07:09:39 INFO - 'sessionrestore_no_auto_restore', 07:09:39 INFO - 'tabpaint']}, 07:09:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:09:39 INFO - 'tests': ['a11yr', 07:09:39 INFO - 'ts_paint', 07:09:39 INFO - 'tpaint', 07:09:39 INFO - 'sessionrestore', 07:09:39 INFO - 'sessionrestore_no_auto_restore', 07:09:39 INFO - 'tabpaint']}, 07:09:39 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 07:09:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:09:39 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 07:09:39 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:09:39 INFO - 'talos_options': ['--mitmproxy', 07:09:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:09:39 INFO - '--firstNonBlankPaint'], 07:09:39 INFO - 'tests': ['quantum_pageload_google', 07:09:39 INFO - 'quantum_pageload_youtube', 07:09:39 INFO - 'quantum_pageload_amazon', 07:09:39 INFO - 'quantum_pageload_facebook']}, 07:09:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:09:39 INFO - 'tests': ['tsvgx', 07:09:39 INFO - 'tsvgr_opacity', 07:09:39 INFO - 'tart', 07:09:39 INFO - 'tscrollx', 07:09:39 INFO - 'cart', 07:09:39 INFO - 'tsvg_static']}, 07:09:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:09:39 INFO - 'tsvgr_opacity', 07:09:39 INFO - 'tart', 07:09:39 INFO - 'tscrollx', 07:09:39 INFO - 'cart', 07:09:39 INFO - 'tsvg_static']}, 07:09:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:09:39 INFO - 'talos_options': ['--disable-e10s'], 07:09:39 INFO - 'tests': ['tp5o']}, 07:09:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:09:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:09:39 INFO - 'talos_options': ['--disable-e10s', 07:09:39 INFO - '--xperf_path', 07:09:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:39 INFO - 'tests': ['tp5n']}, 07:09:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:09:39 INFO - 'talos_options': ['--xperf_path', 07:09:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:39 INFO - 'tests': ['tp5n']}}, 07:09:39 INFO - 'talos.zip': {'path': '', 07:09:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:09:39 INFO - Running post-action listener: _resource_record_post_action 07:09:39 INFO - [mozharness: 2017-07-19 14:09:39.516974Z] Finished populate-webroot step (success) 07:09:39 INFO - [mozharness: 2017-07-19 14:09:39.517065Z] Running create-virtualenv step. 07:09:39 INFO - Running pre-action listener: _resource_record_pre_action 07:09:39 INFO - Running main action method: create_virtualenv 07:09:39 INFO - Creating virtualenv /builds/slave/test/build/venv 07:09:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:09:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:09:39 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:09:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:09:39 INFO - Using real prefix '/usr' 07:09:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:09:40 INFO - Installing distribute.............................................................................................................................................................................................done. 07:09:42 INFO - Installing pip.................done. 07:09:42 INFO - Return code: 0 07:09:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:09:42 INFO - Reading from file tmpfile_stdout 07:09:42 INFO - Output received: 07:09:42 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:09:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf20b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1dd00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1f090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:09:42 INFO - Using env: {'DISPLAY': ':0', 07:09:42 INFO - 'HOME': '/home/cltbld', 07:09:42 INFO - 'LANG': 'en_US.UTF-8', 07:09:42 INFO - 'LANGUAGE': 'en_US:en', 07:09:42 INFO - 'LOGNAME': 'cltbld', 07:09:42 INFO - 'MAIL': '/var/mail/cltbld', 07:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:42 INFO - 'MOZ_NO_REMOTE': '1', 07:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:42 INFO - 'NO_EM_RESTART': '1', 07:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:42 INFO - 'PWD': '/builds/slave/test', 07:09:42 INFO - 'SHELL': '/bin/bash', 07:09:42 INFO - 'SHLVL': '1', 07:09:42 INFO - 'TERM': 'linux', 07:09:42 INFO - 'TMOUT': '86400', 07:09:42 INFO - 'USER': 'cltbld', 07:09:42 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 07:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:42 INFO - '_': '/tools/buildbot/bin/python'} 07:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:09:42 INFO - Cleaning up... 07:09:42 INFO - Return code: 0 07:09:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf20b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1dd00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1f090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:09:42 INFO - Using env: {'DISPLAY': ':0', 07:09:42 INFO - 'HOME': '/home/cltbld', 07:09:42 INFO - 'LANG': 'en_US.UTF-8', 07:09:42 INFO - 'LANGUAGE': 'en_US:en', 07:09:42 INFO - 'LOGNAME': 'cltbld', 07:09:42 INFO - 'MAIL': '/var/mail/cltbld', 07:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:42 INFO - 'MOZ_NO_REMOTE': '1', 07:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:42 INFO - 'NO_EM_RESTART': '1', 07:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:42 INFO - 'PWD': '/builds/slave/test', 07:09:42 INFO - 'SHELL': '/bin/bash', 07:09:42 INFO - 'SHLVL': '1', 07:09:42 INFO - 'TERM': 'linux', 07:09:42 INFO - 'TMOUT': '86400', 07:09:42 INFO - 'USER': 'cltbld', 07:09:42 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 07:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:42 INFO - '_': '/tools/buildbot/bin/python'} 07:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:42 INFO - Downloading/unpacking psutil>=3.1.1 07:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:09:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:44 INFO - Installing collected packages: psutil 07:09:44 INFO - Running setup.py install for psutil 07:09:44 INFO - building 'psutil._psutil_linux' extension 07:09:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:09:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:09:45 INFO - building 'psutil._psutil_posix' extension 07:09:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:09:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:09:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:45 INFO - Successfully installed psutil 07:09:45 INFO - Cleaning up... 07:09:45 INFO - Return code: 0 07:09:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf20b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1dd00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1f090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:09:45 INFO - Using env: {'DISPLAY': ':0', 07:09:45 INFO - 'HOME': '/home/cltbld', 07:09:45 INFO - 'LANG': 'en_US.UTF-8', 07:09:45 INFO - 'LANGUAGE': 'en_US:en', 07:09:45 INFO - 'LOGNAME': 'cltbld', 07:09:45 INFO - 'MAIL': '/var/mail/cltbld', 07:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:45 INFO - 'MOZ_NO_REMOTE': '1', 07:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:45 INFO - 'NO_EM_RESTART': '1', 07:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:45 INFO - 'PWD': '/builds/slave/test', 07:09:45 INFO - 'SHELL': '/bin/bash', 07:09:45 INFO - 'SHLVL': '1', 07:09:45 INFO - 'TERM': 'linux', 07:09:45 INFO - 'TMOUT': '86400', 07:09:45 INFO - 'USER': 'cltbld', 07:09:45 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 07:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:45 INFO - '_': '/tools/buildbot/bin/python'} 07:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:09:47 INFO - Installing collected packages: mozsystemmonitor 07:09:47 INFO - Running setup.py install for mozsystemmonitor 07:09:47 INFO - Successfully installed mozsystemmonitor 07:09:47 INFO - Cleaning up... 07:09:47 INFO - Return code: 0 07:09:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf20b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1dd00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1f090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:09:47 INFO - Using env: {'DISPLAY': ':0', 07:09:47 INFO - 'HOME': '/home/cltbld', 07:09:47 INFO - 'LANG': 'en_US.UTF-8', 07:09:47 INFO - 'LANGUAGE': 'en_US:en', 07:09:47 INFO - 'LOGNAME': 'cltbld', 07:09:47 INFO - 'MAIL': '/var/mail/cltbld', 07:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:47 INFO - 'MOZ_NO_REMOTE': '1', 07:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:47 INFO - 'NO_EM_RESTART': '1', 07:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:47 INFO - 'PWD': '/builds/slave/test', 07:09:47 INFO - 'SHELL': '/bin/bash', 07:09:47 INFO - 'SHLVL': '1', 07:09:47 INFO - 'TERM': 'linux', 07:09:47 INFO - 'TMOUT': '86400', 07:09:47 INFO - 'USER': 'cltbld', 07:09:47 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 07:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:47 INFO - '_': '/tools/buildbot/bin/python'} 07:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:47 INFO - Downloading/unpacking jsonschema==2.5.1 07:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:09:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:48 INFO - Downloading functools32-3.2.3-2.tar.gz 07:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:09:48 INFO - warning: no files found matching '*.txt' 07:09:48 INFO - no previously-included directories found matching 'build' 07:09:48 INFO - no previously-included directories found matching 'dist' 07:09:48 INFO - no previously-included directories found matching '.git*' 07:09:48 INFO - Installing collected packages: jsonschema, functools32 07:09:48 INFO - Running setup.py install for functools32 07:09:48 INFO - warning: no files found matching '*.txt' 07:09:48 INFO - no previously-included directories found matching 'build' 07:09:48 INFO - no previously-included directories found matching 'dist' 07:09:48 INFO - no previously-included directories found matching '.git*' 07:09:48 INFO - Successfully installed jsonschema functools32 07:09:48 INFO - Cleaning up... 07:09:48 INFO - Return code: 0 07:09:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf20b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1dd00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1f090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:09:48 INFO - Using env: {'DISPLAY': ':0', 07:09:48 INFO - 'HOME': '/home/cltbld', 07:09:48 INFO - 'LANG': 'en_US.UTF-8', 07:09:48 INFO - 'LANGUAGE': 'en_US:en', 07:09:48 INFO - 'LOGNAME': 'cltbld', 07:09:48 INFO - 'MAIL': '/var/mail/cltbld', 07:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:48 INFO - 'MOZ_NO_REMOTE': '1', 07:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:48 INFO - 'NO_EM_RESTART': '1', 07:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:48 INFO - 'PWD': '/builds/slave/test', 07:09:48 INFO - 'SHELL': '/bin/bash', 07:09:48 INFO - 'SHLVL': '1', 07:09:48 INFO - 'TERM': 'linux', 07:09:48 INFO - 'TMOUT': '86400', 07:09:48 INFO - 'USER': 'cltbld', 07:09:48 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 07:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:48 INFO - '_': '/tools/buildbot/bin/python'} 07:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:09:49 INFO - Cleaning up... 07:09:49 INFO - Return code: 0 07:09:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf20b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1dd00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1f090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:09:49 INFO - Using env: {'DISPLAY': ':0', 07:09:49 INFO - 'HOME': '/home/cltbld', 07:09:49 INFO - 'LANG': 'en_US.UTF-8', 07:09:49 INFO - 'LANGUAGE': 'en_US:en', 07:09:49 INFO - 'LOGNAME': 'cltbld', 07:09:49 INFO - 'MAIL': '/var/mail/cltbld', 07:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:49 INFO - 'MOZ_NO_REMOTE': '1', 07:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:49 INFO - 'NO_EM_RESTART': '1', 07:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:49 INFO - 'PWD': '/builds/slave/test', 07:09:49 INFO - 'SHELL': '/bin/bash', 07:09:49 INFO - 'SHLVL': '1', 07:09:49 INFO - 'TERM': 'linux', 07:09:49 INFO - 'TMOUT': '86400', 07:09:49 INFO - 'USER': 'cltbld', 07:09:49 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 07:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:49 INFO - '_': '/tools/buildbot/bin/python'} 07:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:49 INFO - Downloading/unpacking blobuploader==1.2.4 07:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:50 INFO - Downloading blobuploader-1.2.4.tar.gz 07:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:09:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:09:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:50 INFO - Downloading docopt-0.6.1.tar.gz 07:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:09:51 INFO - Installing collected packages: blobuploader, requests, docopt 07:09:51 INFO - Running setup.py install for blobuploader 07:09:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:09:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:09:51 INFO - Running setup.py install for requests 07:09:51 INFO - Running setup.py install for docopt 07:09:51 INFO - Successfully installed blobuploader requests docopt 07:09:51 INFO - Cleaning up... 07:09:51 INFO - Return code: 0 07:09:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf20b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1dd00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1f090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:09:51 INFO - Using env: {'DISPLAY': ':0', 07:09:51 INFO - 'HOME': '/home/cltbld', 07:09:51 INFO - 'LANG': 'en_US.UTF-8', 07:09:51 INFO - 'LANGUAGE': 'en_US:en', 07:09:51 INFO - 'LOGNAME': 'cltbld', 07:09:51 INFO - 'MAIL': '/var/mail/cltbld', 07:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:51 INFO - 'MOZ_NO_REMOTE': '1', 07:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:51 INFO - 'NO_EM_RESTART': '1', 07:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:51 INFO - 'PWD': '/builds/slave/test', 07:09:51 INFO - 'SHELL': '/bin/bash', 07:09:51 INFO - 'SHLVL': '1', 07:09:51 INFO - 'TERM': 'linux', 07:09:51 INFO - 'TMOUT': '86400', 07:09:51 INFO - 'USER': 'cltbld', 07:09:51 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 07:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:51 INFO - '_': '/tools/buildbot/bin/python'} 07:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:51 INFO - Running setup.py (path:/tmp/pip-xXe3Dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:51 INFO - Running setup.py (path:/tmp/pip-L_Z2Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:51 INFO - Running setup.py (path:/tmp/pip-mkjt9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:52 INFO - Running setup.py (path:/tmp/pip-aRk6zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:52 INFO - Running setup.py (path:/tmp/pip-8JC1wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:52 INFO - Running setup.py (path:/tmp/pip-ZOInnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:52 INFO - Running setup.py (path:/tmp/pip-ldScJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:52 INFO - Running setup.py (path:/tmp/pip-b6YqWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:52 INFO - Running setup.py (path:/tmp/pip-x9jB6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:52 INFO - Running setup.py (path:/tmp/pip-pEL7WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:52 INFO - Running setup.py (path:/tmp/pip-FFXpmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:52 INFO - Running setup.py (path:/tmp/pip-KHJ4iC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:52 INFO - Running setup.py (path:/tmp/pip-NgEuEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:52 INFO - Running setup.py (path:/tmp/pip-W9hdUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:52 INFO - Running setup.py (path:/tmp/pip-GAocGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:52 INFO - Running setup.py (path:/tmp/pip-WXCJ77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:52 INFO - Running setup.py (path:/tmp/pip-ElwVP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:09:53 INFO - Running setup.py install for manifestparser 07:09:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:09:53 INFO - Running setup.py install for mozcrash 07:09:53 INFO - Running setup.py install for mozdebug 07:09:53 INFO - Running setup.py install for mozdevice 07:09:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:09:53 INFO - Running setup.py install for mozfile 07:09:53 INFO - Running setup.py install for mozhttpd 07:09:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:09:53 INFO - Running setup.py install for mozinfo 07:09:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:09:53 INFO - Running setup.py install for mozInstall 07:09:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:09:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:09:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:09:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:09:53 INFO - Running setup.py install for mozleak 07:09:53 INFO - Running setup.py install for mozlog 07:09:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:09:54 INFO - Running setup.py install for moznetwork 07:09:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:09:54 INFO - Running setup.py install for mozprocess 07:09:54 INFO - Running setup.py install for mozprofile 07:09:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:09:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:09:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:09:54 INFO - Running setup.py install for mozrunner 07:09:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:09:54 INFO - Running setup.py install for mozscreenshot 07:09:54 INFO - Running setup.py install for moztest 07:09:54 INFO - Running setup.py install for mozversion 07:09:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:09:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:09:54 INFO - Cleaning up... 07:09:54 INFO - Return code: 0 07:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf20b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1dd00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1f090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:09:54 INFO - Using env: {'DISPLAY': ':0', 07:09:54 INFO - 'HOME': '/home/cltbld', 07:09:54 INFO - 'LANG': 'en_US.UTF-8', 07:09:54 INFO - 'LANGUAGE': 'en_US:en', 07:09:54 INFO - 'LOGNAME': 'cltbld', 07:09:54 INFO - 'MAIL': '/var/mail/cltbld', 07:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:54 INFO - 'MOZ_NO_REMOTE': '1', 07:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:54 INFO - 'NO_EM_RESTART': '1', 07:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:54 INFO - 'PWD': '/builds/slave/test', 07:09:54 INFO - 'SHELL': '/bin/bash', 07:09:54 INFO - 'SHLVL': '1', 07:09:54 INFO - 'TERM': 'linux', 07:09:54 INFO - 'TMOUT': '86400', 07:09:54 INFO - 'USER': 'cltbld', 07:09:54 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 07:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:54 INFO - '_': '/tools/buildbot/bin/python'} 07:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:55 INFO - Running setup.py (path:/tmp/pip-vB9lWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:55 INFO - Running setup.py (path:/tmp/pip-2G0q2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:55 INFO - Running setup.py (path:/tmp/pip-gOZhts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:55 INFO - Running setup.py (path:/tmp/pip-AFiKtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:55 INFO - Running setup.py (path:/tmp/pip-w5vRIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:55 INFO - Running setup.py (path:/tmp/pip-jDNCfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:55 INFO - Running setup.py (path:/tmp/pip-6XGGdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:55 INFO - Running setup.py (path:/tmp/pip-j4Whj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:55 INFO - Running setup.py (path:/tmp/pip-JqA4fG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:55 INFO - Running setup.py (path:/tmp/pip-LpCDO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:55 INFO - Running setup.py (path:/tmp/pip-_VDxFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:55 INFO - Running setup.py (path:/tmp/pip-UuYsR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:55 INFO - Running setup.py (path:/tmp/pip-Pxemm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:55 INFO - Running setup.py (path:/tmp/pip-TfYa1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:56 INFO - Running setup.py (path:/tmp/pip-skgjK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:56 INFO - Running setup.py (path:/tmp/pip-dZq3Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:56 INFO - Running setup.py (path:/tmp/pip-gCZUNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:09:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:57 INFO - Downloading blessings-1.6.tar.gz 07:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:09:57 INFO - Installing collected packages: blessings 07:09:57 INFO - Running setup.py install for blessings 07:09:57 INFO - Successfully installed blessings 07:09:57 INFO - Cleaning up... 07:09:57 INFO - Return code: 0 07:09:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:57 INFO - Reading from file tmpfile_stdout 07:09:57 INFO - Current package versions: 07:09:57 INFO - argparse == 1.2.1 07:09:57 INFO - blessings == 1.6 07:09:57 INFO - blobuploader == 1.2.4 07:09:57 INFO - docopt == 0.6.1 07:09:57 INFO - functools32 == 3.2.3-2 07:09:57 INFO - jsonschema == 2.5.1 07:09:57 INFO - manifestparser == 1.1 07:09:57 INFO - mozInstall == 1.13 07:09:57 INFO - mozcrash == 1.0 07:09:57 INFO - mozdebug == 0.1 07:09:57 INFO - mozdevice == 0.51 07:09:57 INFO - mozfile == 1.2 07:09:57 INFO - mozhttpd == 0.7 07:09:57 INFO - mozinfo == 0.10 07:09:57 INFO - mozleak == 0.1 07:09:57 INFO - mozlog == 3.5 07:09:57 INFO - moznetwork == 0.27 07:09:57 INFO - mozprocess == 0.25 07:09:57 INFO - mozprofile == 0.28 07:09:57 INFO - mozrunner == 6.13 07:09:57 INFO - mozscreenshot == 0.1 07:09:57 INFO - mozsystemmonitor == 0.3 07:09:57 INFO - moztest == 0.8 07:09:57 INFO - mozversion == 1.4 07:09:57 INFO - psutil == 3.1.1 07:09:57 INFO - requests == 1.2.3 07:09:57 INFO - wsgiref == 0.1.2 07:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf20b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1dd00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1f090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:09:57 INFO - Using env: {'DISPLAY': ':0', 07:09:57 INFO - 'HOME': '/home/cltbld', 07:09:57 INFO - 'LANG': 'en_US.UTF-8', 07:09:57 INFO - 'LANGUAGE': 'en_US:en', 07:09:57 INFO - 'LOGNAME': 'cltbld', 07:09:57 INFO - 'MAIL': '/var/mail/cltbld', 07:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:57 INFO - 'MOZ_NO_REMOTE': '1', 07:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:57 INFO - 'NO_EM_RESTART': '1', 07:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:57 INFO - 'PWD': '/builds/slave/test', 07:09:57 INFO - 'SHELL': '/bin/bash', 07:09:57 INFO - 'SHLVL': '1', 07:09:57 INFO - 'TERM': 'linux', 07:09:57 INFO - 'TMOUT': '86400', 07:09:57 INFO - 'USER': 'cltbld', 07:09:57 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 07:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:57 INFO - '_': '/tools/buildbot/bin/python'} 07:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:09:58 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:59 INFO - Downloading marionette_driver-1.4.0.tar.gz 07:09:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 07:09:59 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 07:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:09:59 INFO - Installing collected packages: marionette-driver, simplejson 07:09:59 INFO - Running setup.py install for marionette-driver 07:09:59 INFO - Running setup.py install for simplejson 07:09:59 INFO - building 'simplejson._speedups' extension 07:09:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 07:10:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 07:10:00 INFO - Successfully installed marionette-driver simplejson 07:10:00 INFO - Cleaning up... 07:10:00 INFO - Return code: 0 07:10:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf20b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1dd00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1f090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:10:00 INFO - Using env: {'DISPLAY': ':0', 07:10:00 INFO - 'HOME': '/home/cltbld', 07:10:00 INFO - 'LANG': 'en_US.UTF-8', 07:10:00 INFO - 'LANGUAGE': 'en_US:en', 07:10:00 INFO - 'LOGNAME': 'cltbld', 07:10:00 INFO - 'MAIL': '/var/mail/cltbld', 07:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:00 INFO - 'MOZ_NO_REMOTE': '1', 07:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:00 INFO - 'NO_EM_RESTART': '1', 07:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:00 INFO - 'PWD': '/builds/slave/test', 07:10:00 INFO - 'SHELL': '/bin/bash', 07:10:00 INFO - 'SHLVL': '1', 07:10:00 INFO - 'TERM': 'linux', 07:10:00 INFO - 'TMOUT': '86400', 07:10:00 INFO - 'USER': 'cltbld', 07:10:00 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 07:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:00 INFO - '_': '/tools/buildbot/bin/python'} 07:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:10:00 INFO - Cleaning up... 07:10:00 INFO - Return code: 0 07:10:00 INFO - Running post-action listener: _resource_record_post_action 07:10:00 INFO - Running post-action listener: _start_resource_monitoring 07:10:00 INFO - Starting resource monitoring. 07:10:00 INFO - [mozharness: 2017-07-19 14:10:00.825802Z] Finished create-virtualenv step (success) 07:10:00 INFO - [mozharness: 2017-07-19 14:10:00.826744Z] Running install step. 07:10:00 INFO - Running pre-action listener: _resource_record_pre_action 07:10:00 INFO - Running main action method: install 07:10:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:10:01 INFO - Reading from file tmpfile_stdout 07:10:01 INFO - Detecting whether we're running mozinstall >=1.0... 07:10:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:10:01 INFO - Reading from file tmpfile_stdout 07:10:01 INFO - Output received: 07:10:01 INFO - Usage: mozinstall [options] installer 07:10:01 INFO - Options: 07:10:01 INFO - -h, --help show this help message and exit 07:10:01 INFO - -d DEST, --destination=DEST 07:10:01 INFO - Directory to install application into. [default: 07:10:01 INFO - "/builds/slave/test"] 07:10:01 INFO - --app=APP Application being installed. [default: firefox] 07:10:01 INFO - mkdir: /builds/slave/test/build/application 07:10:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:10:19 INFO - Reading from file tmpfile_stdout 07:10:19 INFO - Output received: 07:10:19 INFO - /builds/slave/test/build/application/firefox/firefox 07:10:19 INFO - Running post-action listener: _resource_record_post_action 07:10:19 INFO - [mozharness: 2017-07-19 14:10:19.080810Z] Finished install step (success) 07:10:19 INFO - [mozharness: 2017-07-19 14:10:19.081065Z] Running setup-mitmproxy step. 07:10:19 INFO - Running pre-action listener: _resource_record_pre_action 07:10:19 INFO - Running main action method: setup_mitmproxy 07:10:19 INFO - Skipping: mitmproxy is not required 07:10:19 INFO - Running post-action listener: _resource_record_post_action 07:10:19 INFO - [mozharness: 2017-07-19 14:10:19.082261Z] Finished setup-mitmproxy step (success) 07:10:19 INFO - [mozharness: 2017-07-19 14:10:19.082500Z] Running run-tests step. 07:10:19 INFO - Running pre-action listener: _resource_record_pre_action 07:10:19 INFO - Running pre-action listener: _set_gcov_prefix 07:10:19 INFO - Running main action method: run_tests 07:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:10:19 INFO - Python 2.7.3 07:10:19 INFO - Return code: 0 07:10:19 INFO - grabbing minidump binary from tooltool 07:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1dd00>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1f090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:10:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:10:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:10:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:10:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:10:19 INFO - Return code: 0 07:10:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:10:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:10:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:10:19 INFO - ENV: RUST_BACKTRACE is now 1 07:10:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:10:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:10:19 INFO - Using env: {'DISPLAY': ':0', 07:10:19 INFO - 'HOME': '/home/cltbld', 07:10:19 INFO - 'LANG': 'en_US.UTF-8', 07:10:19 INFO - 'LANGUAGE': 'en_US:en', 07:10:19 INFO - 'LOGNAME': 'cltbld', 07:10:19 INFO - 'MAIL': '/var/mail/cltbld', 07:10:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:10:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:19 INFO - 'MOZ_NO_REMOTE': '1', 07:10:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:19 INFO - 'NO_EM_RESTART': '1', 07:10:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:19 INFO - 'PWD': '/builds/slave/test', 07:10:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:10:19 INFO - 'RUST_BACKTRACE': '1', 07:10:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:10:19 INFO - 'SHELL': '/bin/bash', 07:10:19 INFO - 'SHLVL': '1', 07:10:19 INFO - 'TERM': 'linux', 07:10:19 INFO - 'TMOUT': '86400', 07:10:19 INFO - 'USER': 'cltbld', 07:10:19 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949', 07:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:19 INFO - '_': '/tools/buildbot/bin/python'} 07:10:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:10:19 INFO - mozversion application_buildid: 20170719132222 07:10:19 INFO - mozversion application_changeset: a1ea69a3a0a760036e047f6ff89897aa7ffd4e53 07:10:19 INFO - mozversion application_display_name: Nightly 07:10:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:10:19 INFO - mozversion application_name: Firefox 07:10:19 INFO - mozversion application_remotingname: firefox 07:10:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:10:19 INFO - mozversion application_vendor: Mozilla 07:10:19 INFO - mozversion application_version: 56.0a1 07:10:19 INFO - mozversion platform_buildid: 20170719132222 07:10:19 INFO - mozversion platform_changeset: a1ea69a3a0a760036e047f6ff89897aa7ffd4e53 07:10:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:10:19 INFO - mozversion platform_version: 56.0a1 07:10:19 INFO - using testdate: 1500473419 07:10:19 INFO - actual date: 1500473419 07:10:19 INFO - starting webserver on 'localhost:56052' 07:10:19 INFO - SUITE-START | Running 2 tests 07:10:19 INFO - TEST-START | dromaeo_css 07:10:19 INFO - Initialising browser for dromaeo_css test... 07:10:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56052/getInfo.html -profile /tmp/tmpZlpLuC/profile 07:10:19 INFO - TEST-INFO | started process 3371 (/builds/slave/test/build/application/firefox/firefox http://localhost:56052/getInfo.html) 07:10:28 INFO - TEST-INFO | 3371: exit 0 07:10:28 INFO - Browser initialized. 07:10:28 INFO - Running cycle 1/1 for dromaeo_css test... 07:10:28 INFO - TEST-INFO | started process 3600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZlpLuC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:39 INFO - PID 3600 | RSS: Main: 178073600 07:10:39 INFO - PID 3600 | 07:13:39 INFO - PID 3600 | Cycle 1(1): loaded http://localhost:56052/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56052/tests/dromaeo/cssquery-ext.html) 07:13:40 INFO - PID 3600 | RSS: Main: 180387840 07:13:40 INFO - PID 3600 | 07:16:42 INFO - PID 3600 | Cycle 1(1): loaded http://localhost:56052/tests/dromaeo/cssquery-ext.html (next: http://localhost:56052/tests/dromaeo/cssquery-jquery.html) 07:16:42 INFO - PID 3600 | RSS: Main: 178761728 07:16:42 INFO - PID 3600 | 07:19:44 INFO - PID 3600 | Cycle 1(1): loaded http://localhost:56052/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56052/tests/dromaeo/cssquery-mootools.html) 07:19:45 INFO - PID 3600 | RSS: Main: 180084736 07:19:45 INFO - PID 3600 | 07:22:47 INFO - PID 3600 | Cycle 1(1): loaded http://localhost:56052/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56052/tests/dromaeo/cssquery-prototype.html) 07:22:47 INFO - PID 3600 | RSS: Main: 178696192 07:22:47 INFO - PID 3600 | 07:25:51 INFO - PID 3600 | Cycle 1(1): loaded http://localhost:56052/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56052/tests/dromaeo/cssquery-yui.html) 07:25:52 INFO - PID 3600 | RSS: Main: 180674560 07:25:52 INFO - PID 3600 | 07:28:54 INFO - PID 3600 | Cycle 1(1): loaded http://localhost:56052/tests/dromaeo/cssquery-yui.html (next: http://localhost:56052/tests/dromaeo/cssquery-dojo.html) 07:28:54 INFO - PID 3600 | RSS: Main: 182558720 07:28:54 INFO - PID 3600 | 07:28:54 INFO - PID 3600 | __start_tp_report 07:28:54 INFO - PID 3600 | _x_x_mozilla_page_load 07:28:54 INFO - PID 3600 | _x_x_mozilla_page_load_details 07:28:54 INFO - PID 3600 | |i|pagename|runs| 07:28:54 INFO - PID 3600 | |0;dojo.html;3130.34262804811;3148.2444213388785;3163.984180079099;3167.588213532241;3229.0635715642466;6134.846628834276;6225.750969961202;6246.406591373823;6258.749650014;6294.30762616113;6039.214902062726;6185.072239164117;6189.783357582485;6202.0386840039755;6202.875942481148;5617.634853734515;5629.268195134637;5648.6893220872835;5754.568407369443;5756.165356023374;5717.885642287151;5719.656820590757;5739.655620662774;5746.48281654651;5776.797812076578;5582.078956972115;5655.7172141392975;5704.686242256675;5765.481106700396;5788.594798364116;5540.556755459554;5621.690807005613;5685.658860468385;5699.914501282484;5776.220210271623;5558.722063896789;5568.638038527482;5591.580631452616;5620.5503559715125;5633;6076.574639775217;6109.755609775603;6123;6130.63216207029;6146.200993870812;6517.087607734921;6592.967035164794;6658.467322614228;6663.63350015749;6670.499712521531;6523;6612.338766123349;6682.164729408824;6723.798286051427;6745.123133992599;6155.907661385083;6225.937740622627;6251.562390632657;6253.937460625427;6261.154744109578;6753.257141714407;6784.491163162783;6856.485763567753;6861.4853885958755;6862.279460656659;6413.486921046305;6455.548111632234;6458.192725909262;6571.145751052332;6576.0793488911595;6515.446187074057;6575.473962083021;6585.012248162814;6589.670516474157;6593.505487088391;6483.902741458882;6536.24833144185;6543;6544.280129185786;6548.476121910236;6534.869302613921;6580.901286480706;6581.407673309425;6582.045603387482;6588.275289718127;5314.654547454403;5330.600204984642;5363.704996225245;5366.275552800322;5366.946330536723;4506.954930450719;4542.432195975503;4596.563326484045;4604.102200071021;4610.101030299126;5643.492085712223;5723.656580605094;5786.218860453869;5800.1299805029585;5804.071348584291;6627.072209890619;6627.635480048547;6628.83427914306;6639.834004149839;6648.8670226595195;5646.576506761927;5705.572082093777;5716.771329146787;5730.598858079978;5754.6547207167705;5754.5971781975695;5768.711564421762;5810.477057064884;5810.970945145332;5832.912506312408;6298.244210694563;6329.367063293634;6361.427471527492;6438.356164383524;6441.838954026187;6612.735490580323;6615.536912416084;6689.26418094019;6704.83237919056;6711.161104861892;6377.17096777416;6395.488360931207;6415.71129299192;6421.839454013687;6441.227052753699;6490.772822951174;6512.5766825156215;6518.478521718346;6575.638339891352;6598.27418983921;6469.708863101077;6602.3397660233595;6614.536982411185;6714.865702685821;6726.562773419712;6389.77635782764;6403.487720982217;6482.222133344029;6489.837754056186;6513.934860651522;6426.646534440651;6449.226092868886;6493.675316234264;6507.381798729113;6537.901931470937;6349.936500634934;6357.96821015892;6364.109024736448;6393.8721225576155;6441.033844923299;6387.584806987717;6441.549091563733;6501.967490162708;6520.902186467112;6539.6403197824575;6324.525660575383;6328.683565821599;6337.366263373626;6346.397092276226;6354.332795056453 07:28:54 INFO - PID 3600 | |1;ext.html;775.837074214415;819.4386845011168;838.4591938199861;842.827220419814;1162.3490845126723;29967;40773.38839917404;41685.37471937916;41775.58224417755;41825.37261941074;42043;42190.78904605473;42287.365689514685;42311.365329520006;42373.15253694932;7217.783466495987;7733.767986960372;7854.803629909241;7858.842823143534;7912.050553933536;7698.2686644768655;7810.062792464883;7810.609469526529;7812.570308633023;7826.256505631955;7781.182975787546;7792.493487923295;7803.453758236926;7817.570033648147;7837.843243135134;7760.340371068466;7800.336971357441;7802.726904558313;7803.024621922288;7803.76588702337;7518.060242469692;7629.504082234637;7676.654550545239;7684.116326622454;7694;38244.617553824384;38633.227335453135;38704.61295387038;38714.806425967974;38758.41862372067;3582.3551760683067;3628.4013137832226;3631.182983828644;3632.945505817415;3647.4528820676846;30803.075907722803;30969.690303096904;31097.53353699696;31098.37803243945;31190;4729.148753224418;4865.902681946377;4924.852254432372;4939.8024079036795;5016.147254966664;184950;185264;186081;186455;186572.06713966478;47746.28380574294;47978.520214797405;48169.518304816505;48170.518294816604;48223.27665084956;53610;54275;54584.99782512;54643.72678136663;54653;15417.537473875802;15443.30505127272;15446.691066178839;15496.84503154954;15517.612059698373;12118.454669539891;12395.132340736242;13545.05184637066;13870.237136957363;13884.23636699971;14389.496367627084;14409.567712968628;14482.782758258634;14542.709145817236;14616.123032618078;5660.745266463019;5824.621399609096;5974.522038236931;5998.850028749229;6059.818205453844;997.2819569909653;1011.7420057885192;1030.0472063341379;1032.8244198486275;1051.9053285204368;22260.22089226869;22260.666090008664;22568.774312256995;22828.17881440222;22982.310530684106;1057.5928267617023;1150.1546363423045;1150.6145441277265;1165.1843709403452;1171.8066519024435;11831.795314354007;12289.508419663114;12502.874971250352;12545.658402890245;12625.431855566521;235985;237979;238835;239181;239217;52879.735601322514;53237.2014419784;53346.46653533493;53368;53380.73309633427;1475.7786332050277;1500.174903802904;1537.1007960343325;1537.5541093082882;1539.6074001129641;21732;22051.558968820213;22660.320190394315;23120.843957801706;23367.298981030595;34036.48945265773;38645.2270954585;38664.6133538661;38701.41947870728;38917.80541097277;206171;207611;208270;208440;209422;30334.84832575823;30685.23286917845;31194.532082019243;31213.68786312108;34535.309293814484;44142.558574413844;44573.33140002838;44752.55247447614;44875.32687009632;45097.54902451065;30628.387432251675;31128.377432451678;33070.5039424404;33222.83388583042;33313.50029749507;31390.372192555566;31749.206269842514;32212;32230.83884580562;32251.677483225805;34343;34954.300913982086;35075.47386789251;35283;35319.470207947415;28657;30177.547336790405;31097.53353699651;31102.844485777427;31273.218169545944;22988.310350689506;23400.64899026482;23401.882990584938;23477.17829875946;23518.176863809684 07:28:54 INFO - PID 3600 | |2;jquery.html;569.2514343638115;570.9343425506069;573.67013966969;580.3239226301358;600.2466904035435;22065.779342206573;22729.77270227297;22885.771142288573;22956.77043229567;23026.76973230269;26430.867845660792;27084;27125.728742712567;27177.864110679468;27250.45499090017;6350.079238510425;6495.447886929616;6538.05198246254;6539.705713242892;6540.542162048659;5885.176075349455;6158.384161583828;6433.93566064338;6510;6515.153030106103;6409.583377080475;6424.678766061702;6435.774747883825;6442.7745028924;6444.387783160616;6357.872842543169;6424.678766061702;6427.710753016126;6427.775027874025;6431.742730290783;5952.851178720523;5968.791092311748;5974.641521508724;5977.342492325841;5990.191324171268;28757.712422875713;29801.850990745123;30004;30236.546451803242;30331.69668303333;1837.4763192490077;1893.2427029188298;1897.6679081160742;1898.2501911744785;1898.515878451;18951.336703215322;19226.903865480723;19257.325993590297;19275.421737347762;19328.1302341395;2066.5660211355635;2221.44463884029;2224.4883676754275;2249.9775002250094;2256.3343813575034;134359.32820335837;137750.3112484441;138677;138928;139391;14101;15086.622834429227;15179.16514591708;15280.388784448498;15450.5364839055;24009.159679411136;24036.15873444456;24059.759402406104;24103.276901692978;24149.15477958263;9658.613655453702;10050.296479246383;10106.343087699275;10198.847017294747;10228.59085636581;9339.20616747584;9345.252379809599;9381.62473501066;9487.098725621056;9552.617895284111;8579.828403431897;9030.86453703195;9035.322350823715;9210.677626283048;9284.95357523208;2639.274199595127;2710.254679963026;2737.945241095167;2761.2406588188005;2825.4772867019256;960.5437417226901;969.3214749675255;985.1872205430549;1002.1882275356984;1003.2275148135894;19503.317383891495;19915.203391864165;20016;20067.197312107353;20712.275070372463;1062.7980683670078;1064.8189807732704;1064.9627263045757;1071.244772435431;1078.5524007536942;11203.327800332007;11248.26886252391;11742.178047536761;12902.741945161044;13883.444662213398;502863;509245;512618;513199;531165;129675;130747;132346.33826830806;132807;134063.32968335095;1260.1493991555662;1269.1179630156953;1304.3282709404664;1306.1836352279824;1322.90078244134;21047.473813154793;21868;22084.558308834054;22370.664440033088;22448.77551224467;57809.13286300625;57812.4218757807;58217.41782582289;59990;60868.695656521435;74733;74774.62612686901;75023;75518.24481755332;76213.6189319072;20661.79338206659;21287.82916939583;21355.25256616011;21470.355889323346;21712.131514739234;23563.528729424972;23928.521429571658;24047.398815029763;24057;24329.148479803123;18368;18802.623947521246;18927.526811829815;19003.23987040503;19143.13855876461;15679.216039198223;15689.45086921998;16796.580085497473;17001.829981700026;17580.208890599697;18853.340133095277;19292.614147716686;19418.417447476033;19452.708209377153;19661.606767864847;19909.502262443555;20853.89573052125;20877.58244835125;20969.685454717885;21028.158873645494;17983.550411239823;18071.186796594448;18434.354797582022;18436.26254949787;18445.631087377908 07:28:54 INFO - PID 3600 | |3;mootools.html;1384.1072508232191;1437.2167168892952;1443.877270432013;1451.5137428961298;1459.6861674739928;13632.591022269335;13784.310784460762;14269.429222831088;14281.71436571268;14324.570262892104;14393.856061439383;14649.121052736844;14687;14698.559043228694;14699.853001469983;2539.263613552068;2621.0826210826153;2684.1679079485325;2692.098147120717;2695.784337253015;2585.2890455124802;2621.2267381122615;2637.709851916288;2640.326716687242;2641.3660721426913;2599.6100584912224;2645.4576811753545;2659.255408485627;2662.241261240547;2662.6006099085193;2533.7972962163076;2541.517111748771;2558.6801649793774;2654.2302732207636;2655.322892662378;2521.1680145551923;2529.190658989124;2530.9493810123877;2531.9113831015825;2543.898244070235;13725.45098196071;14028.649283767885;14139.929300353535;14172.716545669029;14205.147691138462;7181.245969173266;7446.441516886201;7479.289467500579;7489.625518724042;7505.737299194502;4558.566936141095;4609.423822022247;4745.549172828576;4836.613070954315;4842.176829938883;1878.690016147334;1892.1674463236131;1895.0619443375617;1905.8570607204376;1929.778075521319;22693.65959510592;23187.072517099296;23233.53532929349;23416.180433684738;23847.284581462583;6076.240469941257;6166.4758495527485;6379.649119298483;6392.456641185551;6417.326180750954;13865.306734663227;15786.921065394828;15862.920685396499;15865.603359915864;15992;6371.96814015927;7011.824704382431;7434.3309102181065;7501.624918754041;7543.434242431839;6782.898256526156;6905;6917.827054323682;6966.965165174243;6980.441564674814;4776.928346074812;4890.926636100461;4943.233798761198;4976.278439626234;4985.4266759323145;1226.196841069101;1238.59745582686;1246.4764798784531;1247.8564965028957;1263.6777621706406;882.3646974178581;910.1126401758232;912.6440688131634;929.7954450020984;931.1759093202429;7134.282113484928;7448.478606497493;7512.21121782205;7556.911055296363;8082.19178082187;692.9272426395257;700.7127077898037;703.5286358140058;708.7483943200193;712.6792943175592;4731.929021064687;5199.402068762065;5271.789128434896;5304.204369344552;5384.111621582473;18504.814951850578;19277.90361048186;19408.320708775125;19538.413847584594;19563.413097607096;18466;19077.427677169708;19152.61694766097;19157.329493467663;19199.040047997823;10737.194710396752;10956.28784129029;10983.340999540053;10984.450777461096;11004.614838480775;7620.771376858482;7774.105977812624;7936.246056624612;8094.635741391534;8126.065502467292;16120.98223198215;16141.838581614034;16596.41912533104;16748.330066797193;16932.746008810125;15973.920130399274;16601.91699041497;16680.916595416944;17169.227384767964;17399.652006960045;10309.74225644335;10644.414557199429;11127.387993660426;11172.273802202832;11197.944010279896;13262.933685331898;13431.462741490232;13442;13452.260125693181;13456.46174153023;10452.947735261276;10815.810260871454;11026.889731102907;11096.167787415814;11146.721331966766;9748.610055597981;10229.28395012342;10384.792304154025;10447.895521044693;10543.736406589896;9421.62313507452;9651.758706032406;9808.558614862492;9833;9834.360766550151;6937.7571784987285;6951.582905025714;7166.749163779243;7346.6693998769115;7473.43949203801;6765;7270.382017528569;7274.163471200668;7284.490085694162;7414.740484083031 07:28:54 INFO - PID 3600 | |4;prototype.html;481.1699817814273;493.8671802376854;504.3796130759166;507.21381858119906;519.0656817728088;6102;6122.510199184066;6169.2288463942;6170;6180.474659653934;5815.156802263669;5992.970035149818;5999.790007349744;6004.669743164124;6050.60671056381;4808.447028591721;4834.879128021801;4836.2987366831785;4858.174110401223;4876.317315575822;4731.810727570893;4788.569028787409;4840.394950631171;4853.927191092136;4887.926681099786;4762.404699412574;4828.589569886564;4837.5646191842725;4848.7575621218975;4903.65674402792;4847.636427267951;4872.658913876048;4878.146324393252;4909.828156014522;4914.63140264478;4378.255696531597;4407.471103467572;4418.160549495586;4421.115776844612;4441.644668426518;5939.46544810969;5967.508122969258;5974.402559744034;5996.2504686914135;6024.698765061773;5604.8318550443555;5628.774849006035;5640.323161220639;5641.702408446039;5643.858903527444;6374.840628984312;6422;6424.486041116699;6471.255805582371;6477.967610161919;4765.070811191819;4784.904301913977;4796.472388037313;4819.180739274332;4828.46886842447;6709.215675494615;6743.471198300637;6773.390394864486;6776.3069127325725;6806.829829254309;4848.224284114524;4886.144924638174;4895.681780684244;4924.285978533164;4929.112759703288;4992.126377883856;5007.9499205008215;5020.322256495327;5021.6735912165595;5028.7737051832755;5472.671639701631;5495.670259784426;5527.806526771544;5586.608937374426;5646.745896434671;6354.26925903527;6426.6144031357335;6449.3873082057125;6449.935500645028;6481.222253329536;1610.2673283655909;1640.9343626255054;1683.9391183554283;1701.5405840423016;1704.139409598145;1156.7570810129967;1166.5683697032152;1167.4279602994472;1179.292424545266;1191.9165658404002;5656.2929633795775;5696.031674615326;5753.913691294634;5774.711264436762;5790.681512516768;6357.618542887441;6515.311931920285;6538.934610653928;6639.037339585733;6686;5655.462731040545;5705.400932902068;5712;5733.426657334233;5741.224934633771;3506.7545271830727;3512;3521.401361768454;3528.4883691865048;3567.928641427157;6363.140975968185;6459.224893012869;6480.630072362439;6509.479241660656;6509.641969691713;6670.833229169212;6672.399484046459;6722.29415911332;6762.594244345355;6833.6241506716615;6286.811395658137;6383.872322553523;6383.93616063852;6392.360763923663;6513.478921686159;6584.8024559263295;6618.867622647616;6648.368405001517;6661.866762664817;6780.32196780318;6470.320616335217;6516.543841931019;6569.9343006569325;6579.703913323816;6638.601683898982;6371.426571608577;6391.93608063932;6405.871882562229;6437.645929473924;6446.516511261768;4877.6585639004925;4922.876928076684;4963.354763880672;4963.6525443218625;4986.626003049713;6553.803385898431;6612.437942774918;6665.133532640726;6675.699593518206;6722.159730033746;6407.455366293731;6415.615063096229;6421.36255254907;6433.420992110545;6488.935110648833;6238.064290356483;6370.26741924666;6415.1981002374705;6443.903341449788;6561.770338038145;6205.789870975297;6256.937430625636;6367.3314301997625;6387.329330420424;6392.68036598159;6449.806505804833;6451.612903225821;6459.870802584016;6498.285188629153;6520.836979075561;6168.537359697951;6218.782342618168;6229.190205273286;6271.3728627136925;6284.4344009039405 07:28:54 INFO - PID 3600 | |5;yui.html;901.3014913442086;907.6278725722456;923.3213588012806;926.106307413346;933.7432206143312;18359.81640183598;19168.904155479202;19189.040547972614;19205.519862003457;21121.894390528025;19949.900250498762;21393.786062139374;21749.13003479859;21754.347369578936;21760.673589896163;1053.3416614615846;1067.119626308295;1073.1522097542932;1074.9032587067163;1075.0969185883855;1046.1212581431596;1053.146950969717;1059.099765199582;1059.343207211526;1062.904338609525;1127.408110741863;1132.9206955513118;1133.580575187182;1134.9546018159265;1135.403912945702;1110.9166812489095;1115.0800589513683;1116.0792346314283;1120.6245907620957;1121.198343184627;800.1518390506023;802.6709049289764;808.1554775259867;809.8785182222655;810.3679130278392;16012.439564615299;16195.19024048793;16534.338626454926;16570;17095.230714617872;19949;20401.285954991654;20982.68525972112;21034.789652103434;21036.894815525826;15652.295646695811;15805.446809361618;16048.518544443685;16074.115923624197;16191.83808161927;3496.912577185565;3505.263894582141;3551.200979779555;3551.627079156703;3551.8224088795455;120048;125883;125928;128409.7013977753;129455;15333.233338333039;16157;16263.837361626232;16400.343986240656;16482.2582983766;30964.22589435282;31065.534016989764;31797;31814.840925795223;32484;7306.342429181399;7734.91711160438;7935.2858242757275;8013.799655008672;8115.75652730419;3993.980030099831;4097.8770636880945;4107.404426358221;4112.938305925413;4113.629773320416;5000.1249781288125;5067.569256613156;5149.356330458692;5160.767765450564;5171.534561889448;1072.1101485766794;1095.5343978808974;1096.8976178940113;1099.2580008494235;1099.3019432660158;661.9437347825392;677.8983152527062;688.0573614148649;695.2977492732376;700.2332445971653;10910.345379277269;12371.257724536557;13040.673983150496;13337.866621333857;13585.660358490919;678.6606696651675;699.3321378083917;704.112817849503;709.606168576445;720.1502227371647;5019.974900125476;5261.894762104736;5346.625736198506;5374.274472946102;5632.718364081861;95086.5245673781;99558.50220748995;100978;102693.48653256687;103215;89113;92987.53506232426;94933.52533237428;95359.52320238354;95385.52307238558;76520.61739691377;76914;77113;78071.60964195142;78654.606726966;12326.938365308117;12394.876051239373;12467.127301088836;12658.493660253487;12955.222686638832;35044.29911401809;35362.82318588493;35397.469037963936;35767.28465430729;37830;43645.127097458506;44067.77966110149;56608;62610.68694656497;67276.66361668357;18444;18879.811201887806;18977.05114744285;18990.905045475236;19049.809501904805;21202.89398553059;21204.36386908395;21465.356039318845;21479.57040859205;21953.231636892633;18791.154398051847;18992.335268265546;19027.714584281523;19208.80791192126;19652.705209422154;17194.484165475056;17540.122993850513;17570.297188112334;17828.821711782715;18549.35077272289;16265.837341626906;16901.577460563585;16916.23876925566;17034;17110.828891710924;13436.731265374834;13481.460741570227;14024.439022438988;14146.221957792008;14452.277386130441;13344.532941347006;13898.652533686738;13912.513062043185;13921.860781392057;14002.859971400156 07:28:54 INFO - PID 3600 | __end_tp_report 07:28:54 INFO - PID 3600 | __start_cc_report 07:28:54 INFO - PID 3600 | _x_x_mozilla_cycle_collect,393 07:28:54 INFO - PID 3600 | __end_cc_report 07:28:54 INFO - PID 3600 | __startTimestamp1500474534552__endTimestamp 07:28:54 INFO - PID 3600 | 07:28:54 INFO - PID 3600 | ------- Summary: start ------- 07:28:54 INFO - PID 3600 | Number of tests: 6 07:28:54 INFO - PID 3600 | 07:28:54 INFO - PID 3600 | [#0] dojo.html Cycles:165 Average:6094.80 Median:6354.33 stddev:711.01 (11.2%) stddev-sans-first:674.09 07:28:54 INFO - PID 3600 | Values: 3130.3 3148.2 3164.0 3167.6 3229.1 6134.8 6225.8 6246.4 6258.7 6294.3 6039.2 6185.1 6189.8 6202.0 6202.9 5617.6 5629.3 5648.7 5754.6 5756.2 5717.9 5719.7 5739.7 5746.5 5776.8 5582.1 5655.7 5704.7 5765.5 5788.6 5540.6 5621.7 5685.7 5699.9 5776.2 5558.7 5568.6 5591.6 5620.6 5633.0 6076.6 6109.8 6123.0 6130.6 6146.2 6517.1 6593.0 6658.5 6663.6 6670.5 6523.0 6612.3 6682.2 6723.8 6745.1 6155.9 6225.9 6251.6 6253.9 6261.2 6753.3 6784.5 6856.5 6861.5 6862.3 6413.5 6455.5 6458.2 6571.1 6576.1 6515.4 6575.5 6585.0 6589.7 6593.5 6483.9 6536.2 6543.0 6544.3 6548.5 6534.9 6580.9 6581.4 6582.0 6588.3 5314.7 5330.6 5363.7 5366.3 5366.9 4507.0 4542.4 4596.6 4604.1 4610.1 5643.5 5723.7 5786.2 5800.1 5804.1 6627.1 6627.6 6628.8 6639.8 6648.9 5646.6 5705.6 5716.8 5730.6 5754.7 5754.6 5768.7 5810.5 5811.0 5832.9 6298.2 6329.4 6361.4 6438.4 6441.8 6612.7 6615.5 6689.3 6704.8 6711.2 6377.2 6395.5 6415.7 6421.8 6441.2 6490.8 6512.6 6518.5 6575.6 6598.3 6469.7 6602.3 6614.5 6714.9 6726.6 6389.8 6403.5 6482.2 6489.8 6513.9 6426.6 6449.2 6493.7 6507.4 6537.9 6349.9 6358.0 6364.1 6393.9 6441.0 6387.6 6441.5 6502.0 6520.9 6539.6 6324.5 6328.7 6337.4 6346.4 6354.3 07:28:54 INFO - PID 3600 | 07:28:54 INFO - PID 3600 | [#1] ext.html Cycles:180 Average:37898.29 Median:34189.74 stddev:54955.64 (160.7%) stddev-sans-first:55039.11 07:28:54 INFO - PID 3600 | Values: 775.8 819.4 838.5 842.8 1162.3 29967.0 40773.4 41685.4 41775.6 41825.4 42043.0 42190.8 42287.4 42311.4 42373.2 7217.8 7733.8 7854.8 7858.8 7912.1 7698.3 7810.1 7810.6 7812.6 7826.3 7781.2 7792.5 7803.5 7817.6 7837.8 7760.3 7800.3 7802.7 7803.0 7803.8 7518.1 7629.5 7676.7 7684.1 7694.0 38244.6 38633.2 38704.6 38714.8 38758.4 3582.4 3628.4 3631.2 3632.9 3647.5 30803.1 30969.7 31097.5 31098.4 31190.0 4729.1 4865.9 4924.9 4939.8 5016.1 184950.0 185264.0 186081.0 186455.0 186572.1 47746.3 47978.5 48169.5 48170.5 48223.3 53610.0 54275.0 54585.0 54643.7 54653.0 15417.5 15443.3 15446.7 15496.8 15517.6 12118.5 12395.1 13545.1 13870.2 13884.2 14389.5 14409.6 14482.8 14542.7 14616.1 5660.7 5824.6 5974.5 5998.9 6059.8 997.3 1011.7 1030.0 1032.8 1051.9 22260.2 22260.7 22568.8 22828.2 22982.3 1057.6 1150.2 1150.6 1165.2 1171.8 11831.8 12289.5 12502.9 12545.7 12625.4 235985.0 237979.0 238835.0 239181.0 239217.0 52879.7 53237.2 53346.5 53368.0 53380.7 1475.8 1500.2 1537.1 1537.6 1539.6 21732.0 22051.6 22660.3 23120.8 23367.3 34036.5 38645.2 38664.6 38701.4 38917.8 206171.0 207611.0 208270.0 208440.0 209422.0 30334.8 30685.2 31194.5 31213.7 34535.3 44142.6 44573.3 44752.6 44875.3 45097.5 30628.4 31128.4 33070.5 33222.8 33313.5 31390.4 31749.2 32212.0 32230.8 32251.7 34343.0 34954.3 35075.5 35283.0 35319.5 28657.0 30177.5 31097.5 31102.8 31273.2 22988.3 23400.6 23401.9 23477.2 23518.2 07:28:54 INFO - PID 3600 | 07:28:54 INFO - PID 3600 | [#2] jquery.html Cycles:180 Average:36658.59 Median:2253.16 stddev:86666.42 (3846.4%) stddev-sans-first:86867.18 07:28:54 INFO - PID 3600 | Values: 569.3 570.9 573.7 580.3 600.2 22065.8 22729.8 22885.8 22956.8 23026.8 26430.9 27084.0 27125.7 27177.9 27250.5 6350.1 6495.4 6538.1 6539.7 6540.5 5885.2 6158.4 6433.9 6510.0 6515.2 6409.6 6424.7 6435.8 6442.8 6444.4 6357.9 6424.7 6427.7 6427.8 6431.7 5952.9 5968.8 5974.6 5977.3 5990.2 28757.7 29801.9 30004.0 30236.5 30331.7 1837.5 1893.2 1897.7 1898.3 1898.5 18951.3 19226.9 19257.3 19275.4 19328.1 2066.6 2221.4 2224.5 2250.0 2256.3 134359.3 137750.3 138677.0 138928.0 139391.0 14101.0 15086.6 15179.2 15280.4 15450.5 24009.2 24036.2 24059.8 24103.3 24149.2 9658.6 10050.3 10106.3 10198.8 10228.6 9339.2 9345.3 9381.6 9487.1 9552.6 8579.8 9030.9 9035.3 9210.7 9285.0 2639.3 2710.3 2737.9 2761.2 2825.5 960.5 969.3 985.2 1002.2 1003.2 19503.3 19915.2 20016.0 20067.2 20712.3 1062.8 1064.8 1065.0 1071.2 1078.6 11203.3 11248.3 11742.2 12902.7 13883.4 502863.0 509245.0 512618.0 513199.0 531165.0 129675.0 130747.0 132346.3 132807.0 134063.3 1260.1 1269.1 1304.3 1306.2 1322.9 21047.5 21868.0 22084.6 22370.7 22448.8 57809.1 57812.4 58217.4 59990.0 60868.7 74733.0 74774.6 75023.0 75518.2 76213.6 20661.8 21287.8 21355.3 21470.4 21712.1 23563.5 23928.5 24047.4 24057.0 24329.1 18368.0 18802.6 18927.5 19003.2 19143.1 15679.2 15689.5 16796.6 17001.8 17580.2 18853.3 19292.6 19418.4 19452.7 19661.6 19909.5 20853.9 20877.6 20969.7 21028.2 17983.6 18071.2 18434.4 18436.3 18445.6 07:28:54 INFO - PID 3600 | 07:28:54 INFO - PID 3600 | [#3] mootools.html Cycles:180 Average:8633.95 Median:2542.71 stddev:5942.06 (233.7%) stddev-sans-first:5933.76 07:28:54 INFO - PID 3600 | Values: 1384.1 1437.2 1443.9 1451.5 1459.7 13632.6 13784.3 14269.4 14281.7 14324.6 14393.9 14649.1 14687.0 14698.6 14699.9 2539.3 2621.1 2684.2 2692.1 2695.8 2585.3 2621.2 2637.7 2640.3 2641.4 2599.6 2645.5 2659.3 2662.2 2662.6 2533.8 2541.5 2558.7 2654.2 2655.3 2521.2 2529.2 2530.9 2531.9 2543.9 13725.5 14028.6 14139.9 14172.7 14205.1 7181.2 7446.4 7479.3 7489.6 7505.7 4558.6 4609.4 4745.5 4836.6 4842.2 1878.7 1892.2 1895.1 1905.9 1929.8 22693.7 23187.1 23233.5 23416.2 23847.3 6076.2 6166.5 6379.6 6392.5 6417.3 13865.3 15786.9 15862.9 15865.6 15992.0 6372.0 7011.8 7434.3 7501.6 7543.4 6782.9 6905.0 6917.8 6967.0 6980.4 4776.9 4890.9 4943.2 4976.3 4985.4 1226.2 1238.6 1246.5 1247.9 1263.7 882.4 910.1 912.6 929.8 931.2 7134.3 7448.5 7512.2 7556.9 8082.2 692.9 700.7 703.5 708.7 712.7 4731.9 5199.4 5271.8 5304.2 5384.1 18504.8 19277.9 19408.3 19538.4 19563.4 18466.0 19077.4 19152.6 19157.3 19199.0 10737.2 10956.3 10983.3 10984.5 11004.6 7620.8 7774.1 7936.2 8094.6 8126.1 16121.0 16141.8 16596.4 16748.3 16932.7 15973.9 16601.9 16680.9 17169.2 17399.7 10309.7 10644.4 11127.4 11172.3 11197.9 13262.9 13431.5 13442.0 13452.3 13456.5 10452.9 10815.8 11026.9 11096.2 11146.7 9748.6 10229.3 10384.8 10447.9 10543.7 9421.6 9651.8 9808.6 9833.0 9834.4 6937.8 6951.6 7166.7 7346.7 7473.4 6765.0 7270.4 7274.2 7284.5 7414.7 07:28:54 INFO - PID 3600 | 07:28:54 INFO - PID 3600 | [#4] prototype.html Cycles:180 Average:5415.26 Median:5998.02 stddev:1527.63 (25.5%) stddev-sans-first:1486.35 07:28:54 INFO - PID 3600 | Values: 481.2 493.9 504.4 507.2 519.1 6102.0 6122.5 6169.2 6170.0 6180.5 5815.2 5993.0 5999.8 6004.7 6050.6 4808.4 4834.9 4836.3 4858.2 4876.3 4731.8 4788.6 4840.4 4853.9 4887.9 4762.4 4828.6 4837.6 4848.8 4903.7 4847.6 4872.7 4878.1 4909.8 4914.6 4378.3 4407.5 4418.2 4421.1 4441.6 5939.5 5967.5 5974.4 5996.3 6024.7 5604.8 5628.8 5640.3 5641.7 5643.9 6374.8 6422.0 6424.5 6471.3 6478.0 4765.1 4784.9 4796.5 4819.2 4828.5 6709.2 6743.5 6773.4 6776.3 6806.8 4848.2 4886.1 4895.7 4924.3 4929.1 4992.1 5007.9 5020.3 5021.7 5028.8 5472.7 5495.7 5527.8 5586.6 5646.7 6354.3 6426.6 6449.4 6449.9 6481.2 1610.3 1640.9 1683.9 1701.5 1704.1 1156.8 1166.6 1167.4 1179.3 1191.9 5656.3 5696.0 5753.9 5774.7 5790.7 6357.6 6515.3 6538.9 6639.0 6686.0 5655.5 5705.4 5712.0 5733.4 5741.2 3506.8 3512.0 3521.4 3528.5 3567.9 6363.1 6459.2 6480.6 6509.5 6509.6 6670.8 6672.4 6722.3 6762.6 6833.6 6286.8 6383.9 6383.9 6392.4 6513.5 6584.8 6618.9 6648.4 6661.9 6780.3 6470.3 6516.5 6569.9 6579.7 6638.6 6371.4 6391.9 6405.9 6437.6 6446.5 4877.7 4922.9 4963.4 4963.7 4986.6 6553.8 6612.4 6665.1 6675.7 6722.2 6407.5 6415.6 6421.4 6433.4 6488.9 6238.1 6370.3 6415.2 6443.9 6561.8 6205.8 6256.9 6367.3 6387.3 6392.7 6449.8 6451.6 6459.9 6498.3 6520.8 6168.5 6218.8 6229.2 6271.4 6284.4 07:28:54 INFO - PID 3600 | 07:28:54 INFO - PID 3600 | [#5] yui.html Cycles:180 Average:22528.26 Median:19430.76 stddev:30131.83 (155.1%) stddev-sans-first:30172.60 07:28:54 INFO - PID 3600 | Values: 901.3 907.6 923.3 926.1 933.7 18359.8 19168.9 19189.0 19205.5 21121.9 19949.9 21393.8 21749.1 21754.3 21760.7 1053.3 1067.1 1073.2 1074.9 1075.1 1046.1 1053.1 1059.1 1059.3 1062.9 1127.4 1132.9 1133.6 1135.0 1135.4 1110.9 1115.1 1116.1 1120.6 1121.2 800.2 802.7 808.2 809.9 810.4 16012.4 16195.2 16534.3 16570.0 17095.2 19949.0 20401.3 20982.7 21034.8 21036.9 15652.3 15805.4 16048.5 16074.1 16191.8 3496.9 3505.3 3551.2 3551.6 3551.8 120048.0 125883.0 125928.0 128409.7 129455.0 15333.2 16157.0 16263.8 16400.3 16482.3 30964.2 31065.5 31797.0 31814.8 32484.0 7306.3 7734.9 7935.3 8013.8 8115.8 3994.0 4097.9 4107.4 4112.9 4113.6 5000.1 5067.6 5149.4 5160.8 5171.5 1072.1 1095.5 1096.9 1099.3 1099.3 661.9 677.9 688.1 695.3 700.2 10910.3 12371.3 13040.7 13337.9 13585.7 678.7 699.3 704.1 709.6 720.2 5020.0 5261.9 5346.6 5374.3 5632.7 95086.5 99558.5 100978.0 102693.5 103215.0 89113.0 92987.5 94933.5 95359.5 95385.5 76520.6 76914.0 77113.0 78071.6 78654.6 12326.9 12394.9 12467.1 12658.5 12955.2 35044.3 35362.8 35397.5 35767.3 37830.0 43645.1 44067.8 56608.0 62610.7 67276.7 18444.0 18879.8 18977.1 18990.9 19049.8 21202.9 21204.4 21465.4 21479.6 21953.2 18791.2 18992.3 19027.7 19208.8 19652.7 17194.5 17540.1 17570.3 17828.8 18549.4 16265.8 16901.6 16916.2 17034.0 17110.8 13436.7 13481.5 14024.4 14146.2 14452.3 13344.5 13898.7 13912.5 13921.9 14002.9 07:28:54 INFO - PID 3600 | -------- Summary: end -------- 07:28:54 INFO - PID 3600 | 07:28:55 INFO - TEST-INFO | 3600: exit 0 07:28:55 INFO - TEST-OK | dromaeo_css | took 1115763ms 07:28:55 INFO - TEST-START | kraken 07:28:55 INFO - Initialising browser for kraken test... 07:28:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56052/getInfo.html -profile /tmp/tmpYGBmd3/profile 07:28:55 INFO - TEST-INFO | started process 3980 (/builds/slave/test/build/application/firefox/firefox http://localhost:56052/getInfo.html) 07:29:01 INFO - TEST-INFO | 3980: exit 0 07:29:01 INFO - Browser initialized. 07:29:01 INFO - Running cycle 1/1 for kraken test... 07:29:01 INFO - TEST-INFO | started process 4211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYGBmd3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:13 INFO - PID 4211 | RSS: Main: 175304704 07:29:13 INFO - PID 4211 | 07:29:15 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:56052/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56052/tests/kraken/driver.html?testName=audio-beat-detection) 07:29:16 INFO - PID 4211 | RSS: Main: 179814400 07:29:16 INFO - PID 4211 | 07:29:19 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:56052/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56052/tests/kraken/driver.html?testName=audio-dft) 07:29:20 INFO - PID 4211 | RSS: Main: 180600832 07:29:20 INFO - PID 4211 | 07:29:23 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:56052/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56052/tests/kraken/driver.html?testName=audio-fft) 07:29:23 INFO - PID 4211 | RSS: Main: 174542848 07:29:23 INFO - PID 4211 | 07:29:25 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:56052/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56052/tests/kraken/driver.html?testName=audio-oscillator) 07:29:26 INFO - PID 4211 | RSS: Main: 175366144 07:29:26 INFO - PID 4211 | 07:29:28 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:56052/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56052/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:29:29 INFO - PID 4211 | RSS: Main: 175554560 07:29:29 INFO - PID 4211 | 07:29:32 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:56052/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56052/tests/kraken/driver.html?testName=imaging-darkroom) 07:29:33 INFO - PID 4211 | RSS: Main: 178008064 07:29:33 INFO - PID 4211 | 07:29:36 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:56052/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56052/tests/kraken/driver.html?testName=imaging-desaturate) 07:29:37 INFO - PID 4211 | RSS: Main: 177836032 07:29:37 INFO - PID 4211 | 07:29:40 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:56052/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56052/tests/kraken/driver.html?testName=json-parse-financial) 07:29:40 INFO - PID 4211 | RSS: Main: 178671616 07:29:40 INFO - PID 4211 | 07:29:42 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:56052/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56052/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:29:43 INFO - PID 4211 | RSS: Main: 178450432 07:29:43 INFO - PID 4211 | 07:29:44 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:56052/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56052/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:29:45 INFO - PID 4211 | RSS: Main: 178688000 07:29:45 INFO - PID 4211 | 07:29:47 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:56052/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56052/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:29:48 INFO - PID 4211 | RSS: Main: 178327552 07:29:48 INFO - PID 4211 | 07:29:50 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:56052/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56052/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:29:51 INFO - PID 4211 | RSS: Main: 179138560 07:29:51 INFO - PID 4211 | 07:29:54 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:56052/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56052/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:29:55 INFO - PID 4211 | RSS: Main: 179245056 07:29:55 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:56052/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56052/tests/kraken/driver.html?testName=ai-astar) 07:29:57 INFO - PID 4211 | RSS: Main: 180834304 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | __start_tp_report 07:29:57 INFO - PID 4211 | _x_x_mozilla_page_load 07:29:57 INFO - PID 4211 | _x_x_mozilla_page_load_details 07:29:57 INFO - PID 4211 | |i|pagename|runs| 07:29:57 INFO - PID 4211 | |0;ai-astar;102;111;104;111;112;110;113;103;110;110 07:29:57 INFO - PID 4211 | |1;audio-beat-detection;147;119;153;177;126;140;151;119;177;126 07:29:57 INFO - PID 4211 | |2;audio-dft;163;163;165;162;166;169;166;165;167;164 07:29:57 INFO - PID 4211 | |3;audio-fft;76;75;75;171;74;75;76;75;154;76 07:29:57 INFO - PID 4211 | |4;audio-oscillator;81;80;145;81;81;84;137;80;80;132 07:29:57 INFO - PID 4211 | |5;imaging-gaussian-blur;114;114;113;114;114;114;114;114;114;118 07:29:57 INFO - PID 4211 | |6;imaging-darkroom;151;151;152;152;150;152;152;150;151;150 07:29:57 INFO - PID 4211 | |7;imaging-desaturate;94;94;95;95;99;94;94;94;94;94 07:29:57 INFO - PID 4211 | |8;json-parse-financial;55;55;54;54;54;54;54;54;54;54 07:29:57 INFO - PID 4211 | |9;json-stringify-tinderbox;61;60;54;54;53;54;54;55;54;60 07:29:57 INFO - PID 4211 | |10;stanford-crypto-aes;78;79;80;78;78;78;77;77;79;77 07:29:57 INFO - PID 4211 | |11;stanford-crypto-ccm;132;131;129;127;128;126;134;124;125;167 07:29:57 INFO - PID 4211 | |12;stanford-crypto-pbkdf2;186;183;183;183;187;187;184;182;182;184 07:29:57 INFO - PID 4211 | |13;stanford-crypto-sha256-iterative;72;70;71;74;71;70;68;81;67;70 07:29:57 INFO - PID 4211 | __end_tp_report 07:29:57 INFO - PID 4211 | __start_cc_report 07:29:57 INFO - PID 4211 | _x_x_mozilla_cycle_collect,960 07:29:57 INFO - PID 4211 | __end_cc_report 07:29:57 INFO - PID 4211 | __startTimestamp1500474597470__endTimestamp 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | ------- Summary: start ------- 07:29:57 INFO - PID 4211 | Number of tests: 14 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.50 stddev:4.01 (3.6%) stddev-sans-first:3.46 07:29:57 INFO - PID 4211 | Values: 102.0 111.0 104.0 111.0 112.0 110.0 113.0 103.0 110.0 110.0 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:149.00 stddev:21.68 (14.5%) stddev-sans-first:22.95 07:29:57 INFO - PID 4211 | Values: 147.0 119.0 153.0 177.0 126.0 140.0 151.0 119.0 177.0 126.0 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.50 stddev:2.11 (1.3%) stddev-sans-first:2.11 07:29:57 INFO - PID 4211 | Values: 163.0 163.0 165.0 162.0 166.0 169.0 166.0 165.0 167.0 164.0 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.00 stddev:37.01 (49.3%) stddev-sans-first:38.76 07:29:57 INFO - PID 4211 | Values: 76.0 75.0 75.0 171.0 74.0 75.0 76.0 75.0 154.0 76.0 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:80.50 stddev:27.73 (34.4%) stddev-sans-first:28.71 07:29:57 INFO - PID 4211 | Values: 81.0 80.0 145.0 81.0 81.0 84.0 137.0 80.0 80.0 132.0 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.34 (1.2%) stddev-sans-first:1.41 07:29:57 INFO - PID 4211 | Values: 114.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 114.0 118.0 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.50 stddev:0.88 (0.6%) stddev-sans-first:0.93 07:29:57 INFO - PID 4211 | Values: 151.0 151.0 152.0 152.0 150.0 152.0 152.0 150.0 151.0 150.0 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.00 stddev:1.57 (1.7%) stddev-sans-first:1.64 07:29:57 INFO - PID 4211 | Values: 94.0 94.0 95.0 95.0 99.0 94.0 94.0 94.0 94.0 94.0 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.33 07:29:57 INFO - PID 4211 | Values: 55.0 55.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:54.50 stddev:3.11 (5.7%) stddev-sans-first:2.69 07:29:57 INFO - PID 4211 | Values: 61.0 60.0 54.0 54.0 53.0 54.0 54.0 55.0 54.0 60.0 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.00 stddev:0.99 (1.3%) stddev-sans-first:1.05 07:29:57 INFO - PID 4211 | Values: 78.0 79.0 80.0 78.0 78.0 78.0 77.0 77.0 79.0 77.0 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:130.00 stddev:12.60 (9.7%) stddev-sans-first:13.36 07:29:57 INFO - PID 4211 | Values: 132.0 131.0 129.0 127.0 128.0 126.0 134.0 124.0 125.0 167.0 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.10 Median:184.00 stddev:1.91 (1.0%) stddev-sans-first:1.90 07:29:57 INFO - PID 4211 | Values: 186.0 183.0 183.0 183.0 187.0 187.0 184.0 182.0 182.0 184.0 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.00 stddev:3.89 (5.5%) stddev-sans-first:4.12 07:29:57 INFO - PID 4211 | Values: 72.0 70.0 71.0 74.0 71.0 70.0 68.0 81.0 67.0 70.0 07:29:57 INFO - PID 4211 | -------- Summary: end -------- 07:29:57 INFO - PID 4211 | 07:29:57 INFO - PID 4211 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:29:58 INFO - TEST-INFO | 4211: exit 0 07:29:58 INFO - TEST-OK | kraken | took 62940ms 07:29:58 INFO - SUITE-END | took 1178s 07:29:58 INFO - Completed test suite (00:19:39) 07:29:58 INFO - javascript benchmark 07:29:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8437.813343507309, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.34262804811, 3148.2444213388785, 3163.984180079099, 3167.588213532241, 3229.0635715642466, 6134.846628834276, 6225.750969961202, 6246.406591373823, 6258.749650014, 6294.30762616113, 6039.214902062726, 6185.072239164117, 6189.783357582485, 6202.0386840039755, 6202.875942481148, 5617.634853734515, 5629.268195134637, 5648.6893220872835, 5754.568407369443, 5756.165356023374, 5717.885642287151, 5719.656820590757, 5739.655620662774, 5746.48281654651, 5776.797812076578, 5582.078956972115, 5655.7172141392975, 5704.686242256675, 5765.481106700396, 5788.594798364116, 5540.556755459554, 5621.690807005613, 5685.658860468385, 5699.914501282484, 5776.220210271623, 5558.722063896789, 5568.638038527482, 5591.580631452616, 5620.5503559715125, 5633.0, 6076.574639775217, 6109.755609775603, 6123.0, 6130.63216207029, 6146.200993870812, 6517.087607734921, 6592.967035164794, 6658.467322614228, 6663.63350015749, 6670.499712521531, 6523.0, 6612.338766123349, 6682.164729408824, 6723.798286051427, 6745.123133992599, 6155.907661385083, 6225.937740622627, 6251.562390632657, 6253.937460625427, 6261.154744109578, 6753.257141714407, 6784.491163162783, 6856.485763567753, 6861.4853885958755, 6862.279460656659, 6413.486921046305, 6455.548111632234, 6458.192725909262, 6571.145751052332, 6576.0793488911595, 6515.446187074057, 6575.473962083021, 6585.012248162814, 6589.670516474157, 6593.505487088391, 6483.902741458882, 6536.24833144185, 6543.0, 6544.280129185786, 6548.476121910236, 6534.869302613921, 6580.901286480706, 6581.407673309425, 6582.045603387482, 6588.275289718127, 5314.654547454403, 5330.600204984642, 5363.704996225245, 5366.275552800322, 5366.946330536723, 4506.954930450719, 4542.432195975503, 4596.563326484045, 4604.102200071021, 4610.101030299126, 5643.492085712223, 5723.656580605094, 5786.218860453869, 5800.1299805029585, 5804.071348584291, 6627.072209890619, 6627.635480048547, 6628.83427914306, 6639.834004149839, 6648.8670226595195, 5646.576506761927, 5705.572082093777, 5716.771329146787, 5730.598858079978, 5754.6547207167705, 5754.5971781975695, 5768.711564421762, 5810.477057064884, 5810.970945145332, 5832.912506312408, 6298.244210694563, 6329.367063293634, 6361.427471527492, 6438.356164383524, 6441.838954026187, 6612.735490580323, 6615.536912416084, 6689.26418094019, 6704.83237919056, 6711.161104861892, 6377.17096777416, 6395.488360931207, 6415.71129299192, 6421.839454013687, 6441.227052753699, 6490.772822951174, 6512.5766825156215, 6518.478521718346, 6575.638339891352, 6598.27418983921, 6469.708863101077, 6602.3397660233595, 6614.536982411185, 6714.865702685821, 6726.562773419712, 6389.77635782764, 6403.487720982217, 6482.222133344029, 6489.837754056186, 6513.934860651522, 6426.646534440651, 6449.226092868886, 6493.675316234264, 6507.381798729113, 6537.901931470937, 6349.936500634934, 6357.96821015892, 6364.109024736448, 6393.8721225576155, 6441.033844923299, 6387.584806987717, 6441.549091563733, 6501.967490162708, 6520.902186467112, 6539.6403197824575, 6324.525660575383, 6328.683565821599, 6337.366263373626, 6346.397092276226, 6354.332795056453], "value": 6042.184336432624, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.837074214415, 819.4386845011168, 838.4591938199861, 842.827220419814, 1162.3490845126723, 29967.0, 40773.38839917404, 41685.37471937916, 41775.58224417755, 41825.37261941074, 42043.0, 42190.78904605473, 42287.365689514685, 42311.365329520006, 42373.15253694932, 7217.783466495987, 7733.767986960372, 7854.803629909241, 7858.842823143534, 7912.050553933536, 7698.2686644768655, 7810.062792464883, 7810.609469526529, 7812.570308633023, 7826.256505631955, 7781.182975787546, 7792.493487923295, 7803.453758236926, 7817.570033648147, 7837.843243135134, 7760.340371068466, 7800.336971357441, 7802.726904558313, 7803.024621922288, 7803.76588702337, 7518.060242469692, 7629.504082234637, 7676.654550545239, 7684.116326622454, 7694.0, 38244.617553824384, 38633.227335453135, 38704.61295387038, 38714.806425967974, 38758.41862372067, 3582.3551760683067, 3628.4013137832226, 3631.182983828644, 3632.945505817415, 3647.4528820676846, 30803.075907722803, 30969.690303096904, 31097.53353699696, 31098.37803243945, 31190.0, 4729.148753224418, 4865.902681946377, 4924.852254432372, 4939.8024079036795, 5016.147254966664, 184950.0, 185264.0, 186081.0, 186455.0, 186572.06713966478, 47746.28380574294, 47978.520214797405, 48169.518304816505, 48170.518294816604, 48223.27665084956, 53610.0, 54275.0, 54584.99782512, 54643.72678136663, 54653.0, 15417.537473875802, 15443.30505127272, 15446.691066178839, 15496.84503154954, 15517.612059698373, 12118.454669539891, 12395.132340736242, 13545.05184637066, 13870.237136957363, 13884.23636699971, 14389.496367627084, 14409.567712968628, 14482.782758258634, 14542.709145817236, 14616.123032618078, 5660.745266463019, 5824.621399609096, 5974.522038236931, 5998.850028749229, 6059.818205453844, 997.2819569909653, 1011.7420057885192, 1030.0472063341379, 1032.8244198486275, 1051.9053285204368, 22260.22089226869, 22260.666090008664, 22568.774312256995, 22828.17881440222, 22982.310530684106, 1057.5928267617023, 1150.1546363423045, 1150.6145441277265, 1165.1843709403452, 1171.8066519024435, 11831.795314354007, 12289.508419663114, 12502.874971250352, 12545.658402890245, 12625.431855566521, 235985.0, 237979.0, 238835.0, 239181.0, 239217.0, 52879.735601322514, 53237.2014419784, 53346.46653533493, 53368.0, 53380.73309633427, 1475.7786332050277, 1500.174903802904, 1537.1007960343325, 1537.5541093082882, 1539.6074001129641, 21732.0, 22051.558968820213, 22660.320190394315, 23120.843957801706, 23367.298981030595, 34036.48945265773, 38645.2270954585, 38664.6133538661, 38701.41947870728, 38917.80541097277, 206171.0, 207611.0, 208270.0, 208440.0, 209422.0, 30334.84832575823, 30685.23286917845, 31194.532082019243, 31213.68786312108, 34535.309293814484, 44142.558574413844, 44573.33140002838, 44752.55247447614, 44875.32687009632, 45097.54902451065, 30628.387432251675, 31128.377432451678, 33070.5039424404, 33222.83388583042, 33313.50029749507, 31390.372192555566, 31749.206269842514, 32212.0, 32230.83884580562, 32251.677483225805, 34343.0, 34954.300913982086, 35075.47386789251, 35283.0, 35319.470207947415, 28657.0, 30177.547336790405, 31097.53353699651, 31102.844485777427, 31273.218169545944, 22988.310350689506, 23400.64899026482, 23401.882990584938, 23477.17829875946, 23518.176863809684], "value": 17196.723302553277, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.2514343638115, 570.9343425506069, 573.67013966969, 580.3239226301358, 600.2466904035435, 22065.779342206573, 22729.77270227297, 22885.771142288573, 22956.77043229567, 23026.76973230269, 26430.867845660792, 27084.0, 27125.728742712567, 27177.864110679468, 27250.45499090017, 6350.079238510425, 6495.447886929616, 6538.05198246254, 6539.705713242892, 6540.542162048659, 5885.176075349455, 6158.384161583828, 6433.93566064338, 6510.0, 6515.153030106103, 6409.583377080475, 6424.678766061702, 6435.774747883825, 6442.7745028924, 6444.387783160616, 6357.872842543169, 6424.678766061702, 6427.710753016126, 6427.775027874025, 6431.742730290783, 5952.851178720523, 5968.791092311748, 5974.641521508724, 5977.342492325841, 5990.191324171268, 28757.712422875713, 29801.850990745123, 30004.0, 30236.546451803242, 30331.69668303333, 1837.4763192490077, 1893.2427029188298, 1897.6679081160742, 1898.2501911744785, 1898.515878451, 18951.336703215322, 19226.903865480723, 19257.325993590297, 19275.421737347762, 19328.1302341395, 2066.5660211355635, 2221.44463884029, 2224.4883676754275, 2249.9775002250094, 2256.3343813575034, 134359.32820335837, 137750.3112484441, 138677.0, 138928.0, 139391.0, 14101.0, 15086.622834429227, 15179.16514591708, 15280.388784448498, 15450.5364839055, 24009.159679411136, 24036.15873444456, 24059.759402406104, 24103.276901692978, 24149.15477958263, 9658.613655453702, 10050.296479246383, 10106.343087699275, 10198.847017294747, 10228.59085636581, 9339.20616747584, 9345.252379809599, 9381.62473501066, 9487.098725621056, 9552.617895284111, 8579.828403431897, 9030.86453703195, 9035.322350823715, 9210.677626283048, 9284.95357523208, 2639.274199595127, 2710.254679963026, 2737.945241095167, 2761.2406588188005, 2825.4772867019256, 960.5437417226901, 969.3214749675255, 985.1872205430549, 1002.1882275356984, 1003.2275148135894, 19503.317383891495, 19915.203391864165, 20016.0, 20067.197312107353, 20712.275070372463, 1062.7980683670078, 1064.8189807732704, 1064.9627263045757, 1071.244772435431, 1078.5524007536942, 11203.327800332007, 11248.26886252391, 11742.178047536761, 12902.741945161044, 13883.444662213398, 502863.0, 509245.0, 512618.0, 513199.0, 531165.0, 129675.0, 130747.0, 132346.33826830806, 132807.0, 134063.32968335095, 1260.1493991555662, 1269.1179630156953, 1304.3282709404664, 1306.1836352279824, 1322.90078244134, 21047.473813154793, 21868.0, 22084.558308834054, 22370.664440033088, 22448.77551224467, 57809.13286300625, 57812.4218757807, 58217.41782582289, 59990.0, 60868.695656521435, 74733.0, 74774.62612686901, 75023.0, 75518.24481755332, 76213.6189319072, 20661.79338206659, 21287.82916939583, 21355.25256616011, 21470.355889323346, 21712.131514739234, 23563.528729424972, 23928.521429571658, 24047.398815029763, 24057.0, 24329.148479803123, 18368.0, 18802.623947521246, 18927.526811829815, 19003.23987040503, 19143.13855876461, 15679.216039198223, 15689.45086921998, 16796.580085497473, 17001.829981700026, 17580.208890599697, 18853.340133095277, 19292.614147716686, 19418.417447476033, 19452.708209377153, 19661.606767864847, 19909.502262443555, 20853.89573052125, 20877.58244835125, 20969.685454717885, 21028.158873645494, 17983.550411239823, 18071.186796594448, 18434.354797582022, 18436.26254949787, 18445.631087377908], "value": 12435.15355429924, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.1072508232191, 1437.2167168892952, 1443.877270432013, 1451.5137428961298, 1459.6861674739928, 13632.591022269335, 13784.310784460762, 14269.429222831088, 14281.71436571268, 14324.570262892104, 14393.856061439383, 14649.121052736844, 14687.0, 14698.559043228694, 14699.853001469983, 2539.263613552068, 2621.0826210826153, 2684.1679079485325, 2692.098147120717, 2695.784337253015, 2585.2890455124802, 2621.2267381122615, 2637.709851916288, 2640.326716687242, 2641.3660721426913, 2599.6100584912224, 2645.4576811753545, 2659.255408485627, 2662.241261240547, 2662.6006099085193, 2533.7972962163076, 2541.517111748771, 2558.6801649793774, 2654.2302732207636, 2655.322892662378, 2521.1680145551923, 2529.190658989124, 2530.9493810123877, 2531.9113831015825, 2543.898244070235, 13725.45098196071, 14028.649283767885, 14139.929300353535, 14172.716545669029, 14205.147691138462, 7181.245969173266, 7446.441516886201, 7479.289467500579, 7489.625518724042, 7505.737299194502, 4558.566936141095, 4609.423822022247, 4745.549172828576, 4836.613070954315, 4842.176829938883, 1878.690016147334, 1892.1674463236131, 1895.0619443375617, 1905.8570607204376, 1929.778075521319, 22693.65959510592, 23187.072517099296, 23233.53532929349, 23416.180433684738, 23847.284581462583, 6076.240469941257, 6166.4758495527485, 6379.649119298483, 6392.456641185551, 6417.326180750954, 13865.306734663227, 15786.921065394828, 15862.920685396499, 15865.603359915864, 15992.0, 6371.96814015927, 7011.824704382431, 7434.3309102181065, 7501.624918754041, 7543.434242431839, 6782.898256526156, 6905.0, 6917.827054323682, 6966.965165174243, 6980.441564674814, 4776.928346074812, 4890.926636100461, 4943.233798761198, 4976.278439626234, 4985.4266759323145, 1226.196841069101, 1238.59745582686, 1246.4764798784531, 1247.8564965028957, 1263.6777621706406, 882.3646974178581, 910.1126401758232, 912.6440688131634, 929.7954450020984, 931.1759093202429, 7134.282113484928, 7448.478606497493, 7512.21121782205, 7556.911055296363, 8082.19178082187, 692.9272426395257, 700.7127077898037, 703.5286358140058, 708.7483943200193, 712.6792943175592, 4731.929021064687, 5199.402068762065, 5271.789128434896, 5304.204369344552, 5384.111621582473, 18504.814951850578, 19277.90361048186, 19408.320708775125, 19538.413847584594, 19563.413097607096, 18466.0, 19077.427677169708, 19152.61694766097, 19157.329493467663, 19199.040047997823, 10737.194710396752, 10956.28784129029, 10983.340999540053, 10984.450777461096, 11004.614838480775, 7620.771376858482, 7774.105977812624, 7936.246056624612, 8094.635741391534, 8126.065502467292, 16120.98223198215, 16141.838581614034, 16596.41912533104, 16748.330066797193, 16932.746008810125, 15973.920130399274, 16601.91699041497, 16680.916595416944, 17169.227384767964, 17399.652006960045, 10309.74225644335, 10644.414557199429, 11127.387993660426, 11172.273802202832, 11197.944010279896, 13262.933685331898, 13431.462741490232, 13442.0, 13452.260125693181, 13456.46174153023, 10452.947735261276, 10815.810260871454, 11026.889731102907, 11096.167787415814, 11146.721331966766, 9748.610055597981, 10229.28395012342, 10384.792304154025, 10447.895521044693, 10543.736406589896, 9421.62313507452, 9651.758706032406, 9808.558614862492, 9833.0, 9834.360766550151, 6937.7571784987285, 6951.582905025714, 7166.749163779243, 7346.6693998769115, 7473.43949203801, 6765.0, 7270.382017528569, 7274.163471200668, 7284.490085694162, 7414.740484083031], "value": 6236.029501231036, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.1699817814273, 493.8671802376854, 504.3796130759166, 507.21381858119906, 519.0656817728088, 6102.0, 6122.510199184066, 6169.2288463942, 6170.0, 6180.474659653934, 5815.156802263669, 5992.970035149818, 5999.790007349744, 6004.669743164124, 6050.60671056381, 4808.447028591721, 4834.879128021801, 4836.2987366831785, 4858.174110401223, 4876.317315575822, 4731.810727570893, 4788.569028787409, 4840.394950631171, 4853.927191092136, 4887.926681099786, 4762.404699412574, 4828.589569886564, 4837.5646191842725, 4848.7575621218975, 4903.65674402792, 4847.636427267951, 4872.658913876048, 4878.146324393252, 4909.828156014522, 4914.63140264478, 4378.255696531597, 4407.471103467572, 4418.160549495586, 4421.115776844612, 4441.644668426518, 5939.46544810969, 5967.508122969258, 5974.402559744034, 5996.2504686914135, 6024.698765061773, 5604.8318550443555, 5628.774849006035, 5640.323161220639, 5641.702408446039, 5643.858903527444, 6374.840628984312, 6422.0, 6424.486041116699, 6471.255805582371, 6477.967610161919, 4765.070811191819, 4784.904301913977, 4796.472388037313, 4819.180739274332, 4828.46886842447, 6709.215675494615, 6743.471198300637, 6773.390394864486, 6776.3069127325725, 6806.829829254309, 4848.224284114524, 4886.144924638174, 4895.681780684244, 4924.285978533164, 4929.112759703288, 4992.126377883856, 5007.9499205008215, 5020.322256495327, 5021.6735912165595, 5028.7737051832755, 5472.671639701631, 5495.670259784426, 5527.806526771544, 5586.608937374426, 5646.745896434671, 6354.26925903527, 6426.6144031357335, 6449.3873082057125, 6449.935500645028, 6481.222253329536, 1610.2673283655909, 1640.9343626255054, 1683.9391183554283, 1701.5405840423016, 1704.139409598145, 1156.7570810129967, 1166.5683697032152, 1167.4279602994472, 1179.292424545266, 1191.9165658404002, 5656.2929633795775, 5696.031674615326, 5753.913691294634, 5774.711264436762, 5790.681512516768, 6357.618542887441, 6515.311931920285, 6538.934610653928, 6639.037339585733, 6686.0, 5655.462731040545, 5705.400932902068, 5712.0, 5733.426657334233, 5741.224934633771, 3506.7545271830727, 3512.0, 3521.401361768454, 3528.4883691865048, 3567.928641427157, 6363.140975968185, 6459.224893012869, 6480.630072362439, 6509.479241660656, 6509.641969691713, 6670.833229169212, 6672.399484046459, 6722.29415911332, 6762.594244345355, 6833.6241506716615, 6286.811395658137, 6383.872322553523, 6383.93616063852, 6392.360763923663, 6513.478921686159, 6584.8024559263295, 6618.867622647616, 6648.368405001517, 6661.866762664817, 6780.32196780318, 6470.320616335217, 6516.543841931019, 6569.9343006569325, 6579.703913323816, 6638.601683898982, 6371.426571608577, 6391.93608063932, 6405.871882562229, 6437.645929473924, 6446.516511261768, 4877.6585639004925, 4922.876928076684, 4963.354763880672, 4963.6525443218625, 4986.626003049713, 6553.803385898431, 6612.437942774918, 6665.133532640726, 6675.699593518206, 6722.159730033746, 6407.455366293731, 6415.615063096229, 6421.36255254907, 6433.420992110545, 6488.935110648833, 6238.064290356483, 6370.26741924666, 6415.1981002374705, 6443.903341449788, 6561.770338038145, 6205.789870975297, 6256.937430625636, 6367.3314301997625, 6387.329330420424, 6392.68036598159, 6449.806505804833, 6451.612903225821, 6459.870802584016, 6498.285188629153, 6520.836979075561, 6168.537359697951, 6218.782342618168, 6229.190205273286, 6271.3728627136925, 6284.4344009039405], "value": 4961.232669393013, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.3014913442086, 907.6278725722456, 923.3213588012806, 926.106307413346, 933.7432206143312, 18359.81640183598, 19168.904155479202, 19189.040547972614, 19205.519862003457, 21121.894390528025, 19949.900250498762, 21393.786062139374, 21749.13003479859, 21754.347369578936, 21760.673589896163, 1053.3416614615846, 1067.119626308295, 1073.1522097542932, 1074.9032587067163, 1075.0969185883855, 1046.1212581431596, 1053.146950969717, 1059.099765199582, 1059.343207211526, 1062.904338609525, 1127.408110741863, 1132.9206955513118, 1133.580575187182, 1134.9546018159265, 1135.403912945702, 1110.9166812489095, 1115.0800589513683, 1116.0792346314283, 1120.6245907620957, 1121.198343184627, 800.1518390506023, 802.6709049289764, 808.1554775259867, 809.8785182222655, 810.3679130278392, 16012.439564615299, 16195.19024048793, 16534.338626454926, 16570.0, 17095.230714617872, 19949.0, 20401.285954991654, 20982.68525972112, 21034.789652103434, 21036.894815525826, 15652.295646695811, 15805.446809361618, 16048.518544443685, 16074.115923624197, 16191.83808161927, 3496.912577185565, 3505.263894582141, 3551.200979779555, 3551.627079156703, 3551.8224088795455, 120048.0, 125883.0, 125928.0, 128409.7013977753, 129455.0, 15333.233338333039, 16157.0, 16263.837361626232, 16400.343986240656, 16482.2582983766, 30964.22589435282, 31065.534016989764, 31797.0, 31814.840925795223, 32484.0, 7306.342429181399, 7734.91711160438, 7935.2858242757275, 8013.799655008672, 8115.75652730419, 3993.980030099831, 4097.8770636880945, 4107.404426358221, 4112.938305925413, 4113.629773320416, 5000.1249781288125, 5067.569256613156, 5149.356330458692, 5160.767765450564, 5171.534561889448, 1072.1101485766794, 1095.5343978808974, 1096.8976178940113, 1099.2580008494235, 1099.3019432660158, 661.9437347825392, 677.8983152527062, 688.0573614148649, 695.2977492732376, 700.2332445971653, 10910.345379277269, 12371.257724536557, 13040.673983150496, 13337.866621333857, 13585.660358490919, 678.6606696651675, 699.3321378083917, 704.112817849503, 709.606168576445, 720.1502227371647, 5019.974900125476, 5261.894762104736, 5346.625736198506, 5374.274472946102, 5632.718364081861, 95086.5245673781, 99558.50220748995, 100978.0, 102693.48653256687, 103215.0, 89113.0, 92987.53506232426, 94933.52533237428, 95359.52320238354, 95385.52307238558, 76520.61739691377, 76914.0, 77113.0, 78071.60964195142, 78654.606726966, 12326.938365308117, 12394.876051239373, 12467.127301088836, 12658.493660253487, 12955.222686638832, 35044.29911401809, 35362.82318588493, 35397.469037963936, 35767.28465430729, 37830.0, 43645.127097458506, 44067.77966110149, 56608.0, 62610.68694656497, 67276.66361668357, 18444.0, 18879.811201887806, 18977.05114744285, 18990.905045475236, 19049.809501904805, 21202.89398553059, 21204.36386908395, 21465.356039318845, 21479.57040859205, 21953.231636892633, 18791.154398051847, 18992.335268265546, 19027.714584281523, 19208.80791192126, 19652.705209422154, 17194.484165475056, 17540.122993850513, 17570.297188112334, 17828.821711782715, 18549.35077272289, 16265.837341626906, 16901.577460563585, 16916.23876925566, 17034.0, 17110.828891710924, 13436.731265374834, 13481.460741570227, 14024.439022438988, 14146.221957792008, 14452.277386130441, 13344.532941347006, 13898.652533686738, 13912.513062043185, 13921.860781392057, 14002.859971400156], "value": 9027.393693343214, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 104.0, 111.0, 112.0, 110.0, 113.0, 103.0, 110.0, 110.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 153.0, 177.0, 126.0, 140.0, 151.0, 119.0, 177.0, 126.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 162.0, 166.0, 169.0, 166.0, 165.0, 167.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 171.0, 74.0, 75.0, 76.0, 75.0, 154.0, 76.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 145.0, 81.0, 81.0, 84.0, 137.0, 80.0, 80.0, 132.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 118.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 152.0, 152.0, 150.0, 152.0, 152.0, 150.0, 151.0, 150.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 99.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 54.0, 54.0, 53.0, 54.0, 54.0, 55.0, 54.0, 60.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 80.0, 78.0, 78.0, 78.0, 77.0, 77.0, 79.0, 77.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 129.0, 127.0, 128.0, 126.0, 134.0, 124.0, 125.0, 167.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 183.0, 183.0, 187.0, 187.0, 184.0, 182.0, 182.0, 184.0], "value": 184.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 71.0, 74.0, 71.0, 70.0, 68.0, 81.0, 67.0, 70.0], "value": 71.4, "unit": "score"}]}]} 07:29:58 INFO - Return code: 0 07:29:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:29:58 INFO - # TBPL SUCCESS # 07:29:58 INFO - Running post-action listener: _package_coverage_data 07:29:58 INFO - Running post-action listener: _resource_record_post_action 07:29:58 INFO - [mozharness: 2017-07-19 14:29:58.750175Z] Finished run-tests step (success) 07:29:58 INFO - Running post-run listener: _resource_record_post_run 07:29:58 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 5050368; Write bytes: 443179008; Read time: 1888; Write time: 382084 07:29:58 INFO - TinderboxPrint: CPU usage
13.2% 07:29:58 INFO - TinderboxPrint: I/O read bytes / time
5,050,368 / 1,888 07:29:58 INFO - TinderboxPrint: I/O write bytes / time
443,179,008 / 382,084 07:29:58 INFO - TinderboxPrint: CPU idle
8,287.8 (86.8%) 07:29:58 INFO - TinderboxPrint: CPU user
1,202.7 (12.6%) 07:29:58 INFO - TinderboxPrint: Swap in / out
0 / 0 07:29:58 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 116326400; Read time: 184; Write time: 88144 07:29:58 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:29:58 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 2805760; Write bytes: 326852608; Read time: 1536; Write time: 293940 07:29:59 INFO - Running post-run listener: _upload_blobber_files 07:29:59 INFO - Blob upload gear active. 07:29:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:29:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:29:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:29:59 INFO - (blobuploader) - INFO - Open directory for files ... 07:29:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:29:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:30:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:00 INFO - (blobuploader) - INFO - Done attempting. 07:30:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:30:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:30:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:08 INFO - (blobuploader) - INFO - Done attempting. 07:30:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:30:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:30:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:09 INFO - (blobuploader) - INFO - Done attempting. 07:30:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:30:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:30:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:10 INFO - (blobuploader) - INFO - Done attempting. 07:30:10 INFO - (blobuploader) - INFO - Iteration through files over. 07:30:10 INFO - Return code: 0 07:30:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:30:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:30:10 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bae9e4c6545de9b024c2dabd1ffd32a27581763e8a66edc33e726f9e175bd80dd57873df4a76362200d018511a89da44896f3c0df0fe347337bcc7908ef6d26b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/511f64111d299afdb3a9a9635f4507f167afcbb06d2f67b36ef6a02185434f91f498c9a13a3c9c9b991d6c9f375cd63c217aaf8f88049f0431275e3bb269ee6d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8b30bf3f789decaa1d913630053c3b100b15cbce15d3a185ed5336feeae7d2fb0fb7f4b08f67a25e4cd37f575380609fd5c6886c57fc71ea689c562ceaa792", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d67d034ef926138184ac178f0a2b6424272cf68803431adff13984372251c6da916310d2daa57eb1d55c6d05d7afa05e46384e025d107e52b0024299958cc0de"} 07:30:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:30:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:30:10 INFO - Contents: 07:30:10 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bae9e4c6545de9b024c2dabd1ffd32a27581763e8a66edc33e726f9e175bd80dd57873df4a76362200d018511a89da44896f3c0df0fe347337bcc7908ef6d26b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/511f64111d299afdb3a9a9635f4507f167afcbb06d2f67b36ef6a02185434f91f498c9a13a3c9c9b991d6c9f375cd63c217aaf8f88049f0431275e3bb269ee6d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8b30bf3f789decaa1d913630053c3b100b15cbce15d3a185ed5336feeae7d2fb0fb7f4b08f67a25e4cd37f575380609fd5c6886c57fc71ea689c562ceaa792", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d67d034ef926138184ac178f0a2b6424272cf68803431adff13984372251c6da916310d2daa57eb1d55c6d05d7afa05e46384e025d107e52b0024299958cc0de"} 07:30:10 INFO - Running post-run listener: copy_logs_to_upload_dir 07:30:10 INFO - Copying logs to upload dir... 07:30:10 INFO - mkdir: /builds/slave/test/build/upload/logs 07:30:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.597998 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-07-19 07:30:10.750220) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-19 07:30:10.754307) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bae9e4c6545de9b024c2dabd1ffd32a27581763e8a66edc33e726f9e175bd80dd57873df4a76362200d018511a89da44896f3c0df0fe347337bcc7908ef6d26b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/511f64111d299afdb3a9a9635f4507f167afcbb06d2f67b36ef6a02185434f91f498c9a13a3c9c9b991d6c9f375cd63c217aaf8f88049f0431275e3bb269ee6d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8b30bf3f789decaa1d913630053c3b100b15cbce15d3a185ed5336feeae7d2fb0fb7f4b08f67a25e4cd37f575380609fd5c6886c57fc71ea689c562ceaa792", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d67d034ef926138184ac178f0a2b6424272cf68803431adff13984372251c6da916310d2daa57eb1d55c6d05d7afa05e46384e025d107e52b0024299958cc0de"} build_url:https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011200 build_url: 'https://queue.taskcluster.net/v1/task/Q1PdNsqnTLOSjELWpWPYXw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bae9e4c6545de9b024c2dabd1ffd32a27581763e8a66edc33e726f9e175bd80dd57873df4a76362200d018511a89da44896f3c0df0fe347337bcc7908ef6d26b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/511f64111d299afdb3a9a9635f4507f167afcbb06d2f67b36ef6a02185434f91f498c9a13a3c9c9b991d6c9f375cd63c217aaf8f88049f0431275e3bb269ee6d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8b30bf3f789decaa1d913630053c3b100b15cbce15d3a185ed5336feeae7d2fb0fb7f4b08f67a25e4cd37f575380609fd5c6886c57fc71ea689c562ceaa792", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d67d034ef926138184ac178f0a2b6424272cf68803431adff13984372251c6da916310d2daa57eb1d55c6d05d7afa05e46384e025d107e52b0024299958cc0de"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-19 07:30:10.781240) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-19 07:30:10.781570) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1500457202.141110-1994623949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-19 07:30:10.831462) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-19 07:30:10.834787) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-19 07:30:10.835086) ========= ========= Total master_lag: 0.19 =========