builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1462802944.18 results: success (0) buildid: 20160509043053 builduid: 64a8f71f12304e64bd24db5173202d98 revision: 043082cb7bd8490c60815f67fbd1f33323ad7663 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 07:09:04.178296) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 07:09:04.178859) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 07:09:04.179191) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 07:09:04.195596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:09:04.195891) ========= 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=af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-05-09 07:09:04 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113435 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:09:04.322609) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:09:04.322963) ========= 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=af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014609 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:09:04.372542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:09:04.372941) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 043082cb7bd8490c60815f67fbd1f33323ad7663 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 043082cb7bd8490c60815f67fbd1f33323ad7663 --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=af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 07:09:04,583 truncating revision to first 12 chars 2016-05-09 07:09:04,583 Setting DEBUG logging. 2016-05-09 07:09:04,583 attempt 1/10 2016-05-09 07:09:04,583 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/043082cb7bd8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 07:09:04,942 unpacking tar archive at: mozilla-central-043082cb7bd8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645293 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:09:05.031395) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 07:09:05.031728) ========= script_repo_revision: 043082cb7bd8490c60815f67fbd1f33323ad7663 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 07:09:05.032152) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 07:09:05.032438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 07:09:05.041285) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-09 07:09:05.041770) ========= /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=af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:09:05 INFO - MultiFileLogger online at 20160509 07:09:05 in /builds/slave/test 07:09:05 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:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:09:05 INFO - {'append_to_log': False, 07:09:05 INFO - 'base_work_dir': '/builds/slave/test', 07:09:05 INFO - 'blob_upload_branch': 'Firefox', 07:09:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:09:05 INFO - 'branch': 'Firefox', 07:09:05 INFO - 'buildbot_json_path': 'buildprops.json', 07:09:05 INFO - 'config_files': ('talos/linux_config.py',), 07:09:05 INFO - 'default_actions': ('clobber', 07:09:05 INFO - 'read-buildbot-config', 07:09:05 INFO - 'download-and-extract', 07:09:05 INFO - 'populate-webroot', 07:09:05 INFO - 'create-virtualenv', 07:09:05 INFO - 'install', 07:09:05 INFO - 'run-tests'), 07:09:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:09:05 INFO - 'download_minidump_stackwalk': True, 07:09:05 INFO - 'download_symbols': 'ondemand', 07:09:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:09:05 INFO - 'tooltool.py': '/tools/tooltool.py', 07:09:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:09:05 INFO - '/tools/misc-python/virtualenv.py')}, 07:09:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:09:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:09:05 INFO - 'installer_path': 'installer.exe', 07:09:05 INFO - 'log_level': 'info', 07:09:05 INFO - 'log_name': 'talos', 07:09:05 INFO - 'log_to_console': True, 07:09:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:09:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:09:05 INFO - 'opt_config_files': (), 07:09:05 INFO - 'pip_index': False, 07:09:05 INFO - 'sps_profile': False, 07:09:05 INFO - 'sps_profile_interval': 0, 07:09:05 INFO - 'suite': 'dromaeojs-e10s', 07:09:05 INFO - 'system_bits': '32', 07:09:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:09:05 INFO - 'title': 'talos-linux64-ix-020', 07:09:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:09:05 INFO - 'use_talos_json': True, 07:09:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:09:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:09:05 INFO - 'work_dir': 'build'} 07:09:05 INFO - ##### 07:09:05 INFO - ##### Running clobber step. 07:09:05 INFO - ##### 07:09:05 INFO - Running pre-action listener: _resource_record_pre_action 07:09:05 INFO - Running main action method: clobber 07:09:05 INFO - rmtree: /builds/slave/test/build 07:09:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:09:05 INFO - Running post-action listener: _resource_record_post_action 07:09:05 INFO - ##### 07:09:05 INFO - ##### Finished clobber step (success) 07:09:05 INFO - ##### 07:09:05 INFO - ##### 07:09:05 INFO - ##### Running read-buildbot-config step. 07:09:05 INFO - ##### 07:09:05 INFO - Running pre-action listener: _resource_record_pre_action 07:09:05 INFO - Running main action method: read_buildbot_config 07:09:05 INFO - Using buildbot properties: 07:09:05 INFO - { 07:09:05 INFO - "project": "", 07:09:05 INFO - "product": "firefox", 07:09:05 INFO - "script_repo_revision": "production", 07:09:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:09:05 INFO - "repository": "", 07:09:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:09:05 INFO - "buildid": "20160509043053", 07:09:05 INFO - "pgo_build": "True", 07:09:05 INFO - "basedir": "/builds/slave/test", 07:09:05 INFO - "buildnumber": 727, 07:09:05 INFO - "slavename": "talos-linux64-ix-020", 07:09:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:09:05 INFO - "platform": "ubuntu64_hw", 07:09:05 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:09:05 INFO - "branch": "mozilla-central", 07:09:05 INFO - "repo_path": "mozilla-central", 07:09:05 INFO - "revision": "043082cb7bd8490c60815f67fbd1f33323ad7663", 07:09:05 INFO - "stage_platform": "linux64-pgo", 07:09:05 INFO - "builduid": "64a8f71f12304e64bd24db5173202d98", 07:09:05 INFO - "slavebuilddir": "test" 07:09:05 INFO - } 07:09:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:09:05 INFO - Running post-action listener: _resource_record_post_action 07:09:05 INFO - ##### 07:09:05 INFO - ##### Finished read-buildbot-config step (success) 07:09:05 INFO - ##### 07:09:05 INFO - ##### 07:09:05 INFO - ##### Running download-and-extract step. 07:09:05 INFO - ##### 07:09:05 INFO - Running pre-action listener: _resource_record_pre_action 07:09:05 INFO - Running main action method: download_and_extract 07:09:05 INFO - mkdir: /builds/slave/test/build/tests 07:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:05 INFO - https://queue.taskcluster.net/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:09:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:09:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:09:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:09:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:09:06 INFO - Downloaded 1361 bytes. 07:09:06 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:09:06 INFO - Using the following test package requirements: 07:09:06 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:09:06 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:09:06 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:09:06 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:06 INFO - u'jsshell-linux-x86_64.zip'], 07:09:06 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:09:06 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:09:06 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:09:06 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:09:06 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:09:06 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:09:06 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:06 INFO - https://queue.taskcluster.net/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:09:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:09:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:09:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:09:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:09:07 INFO - Downloaded 23895527 bytes. 07:09:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:09:08 INFO - Return code: 0 07:09:08 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:08 INFO - https://queue.taskcluster.net/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:09:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:09:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:09:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:09:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:09:10 INFO - Downloaded 23895527 bytes. 07:09:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:09:12 INFO - Return code: 0 07:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:12 INFO - https://queue.taskcluster.net/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:09:13 INFO - Downloaded 10840152 bytes. 07:09:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:09:13 INFO - Return code: 0 07:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:13 INFO - https://queue.taskcluster.net/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:09:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:09:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:09:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:09:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:09:15 INFO - Downloaded 58438153 bytes. 07:09:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:09:15 INFO - mkdir: /builds/slave/test/properties 07:09:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:09:15 INFO - Writing to file /builds/slave/test/properties/build_url 07:09:15 INFO - Contents: 07:09:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:09:16 INFO - Running post-action listener: _resource_record_post_action 07:09:16 INFO - Running post-action listener: set_extra_try_arguments 07:09:16 INFO - ##### 07:09:16 INFO - ##### Finished download-and-extract step (success) 07:09:16 INFO - ##### 07:09:16 INFO - ##### 07:09:16 INFO - ##### Running populate-webroot step. 07:09:16 INFO - ##### 07:09:16 INFO - Running pre-action listener: _resource_record_pre_action 07:09:16 INFO - Running main action method: populate_webroot 07:09:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:09:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:09:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:09:16 INFO - '--tppagecycles', 07:09:16 INFO - '7'], 07:09:16 INFO - 'tests': ['tsvgm']}}, 07:09:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:09:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:09:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:09:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:09:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:09:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:09:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:16 INFO - 'talos_options': ['--disable-e10s'], 07:09:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:16 INFO - 'talos_options': ['--disable-e10s'], 07:09:16 INFO - 'tests': ['damp', 'tps']}, 07:09:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:16 INFO - 'tests': ['damp', 'tps']}, 07:09:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:09:16 INFO - 'tests': ['dromaeo_dom']}, 07:09:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:09:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:09:16 INFO - 'tests': ['a11yr', 07:09:16 INFO - 'ts_paint', 07:09:16 INFO - 'tpaint', 07:09:16 INFO - 'sessionrestore', 07:09:16 INFO - 'sessionrestore_no_auto_restore', 07:09:16 INFO - 'tabpaint']}, 07:09:16 INFO - 'other-e10s': {'tests': ['a11yr', 07:09:16 INFO - 'ts_paint', 07:09:16 INFO - 'tpaint', 07:09:16 INFO - 'sessionrestore', 07:09:16 INFO - 'sessionrestore_no_auto_restore', 07:09:16 INFO - 'tabpaint']}, 07:09:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:09:16 INFO - 'ts_paint', 07:09:16 INFO - 'tpaint', 07:09:16 INFO - 'sessionrestore', 07:09:16 INFO - 'sessionrestore_no_auto_restore', 07:09:16 INFO - 'tabpaint']}, 07:09:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:09:16 INFO - 'ts_paint', 07:09:16 INFO - 'tpaint', 07:09:16 INFO - 'sessionrestore', 07:09:16 INFO - 'sessionrestore_no_auto_restore', 07:09:16 INFO - 'tabpaint']}, 07:09:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:09:16 INFO - 'tests': ['a11yr', 07:09:16 INFO - 'ts_paint', 07:09:16 INFO - 'tpaint', 07:09:16 INFO - 'sessionrestore', 07:09:16 INFO - 'sessionrestore_no_auto_restore', 07:09:16 INFO - 'tabpaint']}, 07:09:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:09:16 INFO - 'tests': ['a11yr', 07:09:16 INFO - 'ts_paint', 07:09:16 INFO - 'tpaint', 07:09:16 INFO - 'sessionrestore', 07:09:16 INFO - 'sessionrestore_no_auto_restore', 07:09:16 INFO - 'tabpaint']}, 07:09:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:09:16 INFO - 'tests': ['tsvgx', 07:09:16 INFO - 'tsvgr_opacity', 07:09:16 INFO - 'tart', 07:09:16 INFO - 'tscrollx', 07:09:16 INFO - 'cart']}, 07:09:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:09:16 INFO - 'tsvgr_opacity', 07:09:16 INFO - 'tart', 07:09:16 INFO - 'tscrollx', 07:09:16 INFO - 'cart']}, 07:09:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:16 INFO - 'talos_options': ['--disable-e10s'], 07:09:16 INFO - 'tests': ['tp5o']}, 07:09:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:16 INFO - 'tests': ['tp5o']}, 07:09:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:16 INFO - 'talos_options': ['--disable-e10s', 07:09:16 INFO - '--xperf_path', 07:09:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:16 INFO - 'tests': ['tp5n']}, 07:09:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:16 INFO - 'talos_options': ['--xperf_path', 07:09:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:16 INFO - 'tests': ['tp5n']}}, 07:09:16 INFO - 'talos.zip': {'path': '', 07:09:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:09:16 INFO - Running post-action listener: _resource_record_post_action 07:09:16 INFO - ##### 07:09:16 INFO - ##### Finished populate-webroot step (success) 07:09:16 INFO - ##### 07:09:16 INFO - ##### 07:09:16 INFO - ##### Running create-virtualenv step. 07:09:16 INFO - ##### 07:09:16 INFO - Running pre-action listener: _resource_record_pre_action 07:09:16 INFO - Running main action method: create_virtualenv 07:09:16 INFO - Creating virtualenv /builds/slave/test/build/venv 07:09:16 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:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:09:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:09:16 INFO - Using real prefix '/usr' 07:09:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:09:16 INFO - Installing distribute.............................................................................................................................................................................................done. 07:09:18 INFO - Installing pip.................done. 07:09:18 INFO - Return code: 0 07:09:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:18 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f505f9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e9c0>, '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 0x105f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', '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:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:09:18 INFO - Using env: {'DISPLAY': ':0', 07:09:18 INFO - 'HOME': '/home/cltbld', 07:09:18 INFO - 'LANG': 'en_US.UTF-8', 07:09:18 INFO - 'LANGUAGE': 'en_US:en', 07:09:18 INFO - 'LOGNAME': 'cltbld', 07:09:18 INFO - 'MAIL': '/var/mail/cltbld', 07:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:18 INFO - 'MOZ_NO_REMOTE': '1', 07:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:18 INFO - 'NO_EM_RESTART': '1', 07:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:18 INFO - 'PWD': '/builds/slave/test', 07:09:18 INFO - 'SHELL': '/bin/bash', 07:09:18 INFO - 'SHLVL': '1', 07:09:18 INFO - 'TERM': 'linux', 07:09:18 INFO - 'TMOUT': '86400', 07:09:18 INFO - 'USER': 'cltbld', 07:09:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', 07:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:18 INFO - '_': '/tools/buildbot/bin/python'} 07:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:19 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:19 INFO - Cleaning up... 07:09:19 INFO - Return code: 0 07:09:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:19 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f505f9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e9c0>, '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 0x105f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', '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:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:09:19 INFO - Using env: {'DISPLAY': ':0', 07:09:19 INFO - 'HOME': '/home/cltbld', 07:09:19 INFO - 'LANG': 'en_US.UTF-8', 07:09:19 INFO - 'LANGUAGE': 'en_US:en', 07:09:19 INFO - 'LOGNAME': 'cltbld', 07:09:19 INFO - 'MAIL': '/var/mail/cltbld', 07:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:19 INFO - 'MOZ_NO_REMOTE': '1', 07:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:19 INFO - 'NO_EM_RESTART': '1', 07:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:19 INFO - 'PWD': '/builds/slave/test', 07:09:19 INFO - 'SHELL': '/bin/bash', 07:09:19 INFO - 'SHLVL': '1', 07:09:19 INFO - 'TERM': 'linux', 07:09:19 INFO - 'TMOUT': '86400', 07:09:19 INFO - 'USER': 'cltbld', 07:09:19 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', 07:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:19 INFO - '_': '/tools/buildbot/bin/python'} 07:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:19 INFO - Downloading/unpacking psutil>=0.7.1 07:09:19 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:19 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:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:19 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:19 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:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:09:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:21 INFO - Installing collected packages: psutil 07:09:21 INFO - Running setup.py install for psutil 07:09:21 INFO - building 'psutil._psutil_linux' extension 07:09:21 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:21 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:21 INFO - building 'psutil._psutil_posix' extension 07:09:21 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:21 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:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:21 INFO - Successfully installed psutil 07:09:21 INFO - Cleaning up... 07:09:21 INFO - Return code: 0 07:09:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:21 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f505f9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e9c0>, '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 0x105f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', '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:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:09:21 INFO - Using env: {'DISPLAY': ':0', 07:09:21 INFO - 'HOME': '/home/cltbld', 07:09:21 INFO - 'LANG': 'en_US.UTF-8', 07:09:21 INFO - 'LANGUAGE': 'en_US:en', 07:09:21 INFO - 'LOGNAME': 'cltbld', 07:09:21 INFO - 'MAIL': '/var/mail/cltbld', 07:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:21 INFO - 'MOZ_NO_REMOTE': '1', 07:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:21 INFO - 'NO_EM_RESTART': '1', 07:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:21 INFO - 'PWD': '/builds/slave/test', 07:09:21 INFO - 'SHELL': '/bin/bash', 07:09:21 INFO - 'SHLVL': '1', 07:09:21 INFO - 'TERM': 'linux', 07:09:21 INFO - 'TMOUT': '86400', 07:09:21 INFO - 'USER': 'cltbld', 07:09:21 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', 07:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:21 INFO - '_': '/tools/buildbot/bin/python'} 07:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:09:21 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:21 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:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:21 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:21 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:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:09:23 INFO - Installing collected packages: mozsystemmonitor 07:09:23 INFO - Running setup.py install for mozsystemmonitor 07:09:23 INFO - Successfully installed mozsystemmonitor 07:09:23 INFO - Cleaning up... 07:09:24 INFO - Return code: 0 07:09:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:24 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f505f9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e9c0>, '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 0x105f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', '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:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:09:24 INFO - Using env: {'DISPLAY': ':0', 07:09:24 INFO - 'HOME': '/home/cltbld', 07:09:24 INFO - 'LANG': 'en_US.UTF-8', 07:09:24 INFO - 'LANGUAGE': 'en_US:en', 07:09:24 INFO - 'LOGNAME': 'cltbld', 07:09:24 INFO - 'MAIL': '/var/mail/cltbld', 07:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:24 INFO - 'MOZ_NO_REMOTE': '1', 07:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:24 INFO - 'NO_EM_RESTART': '1', 07:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:24 INFO - 'PWD': '/builds/slave/test', 07:09:24 INFO - 'SHELL': '/bin/bash', 07:09:24 INFO - 'SHLVL': '1', 07:09:24 INFO - 'TERM': 'linux', 07:09:24 INFO - 'TMOUT': '86400', 07:09:24 INFO - 'USER': 'cltbld', 07:09:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', 07:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:24 INFO - '_': '/tools/buildbot/bin/python'} 07:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:24 INFO - Downloading/unpacking blobuploader==1.2.4 07:09:24 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:24 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:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:24 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:24 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:26 INFO - Downloading blobuploader-1.2.4.tar.gz 07:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:09:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:09:26 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:26 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:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:26 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:26 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:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:09:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:09:26 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:26 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:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:26 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:26 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:26 INFO - Downloading docopt-0.6.1.tar.gz 07:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:09:26 INFO - Installing collected packages: blobuploader, requests, docopt 07:09:26 INFO - Running setup.py install for blobuploader 07:09:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:09:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:09:26 INFO - Running setup.py install for requests 07:09:27 INFO - Running setup.py install for docopt 07:09:27 INFO - Successfully installed blobuploader requests docopt 07:09:27 INFO - Cleaning up... 07:09:27 INFO - Return code: 0 07:09:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:27 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f505f9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e9c0>, '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 0x105f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', '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:27 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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:27 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:09:27 INFO - Using env: {'DISPLAY': ':0', 07:09:27 INFO - 'HOME': '/home/cltbld', 07:09:27 INFO - 'LANG': 'en_US.UTF-8', 07:09:27 INFO - 'LANGUAGE': 'en_US:en', 07:09:27 INFO - 'LOGNAME': 'cltbld', 07:09:27 INFO - 'MAIL': '/var/mail/cltbld', 07:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:27 INFO - 'MOZ_NO_REMOTE': '1', 07:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:27 INFO - 'NO_EM_RESTART': '1', 07:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:27 INFO - 'PWD': '/builds/slave/test', 07:09:27 INFO - 'SHELL': '/bin/bash', 07:09:27 INFO - 'SHLVL': '1', 07:09:27 INFO - 'TERM': 'linux', 07:09:27 INFO - 'TMOUT': '86400', 07:09:27 INFO - 'USER': 'cltbld', 07:09:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', 07:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:27 INFO - '_': '/tools/buildbot/bin/python'} 07:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:27 INFO - Running setup.py (path:/tmp/pip-viW2VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:27 INFO - Running setup.py (path:/tmp/pip-gxQBKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:27 INFO - Running setup.py (path:/tmp/pip-bip7kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:27 INFO - Running setup.py (path:/tmp/pip-f5JqbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:27 INFO - Running setup.py (path:/tmp/pip-qyeo_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:28 INFO - Running setup.py (path:/tmp/pip-zdeVHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:28 INFO - Running setup.py (path:/tmp/pip-gC2Q8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:28 INFO - Running setup.py (path:/tmp/pip-GORDUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:28 INFO - Running setup.py (path:/tmp/pip-8BNV84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:28 INFO - Running setup.py (path:/tmp/pip-gUGFZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:28 INFO - Running setup.py (path:/tmp/pip-Fgf7Fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:28 INFO - Running setup.py (path:/tmp/pip-Gnrqgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:28 INFO - Running setup.py (path:/tmp/pip-GN6xMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:28 INFO - Running setup.py (path:/tmp/pip-49LdDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:28 INFO - Running setup.py (path:/tmp/pip-BHt02w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:28 INFO - Running setup.py (path:/tmp/pip-GgOhLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:28 INFO - Running setup.py (path:/tmp/pip-tT3baS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:09:28 INFO - Running setup.py install for manifestparser 07:09:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:09:28 INFO - Running setup.py install for mozcrash 07:09:29 INFO - Running setup.py install for mozdebug 07:09:29 INFO - Running setup.py install for mozdevice 07:09:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:09:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:09:29 INFO - Running setup.py install for mozfile 07:09:29 INFO - Running setup.py install for mozhttpd 07:09:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:09:29 INFO - Running setup.py install for mozinfo 07:09:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:09:29 INFO - Running setup.py install for mozInstall 07:09:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:09:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:09:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:09:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:09:29 INFO - Running setup.py install for mozleak 07:09:29 INFO - Running setup.py install for mozlog 07:09:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:09:29 INFO - Running setup.py install for moznetwork 07:09:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:09:30 INFO - Running setup.py install for mozprocess 07:09:30 INFO - Running setup.py install for mozprofile 07:09:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:09:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:09:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:09:30 INFO - Running setup.py install for mozrunner 07:09:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:09:30 INFO - Running setup.py install for mozscreenshot 07:09:30 INFO - Running setup.py install for moztest 07:09:30 INFO - Running setup.py install for mozversion 07:09:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:09:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:09:30 INFO - Cleaning up... 07:09:30 INFO - Return code: 0 07:09:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:30 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f505f9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e9c0>, '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 0x105f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', '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:30 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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:30 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:09:30 INFO - Using env: {'DISPLAY': ':0', 07:09:30 INFO - 'HOME': '/home/cltbld', 07:09:30 INFO - 'LANG': 'en_US.UTF-8', 07:09:30 INFO - 'LANGUAGE': 'en_US:en', 07:09:30 INFO - 'LOGNAME': 'cltbld', 07:09:30 INFO - 'MAIL': '/var/mail/cltbld', 07:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:30 INFO - 'MOZ_NO_REMOTE': '1', 07:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:30 INFO - 'NO_EM_RESTART': '1', 07:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:30 INFO - 'PWD': '/builds/slave/test', 07:09:30 INFO - 'SHELL': '/bin/bash', 07:09:30 INFO - 'SHLVL': '1', 07:09:30 INFO - 'TERM': 'linux', 07:09:30 INFO - 'TMOUT': '86400', 07:09:30 INFO - 'USER': 'cltbld', 07:09:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', 07:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:30 INFO - '_': '/tools/buildbot/bin/python'} 07:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:30 INFO - Running setup.py (path:/tmp/pip-29iknJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:30 INFO - Running setup.py (path:/tmp/pip-AZ2moF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:31 INFO - Running setup.py (path:/tmp/pip-11Ae89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:31 INFO - Running setup.py (path:/tmp/pip-iQqT8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:31 INFO - Running setup.py (path:/tmp/pip-T7Ap0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:31 INFO - Running setup.py (path:/tmp/pip-dsVm2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:31 INFO - Running setup.py (path:/tmp/pip-3NsqfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:31 INFO - Running setup.py (path:/tmp/pip-b8nFBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:31 INFO - Running setup.py (path:/tmp/pip-1v8grw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:31 INFO - Running setup.py (path:/tmp/pip-vcdeEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:31 INFO - Running setup.py (path:/tmp/pip-rd6MWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:31 INFO - Running setup.py (path:/tmp/pip-9cNVE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:31 INFO - Running setup.py (path:/tmp/pip-pJuyUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:31 INFO - Running setup.py (path:/tmp/pip-QDYIaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:31 INFO - Running setup.py (path:/tmp/pip-7aRU7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:31 INFO - Running setup.py (path:/tmp/pip-CnbWkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:32 INFO - Running setup.py (path:/tmp/pip-kS2jyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:32 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:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:09:32 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:32 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:09:32 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:09:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:09:32 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:32 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:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:32 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:32 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:33 INFO - Downloading blessings-1.6.tar.gz 07:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:09:34 INFO - Installing collected packages: blessings 07:09:34 INFO - Running setup.py install for blessings 07:09:34 INFO - Successfully installed blessings 07:09:34 INFO - Cleaning up... 07:09:34 INFO - Return code: 0 07:09:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:09:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:34 INFO - Reading from file tmpfile_stdout 07:09:34 INFO - Current package versions: 07:09:34 INFO - argparse == 1.2.1 07:09:34 INFO - blessings == 1.6 07:09:34 INFO - blobuploader == 1.2.4 07:09:34 INFO - docopt == 0.6.1 07:09:34 INFO - manifestparser == 1.1 07:09:34 INFO - mozInstall == 1.12 07:09:34 INFO - mozcrash == 0.17 07:09:34 INFO - mozdebug == 0.1 07:09:34 INFO - mozdevice == 0.48 07:09:34 INFO - mozfile == 1.2 07:09:34 INFO - mozhttpd == 0.7 07:09:34 INFO - mozinfo == 0.9 07:09:34 INFO - mozleak == 0.1 07:09:34 INFO - mozlog == 3.1 07:09:34 INFO - moznetwork == 0.27 07:09:34 INFO - mozprocess == 0.22 07:09:34 INFO - mozprofile == 0.28 07:09:34 INFO - mozrunner == 6.11 07:09:34 INFO - mozscreenshot == 0.1 07:09:34 INFO - mozsystemmonitor == 0.0 07:09:34 INFO - moztest == 0.7 07:09:34 INFO - mozversion == 1.4 07:09:34 INFO - psutil == 3.1.1 07:09:34 INFO - requests == 1.2.3 07:09:34 INFO - wsgiref == 0.1.2 07:09:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:34 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f505f9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e9c0>, '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 0x105f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', '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:34 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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:34 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:09:34 INFO - Using env: {'DISPLAY': ':0', 07:09:34 INFO - 'HOME': '/home/cltbld', 07:09:34 INFO - 'LANG': 'en_US.UTF-8', 07:09:34 INFO - 'LANGUAGE': 'en_US:en', 07:09:34 INFO - 'LOGNAME': 'cltbld', 07:09:34 INFO - 'MAIL': '/var/mail/cltbld', 07:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:34 INFO - 'MOZ_NO_REMOTE': '1', 07:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:34 INFO - 'NO_EM_RESTART': '1', 07:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:34 INFO - 'PWD': '/builds/slave/test', 07:09:34 INFO - 'SHELL': '/bin/bash', 07:09:34 INFO - 'SHLVL': '1', 07:09:34 INFO - 'TERM': 'linux', 07:09:34 INFO - 'TMOUT': '86400', 07:09:34 INFO - 'USER': 'cltbld', 07:09:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', 07:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:34 INFO - '_': '/tools/buildbot/bin/python'} 07:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 INFO - Cleaning up... 07:09:34 INFO - Return code: 0 07:09:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:34 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f505f9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e9c0>, '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 0x105f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', '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:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:09:34 INFO - Using env: {'DISPLAY': ':0', 07:09:34 INFO - 'HOME': '/home/cltbld', 07:09:34 INFO - 'LANG': 'en_US.UTF-8', 07:09:34 INFO - 'LANGUAGE': 'en_US:en', 07:09:34 INFO - 'LOGNAME': 'cltbld', 07:09:34 INFO - 'MAIL': '/var/mail/cltbld', 07:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:34 INFO - 'MOZ_NO_REMOTE': '1', 07:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:34 INFO - 'NO_EM_RESTART': '1', 07:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:34 INFO - 'PWD': '/builds/slave/test', 07:09:34 INFO - 'SHELL': '/bin/bash', 07:09:34 INFO - 'SHLVL': '1', 07:09:34 INFO - 'TERM': 'linux', 07:09:34 INFO - 'TMOUT': '86400', 07:09:34 INFO - 'USER': 'cltbld', 07:09:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', 07:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:34 INFO - '_': '/tools/buildbot/bin/python'} 07:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:34 INFO - Downloading/unpacking jsonschema 07:09:34 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:34 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:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:34 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:34 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:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:09:36 INFO - Downloading/unpacking functools32 (from jsonschema) 07:09:36 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:36 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:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:36 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:36 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:36 INFO - Downloading functools32-3.2.3-2.tar.gz 07:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:09:36 INFO - warning: no files found matching '*.txt' 07:09:36 INFO - no previously-included directories found matching 'build' 07:09:36 INFO - no previously-included directories found matching 'dist' 07:09:36 INFO - no previously-included directories found matching '.git*' 07:09:37 INFO - Installing collected packages: jsonschema, functools32 07:09:37 INFO - Running setup.py install for functools32 07:09:37 INFO - warning: no files found matching '*.txt' 07:09:37 INFO - no previously-included directories found matching 'build' 07:09:37 INFO - no previously-included directories found matching 'dist' 07:09:37 INFO - no previously-included directories found matching '.git*' 07:09:37 INFO - Successfully installed jsonschema functools32 07:09:37 INFO - Cleaning up... 07:09:37 INFO - Return code: 0 07:09:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:37 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f505f9cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e9c0>, '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 0x105f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd50>, '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': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', '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:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:09:37 INFO - Using env: {'DISPLAY': ':0', 07:09:37 INFO - 'HOME': '/home/cltbld', 07:09:37 INFO - 'LANG': 'en_US.UTF-8', 07:09:37 INFO - 'LANGUAGE': 'en_US:en', 07:09:37 INFO - 'LOGNAME': 'cltbld', 07:09:37 INFO - 'MAIL': '/var/mail/cltbld', 07:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:37 INFO - 'MOZ_NO_REMOTE': '1', 07:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:37 INFO - 'NO_EM_RESTART': '1', 07:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:37 INFO - 'PWD': '/builds/slave/test', 07:09:37 INFO - 'SHELL': '/bin/bash', 07:09:37 INFO - 'SHLVL': '1', 07:09:37 INFO - 'TERM': 'linux', 07:09:37 INFO - 'TMOUT': '86400', 07:09:37 INFO - 'USER': 'cltbld', 07:09:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', 07:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:37 INFO - '_': '/tools/buildbot/bin/python'} 07:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:37 INFO - Downloading/unpacking flake8 07:09:37 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:37 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:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:37 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:37 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:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:09:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:09:39 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:39 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:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:39 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:39 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:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:09:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:09:39 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:39 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:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:39 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:39 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:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:09:39 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:39 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:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:39 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:39 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:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:09:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:09:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:09:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:09:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:09:39 INFO - no previously-included directories found matching 'docs/_build' 07:09:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:09:40 INFO - Running setup.py install for pep8 07:09:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:09:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:09:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:09:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:09:40 INFO - no previously-included directories found matching 'docs/_build' 07:09:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:09:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:09:40 INFO - Cleaning up... 07:09:40 INFO - Return code: 0 07:09:40 INFO - Running post-action listener: _resource_record_post_action 07:09:40 INFO - Running post-action listener: _start_resource_monitoring 07:09:40 INFO - Starting resource monitoring. 07:09:40 INFO - ##### 07:09:40 INFO - ##### Finished create-virtualenv step (success) 07:09:40 INFO - ##### 07:09:40 INFO - ##### 07:09:40 INFO - ##### Running install step. 07:09:40 INFO - ##### 07:09:40 INFO - Running pre-action listener: _resource_record_pre_action 07:09:40 INFO - Running main action method: install 07:09:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:40 INFO - Reading from file tmpfile_stdout 07:09:40 INFO - Detecting whether we're running mozinstall >=1.0... 07:09:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:09:40 INFO - Reading from file tmpfile_stdout 07:09:40 INFO - Output received: 07:09:40 INFO - Usage: mozinstall [options] installer 07:09:40 INFO - Options: 07:09:40 INFO - -h, --help show this help message and exit 07:09:40 INFO - -d DEST, --destination=DEST 07:09:40 INFO - Directory to install application into. [default: 07:09:40 INFO - "/builds/slave/test"] 07:09:40 INFO - --app=APP Application being installed. [default: firefox] 07:09:40 INFO - mkdir: /builds/slave/test/build/application 07:09:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:09:57 INFO - Reading from file tmpfile_stdout 07:09:57 INFO - Output received: 07:09:57 INFO - /builds/slave/test/build/application/firefox/firefox 07:09:57 INFO - Running post-action listener: _resource_record_post_action 07:09:57 INFO - ##### 07:09:57 INFO - ##### Finished install step (success) 07:09:57 INFO - ##### 07:09:57 INFO - ##### 07:09:57 INFO - ##### Running run-tests step. 07:09:57 INFO - ##### 07:09:57 INFO - Running pre-action listener: _resource_record_pre_action 07:09:57 INFO - Running main action method: run_tests 07:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:09:57 INFO - Python 2.7.3 07:09:57 INFO - Return code: 0 07:09:57 INFO - grabbing minidump binary from tooltool 07:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:57 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e9c0>, '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 0x105f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:09:57 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:09:57 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:09:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:09:57 INFO - Return code: 0 07:09:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:09:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:09:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:09:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:09:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:09:58 INFO - Return code: 0 07:09:58 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/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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:09:58 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/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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:09:58 INFO - Using env: {'DISPLAY': ':0', 07:09:58 INFO - 'HOME': '/home/cltbld', 07:09:58 INFO - 'LANG': 'en_US.UTF-8', 07:09:58 INFO - 'LANGUAGE': 'en_US:en', 07:09:58 INFO - 'LOGNAME': 'cltbld', 07:09:58 INFO - 'MAIL': '/var/mail/cltbld', 07:09:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:09:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:58 INFO - 'MOZ_NO_REMOTE': '1', 07:09:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:58 INFO - 'NO_EM_RESTART': '1', 07:09:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:58 INFO - 'PWD': '/builds/slave/test', 07:09:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:09:58 INFO - 'SHELL': '/bin/bash', 07:09:58 INFO - 'SHLVL': '1', 07:09:58 INFO - 'TERM': 'linux', 07:09:58 INFO - 'TMOUT': '86400', 07:09:58 INFO - 'USER': 'cltbld', 07:09:58 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988', 07:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:58 INFO - '_': '/tools/buildbot/bin/python'} 07:09:58 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/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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:09:58 INFO - mozversion application_buildid: 20160509043053 07:09:58 INFO - mozversion application_changeset: 043082cb7bd8490c60815f67fbd1f33323ad7663 07:09:58 INFO - mozversion application_display_name: Nightly 07:09:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:09:58 INFO - mozversion application_name: Firefox 07:09:58 INFO - mozversion application_remotingname: firefox 07:09:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:09:58 INFO - mozversion application_vendor: Mozilla 07:09:58 INFO - mozversion application_version: 49.0a1 07:09:58 INFO - mozversion platform_buildid: 20160509043053 07:09:58 INFO - mozversion platform_changeset: 043082cb7bd8490c60815f67fbd1f33323ad7663 07:09:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:09:58 INFO - mozversion platform_version: 49.0a1 07:09:58 INFO - using testdate: 1462802998 07:09:58 INFO - actual date: 1462802998 07:09:58 INFO - starting webserver on 'localhost:39674' 07:09:58 INFO - SUITE-START | Running 2 tests 07:09:58 INFO - TEST-START | dromaeo_css 07:09:58 INFO - operating with platform_type : linux_ 07:09:58 INFO - Initialising browser for dromaeo_css test... 07:09:58 INFO - TEST-INFO | started process 20402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE0ZFR4/profile http://localhost:39674/getInfo.html) 07:10:03 INFO - PROCESS | 20402 | 07:10:03 INFO - PROCESS | 20402 | (process:20471): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:10:04 INFO - PROCESS | 20402 | __metrics Screen width/height:1600/1200 07:10:04 INFO - PROCESS | 20402 | colorDepth:24 07:10:04 INFO - PROCESS | 20402 | Browser inner width/height: 1024/697 07:10:04 INFO - PROCESS | 20402 | __metrics 07:10:05 ERROR - PROCESS | 20402 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 07:10:06 INFO - TEST-INFO | 20402: exit 0 07:10:06 INFO - Browser initialized. 07:10:06 INFO - Running cycle 1/1 for dromaeo_css test... 07:10:06 INFO - TEST-INFO | started process 20523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE0ZFR4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:08 INFO - PROCESS | 20523 | 07:10:08 INFO - PROCESS | 20523 | (process:20586): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:10:18 INFO - PROCESS | 20523 | RSS: Main: 163098624 07:10:18 INFO - PROCESS | 20523 | 07:11:07 INFO - PROCESS | 20523 | 1462803067864 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:13:16 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:39674/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39674/tests/dromaeo/cssquery-ext.html) 07:13:17 INFO - PROCESS | 20523 | RSS: Main: 165404672 07:13:17 INFO - PROCESS | 20523 | 07:16:19 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:39674/tests/dromaeo/cssquery-ext.html (next: http://localhost:39674/tests/dromaeo/cssquery-jquery.html) 07:16:19 INFO - PROCESS | 20523 | RSS: Main: 166465536 07:16:19 INFO - PROCESS | 20523 | 07:19:21 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:39674/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39674/tests/dromaeo/cssquery-mootools.html) 07:19:22 INFO - PROCESS | 20523 | RSS: Main: 167460864 07:19:22 INFO - PROCESS | 20523 | 07:22:23 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:39674/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39674/tests/dromaeo/cssquery-prototype.html) 07:22:24 INFO - PROCESS | 20523 | RSS: Main: 165167104 07:22:24 INFO - PROCESS | 20523 | 07:25:27 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:39674/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39674/tests/dromaeo/cssquery-yui.html) 07:25:27 INFO - PROCESS | 20523 | RSS: Main: 166416384 07:25:27 INFO - PROCESS | 20523 | 07:28:30 INFO - PROCESS | 20523 | Cycle 1(1): loaded http://localhost:39674/tests/dromaeo/cssquery-yui.html (next: http://localhost:39674/tests/dromaeo/cssquery-dojo.html) 07:28:30 INFO - PROCESS | 20523 | RSS: Main: 168513536 07:28:30 INFO - PROCESS | 20523 | 07:28:30 INFO - PROCESS | 20523 | __start_tp_report 07:28:30 INFO - PROCESS | 20523 | _x_x_mozilla_page_load 07:28:30 INFO - PROCESS | 20523 | _x_x_mozilla_page_load_details 07:28:30 INFO - PROCESS | 20523 | |i|pagename|runs| 07:28:30 INFO - PROCESS | 20523 | |0;dojo.html;3245.334706385191;3258.3483303339335;3286.5727455430792;3294.127056330073;3308.255642480442;5585.832425027245;5596.776128954842;5644.6613203207835;5705.2012718219485;5715.9428405716035;5405.594580406466;5512.503874651281;5589.972050139754;5604.467575580324;5621.80323688671;4942.110420124376;4970.950290497094;4999.825006124786;5099.337086178792;5137.845864624067;5052.520010598987;5153.866149447115;5186.92219616706;5204.115300398941;5218.112920803454;5018.698878067309;5082.186850103965;5097.745112744348;5139.12634852076;5151.484851514856;5102.974485127587;5123.436421993578;5128.666636668605;5132.1275383184575;5137.717425541594;5035.043341765053;5057.49425057495;5078.7968481260705;5120.667156634807;5136.743162841843;5351.732413379315;5435.945640543583;5465.207544906006;5517.172424136372;5558.972205138989;6047.697615119227;6049.637021778663;6056.3338032816355;6072.2713274406915;6085.726142323561;5850.3564607893095;6088.512918966472;6102;6113.23584551931;6121.326654068093;5596.1605759136455;5628.577856660726;5662.886742265132;5672.8865422691315;5679.971600142014;6152.846178845475;6157.476614487819;6158.507319414436;6161.476274516626;6186.041163619646;5754.827355179351;5810.796622118206;5967.283925928917;5972.940270597325;5988.790392336247;5994.550408719363;6059.363766804422;6077.665728384893;6099.2985806632805;6114.633122012693;5711.7144142792695;5956.434138756811;5974.551908606872;6028.788992385245;6089.908651370233;5912.142739302863;6075.5747097703625;6078.969605152034;6079.05774604937;6079.966405711039;4532.229520981376;4548.295014272793;4573.588377046081;4584.4957054723955;4586.72479651222;4077.082656402345;4077.7145599808323;4081.7346872453195;4104.261232978092;4122.40225167355;5638.238837756932;5655.575831812548;5824.796132135355;5850.3272123705465;5860.794872179538;6041.607295525777;6071.969640151771;6076.696165191723;6077.4834139098675;6125.418085281891;5734.6845923473775;5778.653280803165;5787.652740835563;5796.652200867961;5798.159266906275;4999.825006124768;5113.667611605309;5113.71874546896;5137.434882162959;5173.611979101583;6290.842728931813;6338.58799178052;6339.936600633934;6350.587211831216;6366.076918846834;6107.267127944586;6137.570370074052;6137.907931380943;6147;6165.938340616716;6054.636721796706;6148.139260503443;6152.846178845564;6216.844578885383;6300.21247344082;5965.313988891159;5993.850153746192;5994.130851026664;6006.459418652343;6051.969740151447;6020.969895150496;6074.149619053248;6077.453029227391;6079.665618391031;6083.847903802441;5728.914066289092;5846.766129354778;5860.677662728421;5883.499902508163;5935.584509084495;5564.4991950724625;5665.603407761417;5834.562407819515;5889.646621202742;5897.056470964797;5814.215080964185;5832.416758324133;5840.474357307863;5862.032764593965;5872.354041055566;5680.147977803363;5875.089361149029;5941.910871336847;5968.46283834457;5985.40145985398;5766.279215098113;5769.971150144391;5813.6221145625395;5828.300603927556;5848.53211743068 07:28:30 INFO - PROCESS | 20523 | |1;ext.html;583.5944018906858;643.0707627478295;645.9289478157399;659.2715049869894;696.9581825090498;37243.62756372435;41300.173996520054;41330;41340.79329603348;41354.37968430476;42897.14205715884;43174.56825431745;43189.136217275634;43492;43541.129177416435;8679.652813887436;8794.208521233088;8817.16236957488;8821.911780882205;8822.647094116228;8680.348973826956;8759.868601970944;8760.4305720128;8762.167594078552;8794.648214071429;8753.124687531228;8789.340799440035;8832.911670883306;8867.246284065863;8873.51195684237;8802.383833131684;8806.911930880706;8822.691205807765;8840.513771742551;8846.24806891415;8636.697715579925;8664.610092545787;8704.303655707528;8739.912600873973;8751.956240218822;39593.60406395957;39642.80178599117;39686.20627587461;39741.80129099365;39868.60131398707;3630.25579756152;3638.490611314418;3675.1547144156725;3717.8326975286177;3787.734858559902;31407.685923140703;31888;32248.677513225037;32272.35455290881;33266.50100248498;4275.551067137968;4298;4370.737755734666;4387.429634147572;4396.274614688605;306530;307687;307757;308990;310282;35310.646893530735;55654.72172639111;56222.156667650015;56575.43424565784;56587.43412565904;35615.10962225913;37089.25821483555;37247.81376093102;37437;37453.62546374501;14962.62593435151;15162.469313573973;15202.619934501727;15294.770578441332;15295.388184472497;13212.933935330262;13257.602271931857;13266.469341226435;13299.335033248299;13299.601011969462;8623.870641940375;8639.95680021596;8647.567621618893;8685.95768507783;8689.6524139035;3338.3990881641053;3340.8329583520726;3416.350893330259;3417.726581873444;3422.6748458896864;1086.3536195963547;1095.1731442760665;1173.8884805943421;1198.1313547677864;1228.2016689152122;31045;31436.371272574877;31447.52828707571;31884.840575796974;32025.039248822108;1108.944552772358;1166.8424762657103;1200.4477940147456;1287.9484820607258;1323.7501932755063;15266.770998435033;15934.442294519868;16148.596285092966;16301.91849040771;16446.095464749313;432675;436151;436667;437238;438254;55377;56088.43911560832;56229.71885140548;56576.717116414155;56597.71701141468;1429.9642508937359;1451.2961213811293;1469.8236211654455;1470.3016067368128;1494.5964589560758;28778.136655900358;29015.709842901302;29732.405351893274;30171.245718857204;30411.54382684306;48675.5132448671;49109.2633610489;49313;49434.50565494443;49435.50564494309;375018;383317;384103;384593;384930;27605.171844844688;27930;27960.58059129074;27993.300167495974;28009.859950700116;45857.77071114623;46712.29931551097;47185.52814471811;47726.284105737745;47843.28235076407;40245.1950960985;40405.595944040186;40859.79570102131;40931.795341023106;41570.376444352754;38541.6145838538;39556.80221598873;40086;40106.39840402338;40339.394909076975;39587.80206098951;40540.797296013334;41223.58776412318;41252.38121428121;41487.377689335284;35153.48465153566;35916.4612530807;35985.28029439449;36049.27901441904;36333.818330909235;27251.727482725713;27612.861935690195;27768.305792354546;28046;28076.71923280741 07:28:30 INFO - PROCESS | 20523 | |2;jquery.html;402.77042086010965;404.65199928061844;409.20205599081777;410.2246753635628;425.01608775684286;17669.469915902526;19268.614627707437;19453.902730486327;19550.022498875052;20381.388558343275;19158.329458468957;19428.80571194291;19674.11466484008;19678.11448484818;19826.1078251479;5740.7129643517765;5797.797077102302;5886.323072846634;5911.142884281798;5958.2125362391325;5837.795677151301;5839.941600583982;5902.2622172228475;5912.911306330387;5923.318818335882;5763;5860.531157507389;5891.381404952483;5910;5924.88150236995;5604.859878503029;5817.534597232232;5826.504747096502;5849.795257165979;5852.385499522553;5218.947810521884;5262.578993680497;5292.761825717814;5296.443873393277;5301.602379821529;12643.557475488406;13442.395092220873;13600.863991360058;13814.447422103103;22759.20342788011;2270.3642979965634;2352.447174913894;2526.343150780792;2580.8967641294325;2636.1827833371717;10166.440845753481;10282.126019288295;10892.183086268482;11774.587889423914;14583.489577864724;1942.8639995200342;2002.699595060738;2041.5202427429542;2075.284027010679;2085.2076211039707;85029.14970850336;87980.56009719975;88188;89043.55478222632;89913;10787.838182427113;10832.837507437394;11116.38859862699;11269.154813389028;11295.209335346446;15872;15896.12571308566;16015.919920400323;16046.117463539618;16055.277512511964;7976.604094283477;8117.472364296302;8153.073256770263;8270.8345833083;8350.457220280663;7698.730544430918;7940.285374316224;7987.800304992422;8041.437099402986;8193.139720329398;4822.807087716452;4826.662133650681;4878.975415162856;4887.975560122177;4924.409070911442;1949.9220031198877;2020.9797902021085;2023.5447024419389;2032.5121970726918;2035.3079952816113;977.9559919803484;1040.8022475729588;1047.9161667066617;1064.6965614799744;1120.092724892823;18988.335408260646;19289.421317360502;19332.323368682028;19494.902525487283;19921.60156796856;1058.7194393485731;1090.1660229924114;1117.7205698575356;1150.913681473893;1160.9361485118231;10831.350118992885;10937.56249750001;10983.890161098447;11145.777084458428;11155.498002589902;445560;446747;487188;489917;494259;74549;87146.94985675471;90930;93974;95814.52092739491;1042.671558459083;1071.1002757683427;1083.8590983172137;1084.810158222308;1089.2919602258596;17261.56846078808;17415.651686965935;17620.735688964418;17793.822061779734;17992;40125;40813.1837363257;41442;41669;41930;56864.14703779364;58548.70725646344;59078.40921590901;59386;59628.40371596228;7561.6597253122645;8714.346424018351;8917.152870477294;8936.687215947411;8998.325125615474;11641.243319184226;13367.66580835448;13468.86531134676;13660.726785464434;13940.442382305;11782.587609433629;11804.70488237801;11996.76006479848;12113.636590902288;12166.148369614042;11811.527538898692;11818.76362472763;11922.880771192524;11963.76072478563;12090.516379344728;11956.222845515014;12052.397380131133;12059.69850753703;12070.517179312728;12439.067069969607;7609.162992070978;7881.724139655084;8139;8248.257656810916;8315.625796839036;11300.208985370946;12157.75684486323;12506.249625022529;12511.56209532662;12518.624441266777 07:28:30 INFO - PROCESS | 20523 | |3;mootools.html;1518.309169327956;1561.6017915431564;1733.6012717075073;1842.281510211018;1856.0534127594922;7455.329020388164;8453.535055571941;8455.492670439779;9053.95473022634;9063.773405664862;8551.78620534487;8775.868361974575;8833.072527384613;8885.777855553599;8893;2391.055533064443;2409.3013026222375;2413.070967677448;2425.4300239443714;2436.0377650827913;2430.890609922558;2432.5621388150125;2468.7778099971;2469.1234611712853;2470.888810003545;2427.7086749590076;2433.3794882305074;2449.7917676997386;2460.237326428804;2477.4549599088264;2358.7641235876445;2366.089055713554;2372.2527403867725;2373.8575685458927;2385.6540801583674;2306.3888069661552;2347.119830063726;2362.173239366225;2369.4905595297096;2378.143868207444;8836.425632333878;8967.955160224157;8969.820603587892;8971.147740964598;8987.281017518648;5413.350397952231;5481.068218402881;5540.445955404468;5552.139418390156;5553.9725150847225;3543.7165026797793;3556.2354093869944;3587.7309201809967;3623.547056617923;3634.509341238925;1088.0588291128197;1127.520803658442;1138.3283862521068;1165.9766804663943;1180.9409529523575;12538.937305313506;12602;12608.11743177978;12627.810582841264;12650.987920966392;4775.6418268629295;4870.220764677634;4901.705897646153;4906.484819094015;4975.5522003019905;10479.423631700178;10483.37099774016;10506.632267870587;10531.736706582244;10580.894191058145;5442.292501974718;5520.227168196456;5527.2538207342295;5527.2538207342295;5537.390887002426;4276.2302785498905;4954.8513544593;5066.594672426197;5094.2103973884105;5117.437081920985;4112.558436888154;4113.958860411358;4146.419501269825;4162.146759914211;4195.664346852244;1327.6747196936813;1331.7869140937403;1334.5129027904939;1339.4951440805755;1347.42060913808;961.4423634292094;1040.953157107917;1047.696168111239;1053.942033188182;1061.7451811565322;6084.239470066242;6111;6243.781467648701;6268.592541484789;6373.3945275198785;464;469.27497017108647;469.38276166840495;471.21072204058066;478.67689309715803;4276.144771045803;4377.015171586368;4381.539938306496;4389.780510974439;4391.802368893344;10838.349699018085;11186.944065279622;11420.31478111316;11423.485943132579;11476.655700329004;11014.339139651647;11265.098792096613;11275.37985410794;11296.435178241056;11308.830367544493;7602.50583712057;7994.200579942076;8425.620847061897;8432.494050356998;8452.1547845215;5782.797602083907;5929.970350148222;5946.345901950868;6274.905876411949;6306.369363063657;10167.796644067224;10360.222983276133;10504.212184086377;10516.474176291307;10528.157747380037;10165.796684066425;10381.480925953823;10653;10683.94658026705;10689.30519516229;7604.733834315773;8149.755507334789;8417.705380311905;8510.48937063778;8571.914280857112;8807.251383632463;8814.471131732116;8829.470231786114;8861.202491775513;8871.822563548822;7943.6822527100585;7972.083210430875;8074.192580741878;8143.982002249719;8173.632186551738;7598.430117741081;7774.378049756119;7808.648610812414;7868.881966770388;7902;6911.550749201487;7380.926190738024;7459.477836551389;7475.962620186864;7480.625968701652;5399.217113518596;5488;5525.889482210253;5571.415001424792;5593.972030139823;5173.0688476073165;5298.443663415286;5337.546308563816;5479.863003424946;5578.246936663499 07:28:30 INFO - PROCESS | 20523 | |4;prototype.html;335.6609824077681;339.32474375991774;340.9062507810353;343.1952072390244;345.66125197306656;5572.247746554219;5607.803726869561;5610.270664813574;5613.091548873383;5632.718364081795;5493.363185670881;5513.7794488220425;5529.364123125842;5539.584531160169;5551.861203469915;4079.592040795919;4132.855350062749;4206.852760153395;4255.425517555137;4255.765932873691;4228.344606585984;4233.978830105845;4292.377605247238;4314.784260786963;4320.675949303799;4310.8145260053425;4311.6335111515555;4326.935095973563;4337.132573485315;4347.78261086946;3990.04238982645;4186.790660466964;4194.203101410722;4200.537940826506;4301.204277208711;3652.2330310634798;3672.816359182057;3687.944680829763;3692.2061756722433;3718.3307004739136;5330.360356757214;5338.839834804962;5342.91985620216;5397.595180361489;5413.702246376448;4594.701344412602;4873.756312184377;4878.243872199815;4935.876603084916;4937.506249375069;5696.601237913348;5751.338596061465;5753.137029445575;5757.193992841006;5826.1843341931735;4131.793410329472;4135.56576559463;4144.3990621359735;4158.875233742962;4169.374593810922;5958.106284057383;5996.550258730569;6002.78990235344;6024.246969128859;6062.605930614496;4179.373094035858;4191.476065491814;4204.66362690984;4207.347861081537;4207.368894665825;4224.767637779952;4232.576742325743;4238.682098842537;4264.402983582301;4287.849925252601;4586.747728874944;4804.615630749532;4832.420109586872;4853;4880.413865493729;5809.622374545641;5812.360640329561;5812.7674893003805;5887;5894.440028197314;1434.2398528779763;1437.8849692024612;1439.3379045638915;1446.70342579773;1449.463698431587;916.2303664921365;939.2157548447124;967.874176357069;972.6644307713827;981.9656312029188;5361.517463428232;5381;5397.919031214535;5411.675299482044;5424.864378390493;5646.887062258732;5675;5721.485066344049;5725.656460612377;5750.338711048199;5241.9516096780035;5328.280682107943;5354.223637572608;5362.9888791703115;5454.863628409322;3019.969800302013;3023.168628627145;3029.0307101727235;3063.4638938185726;3078.7690923180853;5856;5903.793367232126;5911.586188966817;5942.554308426886;5943.227380440515;6103.633781973096;6107.511399088063;6107.816765497042;6125.724342404603;6162.168107305546;6226.315105338409;6232.220972378453;6232.563720539519;6252.280987686474;6273.404026617464;5686.891056243992;6030.849228769316;6033.698315084141;6048;6078.149059131813;5924.851878703067;5963.91054134197;5964;6030.427109424598;6034.163942946808;6148.661823599566;6154.384386635751;6230.968845155745;6274.905876411766;6310.337414571404;4189.224993376235;4207.431996680409;4227.66178705709;4231.238377092153;4233.872983810491;6035.215421995113;6053.727582258897;6059.757609695739;6092.664903430354;6100.359462256399;5708.971455142698;5836.270466191726;5842.678652673973;5865.090910908816;5899.705014749159;5788.7395067222915;5844.736986835517;5855.882882342244;5864.413558644102;5901.970490147522;5454.372747133972;5575.459583164638;5758.2514273144225;5758.481736643722;5792.855178620568;5781.768729250783;5795.8551036224435;5811;5848.853778655568;5856.506590819314;5729.455701708331;5761.337446193741;5786.33457152416;5821.592488525932;5830.47525722687 07:28:30 INFO - PROCESS | 20523 | |5;yui.html;810.7405630198339;841.8021764885254;852.5737131434283;862.4652715316505;866.6923242249005;13364.198148111109;13388.732225355487;13510.662233444169;13841.100328478642;14884.92557537212;11190.776184476306;12322;12383.380830958438;12499.875001249984;12527.624171274854;800.2837460472873;827.3877330775213;828.1470085811624;829.999850180534;830.3647709502236;826.7726375246825;830.3191383065888;832.650286879509;833.3250067445389;833.4665813879122;878.8066625342415;882.9690960816373;883.8364902493028;885.5616469847403;886.1492966751925;878.3368556739684;880.4937161132375;880.8194320164351;881.9647214111428;884.7743825324566;630.1209812311845;632.3234139470768;634.1407392982488;634.9809505714836;639.0510092512615;13392.732145357135;13415.530456433979;13420.127691700009;13436.328183590782;13441.932790336083;13188.274644894527;13272.469101235938;13368.131071480322;13414.86585134146;13457.12528685642;11095.44522773866;11236.831447528293;11259.831102533468;11679;11761.470733817;3799.4490798834013;3805.4101614249835;3854.3447613905705;3886.106195575005;3971.285168669638;51639.48360516384;51981.480185198045;52510.47489525094;52578.47421525736;55141;9916.900830991597;10066.245031622657;10165;10232.744181395525;10264.486775661187;19558;19641.705374419395;19689.50776230577;19690.40928772139;19993.400197994084;8136.0643525995265;8325.750227493185;8546.529940853312;8741.213290803731;8843.60203790831;4716.127516409407;4752.596029337545;4798.928016079692;4843.249296358999;4911.87720306988;3367.7642565020215;3468.9479657805155;3469.739769517246;3472.7498100683733;3481.9477707834403;627.2911609880805;630.4389093706604;644.2011905237565;647.3300134361008;654.3914159831307;702.3994484715495;735.4006484715047;737.3253473072186;749.9775006749807;764.8049747314399;9312.674056407994;9324.95337523308;9333.533323333942;9550.37922535033;9722.368046076983;668.5353679192914;716.5915428205977;728.5701436152696;753.6947536247828;809.5587904592012;4373.497047839475;4572.51988541205;4696.8590942271785;4703.835365762182;4720.362751028567;63158.36841631617;66097.33902661008;66376.6681166591;66383.66808165929;66490;55278.17082743762;57853.421465784806;57876.421235787944;57908.42091579115;59030;51078;51603;51898;52255.73872130615;52318.47681523212;8353.916460835313;8429.157084291766;8595.65617375298;8870.379073464796;8886.333524985781;31467.527987079753;32996.50505242375;33474;34432.31135377228;34438.311233774686;40506;42402;46656.533434665216;47529.86115624736;47651.285230720874;12356.752864942831;12429.254244745343;12494.625161245178;12531.87468125307;12586.811197831857;13023.609291720884;13072.206915382285;13523.797143042666;13996.37016334247;14013.789793153315;13145.60563183106;13168.341582921008;13226.470941162246;13274.137181083199;13420.194788312732;12605.117641764988;13452.192868427926;13787.86212137906;14508.202048887413;14524.564263072125;13388.531401400904;13397.12918660284;13610.523631672844;13964.860351396355;14237.857621423653;10129.290949633454;10349.793004140025;10532.262741608014;10901.291416057931;11025.283356581796;10347.896521034694;10395.683453237229;10879.1840611956;10903.563857445613;10921.563137474412 07:28:30 INFO - PROCESS | 20523 | __end_tp_report 07:28:30 INFO - PROCESS | 20523 | __start_cc_report 07:28:30 INFO - PROCESS | 20523 | _x_x_mozilla_cycle_collect,338 07:28:30 INFO - PROCESS | 20523 | __end_cc_report 07:28:30 INFO - PROCESS | 20523 | __startTimestamp1462804110353__endTimestamp 07:28:30 INFO - PROCESS | 20523 | 07:28:30 INFO - PROCESS | 20523 | ------- Summary: start ------- 07:28:30 INFO - PROCESS | 20523 | Number of tests: 6 07:28:30 INFO - PROCESS | 20523 | 07:28:30 INFO - PROCESS | 20523 | [#0] dojo.html Cycles:165 Average:5594.17 Median:5814.22 stddev:650.29 (11.2%) stddev-sans-first:625.64 07:28:30 INFO - PROCESS | 20523 | Values: 3245.3 3258.3 3286.6 3294.1 3308.3 5585.8 5596.8 5644.7 5705.2 5715.9 5405.6 5512.5 5590.0 5604.5 5621.8 4942.1 4971.0 4999.8 5099.3 5137.8 5052.5 5153.9 5186.9 5204.1 5218.1 5018.7 5082.2 5097.7 5139.1 5151.5 5103.0 5123.4 5128.7 5132.1 5137.7 5035.0 5057.5 5078.8 5120.7 5136.7 5351.7 5435.9 5465.2 5517.2 5559.0 6047.7 6049.6 6056.3 6072.3 6085.7 5850.4 6088.5 6102.0 6113.2 6121.3 5596.2 5628.6 5662.9 5672.9 5680.0 6152.8 6157.5 6158.5 6161.5 6186.0 5754.8 5810.8 5967.3 5972.9 5988.8 5994.6 6059.4 6077.7 6099.3 6114.6 5711.7 5956.4 5974.6 6028.8 6089.9 5912.1 6075.6 6079.0 6079.1 6080.0 4532.2 4548.3 4573.6 4584.5 4586.7 4077.1 4077.7 4081.7 4104.3 4122.4 5638.2 5655.6 5824.8 5850.3 5860.8 6041.6 6072.0 6076.7 6077.5 6125.4 5734.7 5778.7 5787.7 5796.7 5798.2 4999.8 5113.7 5113.7 5137.4 5173.6 6290.8 6338.6 6339.9 6350.6 6366.1 6107.3 6137.6 6137.9 6147.0 6165.9 6054.6 6148.1 6152.8 6216.8 6300.2 5965.3 5993.9 5994.1 6006.5 6052.0 6021.0 6074.1 6077.5 6079.7 6083.8 5728.9 5846.8 5860.7 5883.5 5935.6 5564.5 5665.6 5834.6 5889.6 5897.1 5814.2 5832.4 5840.5 5862.0 5872.4 5680.1 5875.1 5941.9 5968.5 5985.4 5766.3 5770.0 5813.6 5828.3 5848.5 07:28:30 INFO - PROCESS | 20523 | 07:28:30 INFO - PROCESS | 20523 | [#1] ext.html Cycles:180 Average:53083.30 Median:39618.20 stddev:100132.74 (252.7%) stddev-sans-first:100336.06 07:28:30 INFO - PROCESS | 20523 | Values: 583.6 643.1 645.9 659.3 697.0 37243.6 41300.2 41330.0 41340.8 41354.4 42897.1 43174.6 43189.1 43492.0 43541.1 8679.7 8794.2 8817.2 8821.9 8822.6 8680.3 8759.9 8760.4 8762.2 8794.6 8753.1 8789.3 8832.9 8867.2 8873.5 8802.4 8806.9 8822.7 8840.5 8846.2 8636.7 8664.6 8704.3 8739.9 8752.0 39593.6 39642.8 39686.2 39741.8 39868.6 3630.3 3638.5 3675.2 3717.8 3787.7 31407.7 31888.0 32248.7 32272.4 33266.5 4275.6 4298.0 4370.7 4387.4 4396.3 306530.0 307687.0 307757.0 308990.0 310282.0 35310.6 55654.7 56222.2 56575.4 56587.4 35615.1 37089.3 37247.8 37437.0 37453.6 14962.6 15162.5 15202.6 15294.8 15295.4 13212.9 13257.6 13266.5 13299.3 13299.6 8623.9 8640.0 8647.6 8686.0 8689.7 3338.4 3340.8 3416.4 3417.7 3422.7 1086.4 1095.2 1173.9 1198.1 1228.2 31045.0 31436.4 31447.5 31884.8 32025.0 1108.9 1166.8 1200.4 1287.9 1323.8 15266.8 15934.4 16148.6 16301.9 16446.1 432675.0 436151.0 436667.0 437238.0 438254.0 55377.0 56088.4 56229.7 56576.7 56597.7 1430.0 1451.3 1469.8 1470.3 1494.6 28778.1 29015.7 29732.4 30171.2 30411.5 48675.5 49109.3 49313.0 49434.5 49435.5 375018.0 383317.0 384103.0 384593.0 384930.0 27605.2 27930.0 27960.6 27993.3 28009.9 45857.8 46712.3 47185.5 47726.3 47843.3 40245.2 40405.6 40859.8 40931.8 41570.4 38541.6 39556.8 40086.0 40106.4 40339.4 39587.8 40540.8 41223.6 41252.4 41487.4 35153.5 35916.5 35985.3 36049.3 36333.8 27251.7 27612.9 27768.3 28046.0 28076.7 07:28:30 INFO - PROCESS | 20523 | 07:28:30 INFO - PROCESS | 20523 | [#2] jquery.html Cycles:180 Average:28549.18 Median:2058.40 stddev:78204.46 (3799.3%) stddev-sans-first:78395.29 07:28:30 INFO - PROCESS | 20523 | Values: 402.8 404.7 409.2 410.2 425.0 17669.5 19268.6 19453.9 19550.0 20381.4 19158.3 19428.8 19674.1 19678.1 19826.1 5740.7 5797.8 5886.3 5911.1 5958.2 5837.8 5839.9 5902.3 5912.9 5923.3 5763.0 5860.5 5891.4 5910.0 5924.9 5604.9 5817.5 5826.5 5849.8 5852.4 5218.9 5262.6 5292.8 5296.4 5301.6 12643.6 13442.4 13600.9 13814.4 22759.2 2270.4 2352.4 2526.3 2580.9 2636.2 10166.4 10282.1 10892.2 11774.6 14583.5 1942.9 2002.7 2041.5 2075.3 2085.2 85029.1 87980.6 88188.0 89043.6 89913.0 10787.8 10832.8 11116.4 11269.2 11295.2 15872.0 15896.1 16015.9 16046.1 16055.3 7976.6 8117.5 8153.1 8270.8 8350.5 7698.7 7940.3 7987.8 8041.4 8193.1 4822.8 4826.7 4879.0 4888.0 4924.4 1949.9 2021.0 2023.5 2032.5 2035.3 978.0 1040.8 1047.9 1064.7 1120.1 18988.3 19289.4 19332.3 19494.9 19921.6 1058.7 1090.2 1117.7 1150.9 1160.9 10831.4 10937.6 10983.9 11145.8 11155.5 445560.0 446747.0 487188.0 489917.0 494259.0 74549.0 87146.9 90930.0 93974.0 95814.5 1042.7 1071.1 1083.9 1084.8 1089.3 17261.6 17415.7 17620.7 17793.8 17992.0 40125.0 40813.2 41442.0 41669.0 41930.0 56864.1 58548.7 59078.4 59386.0 59628.4 7561.7 8714.3 8917.2 8936.7 8998.3 11641.2 13367.7 13468.9 13660.7 13940.4 11782.6 11804.7 11996.8 12113.6 12166.1 11811.5 11818.8 11922.9 11963.8 12090.5 11956.2 12052.4 12059.7 12070.5 12439.1 7609.2 7881.7 8139.0 8248.3 8315.6 11300.2 12157.8 12506.2 12511.6 12518.6 07:28:30 INFO - PROCESS | 20523 | 07:28:30 INFO - PROCESS | 20523 | [#3] mootools.html Cycles:180 Average:5973.09 Median:466.64 stddev:3379.90 (724.3%) stddev-sans-first:3372.80 07:28:30 INFO - PROCESS | 20523 | Values: 1518.3 1561.6 1733.6 1842.3 1856.1 7455.3 8453.5 8455.5 9054.0 9063.8 8551.8 8775.9 8833.1 8885.8 8893.0 2391.1 2409.3 2413.1 2425.4 2436.0 2430.9 2432.6 2468.8 2469.1 2470.9 2427.7 2433.4 2449.8 2460.2 2477.5 2358.8 2366.1 2372.3 2373.9 2385.7 2306.4 2347.1 2362.2 2369.5 2378.1 8836.4 8968.0 8969.8 8971.1 8987.3 5413.4 5481.1 5540.4 5552.1 5554.0 3543.7 3556.2 3587.7 3623.5 3634.5 1088.1 1127.5 1138.3 1166.0 1180.9 12538.9 12602.0 12608.1 12627.8 12651.0 4775.6 4870.2 4901.7 4906.5 4975.6 10479.4 10483.4 10506.6 10531.7 10580.9 5442.3 5520.2 5527.3 5527.3 5537.4 4276.2 4954.9 5066.6 5094.2 5117.4 4112.6 4114.0 4146.4 4162.1 4195.7 1327.7 1331.8 1334.5 1339.5 1347.4 961.4 1041.0 1047.7 1053.9 1061.7 6084.2 6111.0 6243.8 6268.6 6373.4 464.0 469.3 469.4 471.2 478.7 4276.1 4377.0 4381.5 4389.8 4391.8 10838.3 11186.9 11420.3 11423.5 11476.7 11014.3 11265.1 11275.4 11296.4 11308.8 7602.5 7994.2 8425.6 8432.5 8452.2 5782.8 5930.0 5946.3 6274.9 6306.4 10167.8 10360.2 10504.2 10516.5 10528.2 10165.8 10381.5 10653.0 10683.9 10689.3 7604.7 8149.8 8417.7 8510.5 8571.9 8807.3 8814.5 8829.5 8861.2 8871.8 7943.7 7972.1 8074.2 8144.0 8173.6 7598.4 7774.4 7808.6 7868.9 7902.0 6911.6 7380.9 7459.5 7476.0 7480.6 5399.2 5488.0 5525.9 5571.4 5594.0 5173.1 5298.4 5337.5 5479.9 5578.2 07:28:30 INFO - PROCESS | 20523 | 07:28:30 INFO - PROCESS | 20523 | [#4] prototype.html Cycles:180 Average:4858.78 Median:5562.05 stddev:1455.16 (26.2%) stddev-sans-first:1419.09 07:28:30 INFO - PROCESS | 20523 | Values: 335.7 339.3 340.9 343.2 345.7 5572.2 5607.8 5610.3 5613.1 5632.7 5493.4 5513.8 5529.4 5539.6 5551.9 4079.6 4132.9 4206.9 4255.4 4255.8 4228.3 4234.0 4292.4 4314.8 4320.7 4310.8 4311.6 4326.9 4337.1 4347.8 3990.0 4186.8 4194.2 4200.5 4301.2 3652.2 3672.8 3687.9 3692.2 3718.3 5330.4 5338.8 5342.9 5397.6 5413.7 4594.7 4873.8 4878.2 4935.9 4937.5 5696.6 5751.3 5753.1 5757.2 5826.2 4131.8 4135.6 4144.4 4158.9 4169.4 5958.1 5996.6 6002.8 6024.2 6062.6 4179.4 4191.5 4204.7 4207.3 4207.4 4224.8 4232.6 4238.7 4264.4 4287.8 4586.7 4804.6 4832.4 4853.0 4880.4 5809.6 5812.4 5812.8 5887.0 5894.4 1434.2 1437.9 1439.3 1446.7 1449.5 916.2 939.2 967.9 972.7 982.0 5361.5 5381.0 5397.9 5411.7 5424.9 5646.9 5675.0 5721.5 5725.7 5750.3 5242.0 5328.3 5354.2 5363.0 5454.9 3020.0 3023.2 3029.0 3063.5 3078.8 5856.0 5903.8 5911.6 5942.6 5943.2 6103.6 6107.5 6107.8 6125.7 6162.2 6226.3 6232.2 6232.6 6252.3 6273.4 5686.9 6030.8 6033.7 6048.0 6078.1 5924.9 5963.9 5964.0 6030.4 6034.2 6148.7 6154.4 6231.0 6274.9 6310.3 4189.2 4207.4 4227.7 4231.2 4233.9 6035.2 6053.7 6059.8 6092.7 6100.4 5709.0 5836.3 5842.7 5865.1 5899.7 5788.7 5844.7 5855.9 5864.4 5902.0 5454.4 5575.5 5758.3 5758.5 5792.9 5781.8 5795.9 5811.0 5848.9 5856.5 5729.5 5761.3 5786.3 5821.6 5830.5 07:28:30 INFO - PROCESS | 20523 | 07:28:30 INFO - PROCESS | 20523 | [#5] yui.html Cycles:180 Average:14960.12 Median:4709.98 stddev:17486.80 (371.3%) stddev-sans-first:17503.57 07:28:30 INFO - PROCESS | 20523 | Values: 810.7 841.8 852.6 862.5 866.7 13364.2 13388.7 13510.7 13841.1 14884.9 11190.8 12322.0 12383.4 12499.9 12527.6 800.3 827.4 828.1 830.0 830.4 826.8 830.3 832.7 833.3 833.5 878.8 883.0 883.8 885.6 886.1 878.3 880.5 880.8 882.0 884.8 630.1 632.3 634.1 635.0 639.1 13392.7 13415.5 13420.1 13436.3 13441.9 13188.3 13272.5 13368.1 13414.9 13457.1 11095.4 11236.8 11259.8 11679.0 11761.5 3799.4 3805.4 3854.3 3886.1 3971.3 51639.5 51981.5 52510.5 52578.5 55141.0 9916.9 10066.2 10165.0 10232.7 10264.5 19558.0 19641.7 19689.5 19690.4 19993.4 8136.1 8325.8 8546.5 8741.2 8843.6 4716.1 4752.6 4798.9 4843.2 4911.9 3367.8 3468.9 3469.7 3472.7 3481.9 627.3 630.4 644.2 647.3 654.4 702.4 735.4 737.3 750.0 764.8 9312.7 9325.0 9333.5 9550.4 9722.4 668.5 716.6 728.6 753.7 809.6 4373.5 4572.5 4696.9 4703.8 4720.4 63158.4 66097.3 66376.7 66383.7 66490.0 55278.2 57853.4 57876.4 57908.4 59030.0 51078.0 51603.0 51898.0 52255.7 52318.5 8353.9 8429.2 8595.7 8870.4 8886.3 31467.5 32996.5 33474.0 34432.3 34438.3 40506.0 42402.0 46656.5 47529.9 47651.3 12356.8 12429.3 12494.6 12531.9 12586.8 13023.6 13072.2 13523.8 13996.4 14013.8 13145.6 13168.3 13226.5 13274.1 13420.2 12605.1 13452.2 13787.9 14508.2 14524.6 13388.5 13397.1 13610.5 13964.9 14237.9 10129.3 10349.8 10532.3 10901.3 11025.3 10347.9 10395.7 10879.2 10903.6 10921.6 07:28:30 INFO - PROCESS | 20523 | -------- Summary: end -------- 07:28:30 INFO - PROCESS | 20523 | 07:28:31 INFO - TEST-INFO | 20523: exit 0 07:28:31 INFO - TEST-OK | dromaeo_css | took 1112193ms 07:28:31 INFO - TEST-START | kraken 07:28:31 INFO - operating with platform_type : linux_ 07:28:31 INFO - Initialising browser for kraken test... 07:28:31 INFO - TEST-INFO | started process 20760 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYZAhsn/profile http://localhost:39674/getInfo.html) 07:28:35 INFO - PROCESS | 20760 | 07:28:35 INFO - PROCESS | 20760 | (process:20828): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:28:36 INFO - PROCESS | 20760 | __metrics Screen width/height:1600/1200 07:28:36 INFO - PROCESS | 20760 | colorDepth:24 07:28:36 INFO - PROCESS | 20760 | Browser inner width/height: 1024/697 07:28:36 INFO - PROCESS | 20760 | __metrics 07:28:37 ERROR - PROCESS | 20760 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 07:28:38 INFO - TEST-INFO | 20760: exit 0 07:28:38 INFO - Browser initialized. 07:28:38 INFO - Running cycle 1/1 for kraken test... 07:28:38 INFO - TEST-INFO | started process 20879 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYZAhsn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:39 INFO - PROCESS | 20879 | 07:28:39 INFO - PROCESS | 20879 | (process:20940): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:28:49 INFO - PROCESS | 20879 | RSS: Main: 163360768 07:28:49 INFO - PROCESS | 20879 | 07:28:52 INFO - PROCESS | 20879 | Cycle 1(1): loaded http://localhost:39674/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39674/tests/kraken/driver.html?testName=audio-beat-detection) 07:28:53 INFO - PROCESS | 20879 | RSS: Main: 167731200 07:28:53 INFO - PROCESS | 20879 | 07:28:56 INFO - PROCESS | 20879 | Cycle 1(1): loaded http://localhost:39674/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39674/tests/kraken/driver.html?testName=audio-dft) 07:28:56 INFO - PROCESS | 20879 | RSS: Main: 168071168 07:28:56 INFO - PROCESS | 20879 | 07:28:59 INFO - PROCESS | 20879 | Cycle 1(1): loaded http://localhost:39674/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39674/tests/kraken/driver.html?testName=audio-fft) 07:29:00 INFO - PROCESS | 20879 | RSS: Main: 162754560 07:29:00 INFO - PROCESS | 20879 | 07:29:02 INFO - PROCESS | 20879 | Cycle 1(1): loaded http://localhost:39674/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39674/tests/kraken/driver.html?testName=audio-oscillator) 07:29:03 INFO - PROCESS | 20879 | RSS: Main: 163098624 07:29:03 INFO - PROCESS | 20879 | 07:29:05 INFO - PROCESS | 20879 | Cycle 1(1): loaded http://localhost:39674/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39674/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:29:06 INFO - PROCESS | 20879 | RSS: Main: 163672064 07:29:06 INFO - PROCESS | 20879 | 07:29:09 INFO - PROCESS | 20879 | Cycle 1(1): loaded http://localhost:39674/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39674/tests/kraken/driver.html?testName=imaging-darkroom) 07:29:09 INFO - PROCESS | 20879 | RSS: Main: 163848192 07:29:09 INFO - PROCESS | 20879 | 07:29:13 INFO - PROCESS | 20879 | Cycle 1(1): loaded http://localhost:39674/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39674/tests/kraken/driver.html?testName=imaging-desaturate) 07:29:13 INFO - PROCESS | 20879 | RSS: Main: 162451456 07:29:13 INFO - PROCESS | 20879 | 07:29:16 INFO - PROCESS | 20879 | Cycle 1(1): loaded http://localhost:39674/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39674/tests/kraken/driver.html?testName=json-parse-financial) 07:29:17 INFO - PROCESS | 20879 | RSS: Main: 163520512 07:29:17 INFO - PROCESS | 20879 | 07:29:19 INFO - PROCESS | 20879 | Cycle 1(1): loaded http://localhost:39674/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39674/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:29:19 INFO - PROCESS | 20879 | RSS: Main: 163696640 07:29:19 INFO - PROCESS | 20879 | 07:29:21 INFO - PROCESS | 20879 | Cycle 1(1): loaded http://localhost:39674/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39674/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:29:22 INFO - PROCESS | 20879 | RSS: Main: 163676160 07:29:22 INFO - PROCESS | 20879 | 07:29:24 INFO - PROCESS | 20879 | Cycle 1(1): loaded http://localhost:39674/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39674/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:29:24 INFO - PROCESS | 20879 | RSS: Main: 164126720 07:29:24 INFO - PROCESS | 20879 | 07:29:27 INFO - PROCESS | 20879 | Cycle 1(1): loaded http://localhost:39674/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:29:28 INFO - PROCESS | 20879 | RSS: Main: 165265408 07:29:28 INFO - PROCESS | 20879 | 07:29:31 INFO - PROCESS | 20879 | Cycle 1(1): loaded http://localhost:39674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:29:31 INFO - PROCESS | 20879 | RSS: Main: 164839424 07:29:31 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | Cycle 1(1): loaded http://localhost:39674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39674/tests/kraken/driver.html?testName=ai-astar) 07:29:33 INFO - PROCESS | 20879 | RSS: Main: 165826560 07:29:33 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | __start_tp_report 07:29:33 INFO - PROCESS | 20879 | _x_x_mozilla_page_load 07:29:33 INFO - PROCESS | 20879 | _x_x_mozilla_page_load_details 07:29:33 INFO - PROCESS | 20879 | |i|pagename|runs| 07:29:33 INFO - PROCESS | 20879 | |0;ai-astar;109;111;105;110;111;112;104;111;110;112 07:29:33 INFO - PROCESS | 20879 | |1;audio-beat-detection;152;125;149;212;126;152;149;126;181;126 07:29:33 INFO - PROCESS | 20879 | |2;audio-dft;161;164;163;162;162;170;164;164;162;160 07:29:33 INFO - PROCESS | 20879 | |3;audio-fft;76;74;75;167;77;77;77;78;160;76 07:29:33 INFO - PROCESS | 20879 | |4;audio-oscillator;92;93;173;92;94;91;159;91;91;149 07:29:33 INFO - PROCESS | 20879 | |5;imaging-gaussian-blur;118;118;117;118;118;117;118;118;118;117 07:29:33 INFO - PROCESS | 20879 | |6;imaging-darkroom;146;148;147;147;146;146;147;147;147;148 07:29:33 INFO - PROCESS | 20879 | |7;imaging-desaturate;97;96;96;95;96;95;96;96;96;96 07:29:33 INFO - PROCESS | 20879 | |8;json-parse-financial;59;64;59;57;60;58;69;107;56;56 07:29:33 INFO - PROCESS | 20879 | |9;json-stringify-tinderbox;59;58;58;59;58;58;60;60;59;60 07:29:33 INFO - PROCESS | 20879 | |10;stanford-crypto-aes;80;80;80;80;81;80;85;80;80;80 07:29:33 INFO - PROCESS | 20879 | |11;stanford-crypto-ccm;126;125;125;123;138;125;129;128;194;142 07:29:33 INFO - PROCESS | 20879 | |12;stanford-crypto-pbkdf2;167;169;172;171;170;169;170;170;175;173 07:29:33 INFO - PROCESS | 20879 | |13;stanford-crypto-sha256-iterative;65;66;67;65;65;65;65;71;64;64 07:29:33 INFO - PROCESS | 20879 | __end_tp_report 07:29:33 INFO - PROCESS | 20879 | __start_cc_report 07:29:33 INFO - PROCESS | 20879 | _x_x_mozilla_cycle_collect,824 07:29:33 INFO - PROCESS | 20879 | __end_cc_report 07:29:33 INFO - PROCESS | 20879 | __startTimestamp1462804173729__endTimestamp 07:29:33 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | ------- Summary: start ------- 07:29:33 INFO - PROCESS | 20879 | Number of tests: 14 07:29:33 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:2.80 (2.5%) stddev-sans-first:2.96 07:29:33 INFO - PROCESS | 20879 | Values: 109.0 111.0 105.0 110.0 111.0 112.0 104.0 111.0 110.0 112.0 07:29:33 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:150.50 stddev:28.22 (18.8%) stddev-sans-first:29.92 07:29:33 INFO - PROCESS | 20879 | Values: 152.0 125.0 149.0 212.0 126.0 152.0 149.0 126.0 181.0 126.0 07:29:33 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:2.74 (1.7%) stddev-sans-first:2.79 07:29:33 INFO - PROCESS | 20879 | Values: 161.0 164.0 163.0 162.0 162.0 170.0 164.0 164.0 162.0 160.0 07:29:33 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | [#3] audio-fft Cycles:10 Average:93.70 Median:76.50 stddev:36.84 (48.2%) stddev-sans-first:38.52 07:29:33 INFO - PROCESS | 20879 | Values: 76.0 74.0 75.0 167.0 77.0 77.0 77.0 78.0 160.0 76.0 07:29:33 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | [#4] audio-oscillator Cycles:10 Average:112.50 Median:91.50 stddev:33.51 (36.6%) stddev-sans-first:34.71 07:29:33 INFO - PROCESS | 20879 | Values: 92.0 93.0 173.0 92.0 94.0 91.0 159.0 91.0 91.0 149.0 07:29:33 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:29:33 INFO - PROCESS | 20879 | Values: 118.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 118.0 117.0 07:29:33 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 07:29:33 INFO - PROCESS | 20879 | Values: 146.0 148.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 148.0 07:29:33 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 07:29:33 INFO - PROCESS | 20879 | Values: 97.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 07:29:33 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:59.00 stddev:15.46 (26.2%) stddev-sans-first:16.27 07:29:33 INFO - PROCESS | 20879 | Values: 59.0 64.0 59.0 57.0 60.0 58.0 69.0 107.0 56.0 56.0 07:29:33 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.88 (1.5%) stddev-sans-first:0.93 07:29:33 INFO - PROCESS | 20879 | Values: 59.0 58.0 58.0 59.0 58.0 58.0 60.0 60.0 59.0 60.0 07:29:33 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:1.58 (2.0%) stddev-sans-first:1.66 07:29:33 INFO - PROCESS | 20879 | Values: 80.0 80.0 80.0 80.0 81.0 80.0 85.0 80.0 80.0 80.0 07:29:33 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:128.50 stddev:21.46 (16.7%) stddev-sans-first:22.49 07:29:33 INFO - PROCESS | 20879 | Values: 126.0 125.0 125.0 123.0 138.0 125.0 129.0 128.0 194.0 142.0 07:29:33 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:170.50 stddev:2.27 (1.3%) stddev-sans-first:2.00 07:29:33 INFO - PROCESS | 20879 | Values: 167.0 169.0 172.0 171.0 170.0 169.0 170.0 170.0 175.0 173.0 07:29:33 INFO - PROCESS | 20879 | 07:29:33 INFO - PROCESS | 20879 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.00 stddev:2.06 (3.2%) stddev-sans-first:2.17 07:29:33 INFO - PROCESS | 20879 | Values: 65.0 66.0 67.0 65.0 65.0 65.0 65.0 71.0 64.0 64.0 07:29:33 INFO - PROCESS | 20879 | -------- Summary: end -------- 07:29:33 INFO - PROCESS | 20879 | 07:29:34 INFO - TEST-INFO | 20879: exit 0 07:29:34 INFO - TEST-OK | kraken | took 63618ms 07:29:34 INFO - SUITE-END | took 1175s 07:29:34 INFO - Completed test suite (00:19:35) 07:29:34 INFO - javascript benchmark 07:29:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3245.334706385191, 3258.3483303339335, 3286.5727455430792, 3294.127056330073, 3308.255642480442, 5585.832425027245, 5596.776128954842, 5644.6613203207835, 5705.2012718219485, 5715.9428405716035, 5405.594580406466, 5512.503874651281, 5589.972050139754, 5604.467575580324, 5621.80323688671, 4942.110420124376, 4970.950290497094, 4999.825006124786, 5099.337086178792, 5137.845864624067, 5052.520010598987, 5153.866149447115, 5186.92219616706, 5204.115300398941, 5218.112920803454, 5018.698878067309, 5082.186850103965, 5097.745112744348, 5139.12634852076, 5151.484851514856, 5102.974485127587, 5123.436421993578, 5128.666636668605, 5132.1275383184575, 5137.717425541594, 5035.043341765053, 5057.49425057495, 5078.7968481260705, 5120.667156634807, 5136.743162841843, 5351.732413379315, 5435.945640543583, 5465.207544906006, 5517.172424136372, 5558.972205138989, 6047.697615119227, 6049.637021778663, 6056.3338032816355, 6072.2713274406915, 6085.726142323561, 5850.3564607893095, 6088.512918966472, 6102.0, 6113.23584551931, 6121.326654068093, 5596.1605759136455, 5628.577856660726, 5662.886742265132, 5672.8865422691315, 5679.971600142014, 6152.846178845475, 6157.476614487819, 6158.507319414436, 6161.476274516626, 6186.041163619646, 5754.827355179351, 5810.796622118206, 5967.283925928917, 5972.940270597325, 5988.790392336247, 5994.550408719363, 6059.363766804422, 6077.665728384893, 6099.2985806632805, 6114.633122012693, 5711.7144142792695, 5956.434138756811, 5974.551908606872, 6028.788992385245, 6089.908651370233, 5912.142739302863, 6075.5747097703625, 6078.969605152034, 6079.05774604937, 6079.966405711039, 4532.229520981376, 4548.295014272793, 4573.588377046081, 4584.4957054723955, 4586.72479651222, 4077.082656402345, 4077.7145599808323, 4081.7346872453195, 4104.261232978092, 4122.40225167355, 5638.238837756932, 5655.575831812548, 5824.796132135355, 5850.3272123705465, 5860.794872179538, 6041.607295525777, 6071.969640151771, 6076.696165191723, 6077.4834139098675, 6125.418085281891, 5734.6845923473775, 5778.653280803165, 5787.652740835563, 5796.652200867961, 5798.159266906275, 4999.825006124768, 5113.667611605309, 5113.71874546896, 5137.434882162959, 5173.611979101583, 6290.842728931813, 6338.58799178052, 6339.936600633934, 6350.587211831216, 6366.076918846834, 6107.267127944586, 6137.570370074052, 6137.907931380943, 6147.0, 6165.938340616716, 6054.636721796706, 6148.139260503443, 6152.846178845564, 6216.844578885383, 6300.21247344082, 5965.313988891159, 5993.850153746192, 5994.130851026664, 6006.459418652343, 6051.969740151447, 6020.969895150496, 6074.149619053248, 6077.453029227391, 6079.665618391031, 6083.847903802441, 5728.914066289092, 5846.766129354778, 5860.677662728421, 5883.499902508163, 5935.584509084495, 5564.4991950724625, 5665.603407761417, 5834.562407819515, 5889.646621202742, 5897.056470964797, 5814.215080964185, 5832.416758324133, 5840.474357307863, 5862.032764593965, 5872.354041055566, 5680.147977803363, 5875.089361149029, 5941.910871336847, 5968.46283834457, 5985.40145985398, 5766.279215098113, 5769.971150144391, 5813.6221145625395, 5828.300603927556, 5848.53211743068], "value": 5549.7653154176205, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.5944018906858, 643.0707627478295, 645.9289478157399, 659.2715049869894, 696.9581825090498, 37243.62756372435, 41300.173996520054, 41330.0, 41340.79329603348, 41354.37968430476, 42897.14205715884, 43174.56825431745, 43189.136217275634, 43492.0, 43541.129177416435, 8679.652813887436, 8794.208521233088, 8817.16236957488, 8821.911780882205, 8822.647094116228, 8680.348973826956, 8759.868601970944, 8760.4305720128, 8762.167594078552, 8794.648214071429, 8753.124687531228, 8789.340799440035, 8832.911670883306, 8867.246284065863, 8873.51195684237, 8802.383833131684, 8806.911930880706, 8822.691205807765, 8840.513771742551, 8846.24806891415, 8636.697715579925, 8664.610092545787, 8704.303655707528, 8739.912600873973, 8751.956240218822, 39593.60406395957, 39642.80178599117, 39686.20627587461, 39741.80129099365, 39868.60131398707, 3630.25579756152, 3638.490611314418, 3675.1547144156725, 3717.8326975286177, 3787.734858559902, 31407.685923140703, 31888.0, 32248.677513225037, 32272.35455290881, 33266.50100248498, 4275.551067137968, 4298.0, 4370.737755734666, 4387.429634147572, 4396.274614688605, 306530.0, 307687.0, 307757.0, 308990.0, 310282.0, 35310.646893530735, 55654.72172639111, 56222.156667650015, 56575.43424565784, 56587.43412565904, 35615.10962225913, 37089.25821483555, 37247.81376093102, 37437.0, 37453.62546374501, 14962.62593435151, 15162.469313573973, 15202.619934501727, 15294.770578441332, 15295.388184472497, 13212.933935330262, 13257.602271931857, 13266.469341226435, 13299.335033248299, 13299.601011969462, 8623.870641940375, 8639.95680021596, 8647.567621618893, 8685.95768507783, 8689.6524139035, 3338.3990881641053, 3340.8329583520726, 3416.350893330259, 3417.726581873444, 3422.6748458896864, 1086.3536195963547, 1095.1731442760665, 1173.8884805943421, 1198.1313547677864, 1228.2016689152122, 31045.0, 31436.371272574877, 31447.52828707571, 31884.840575796974, 32025.039248822108, 1108.944552772358, 1166.8424762657103, 1200.4477940147456, 1287.9484820607258, 1323.7501932755063, 15266.770998435033, 15934.442294519868, 16148.596285092966, 16301.91849040771, 16446.095464749313, 432675.0, 436151.0, 436667.0, 437238.0, 438254.0, 55377.0, 56088.43911560832, 56229.71885140548, 56576.717116414155, 56597.71701141468, 1429.9642508937359, 1451.2961213811293, 1469.8236211654455, 1470.3016067368128, 1494.5964589560758, 28778.136655900358, 29015.709842901302, 29732.405351893274, 30171.245718857204, 30411.54382684306, 48675.5132448671, 49109.2633610489, 49313.0, 49434.50565494443, 49435.50564494309, 375018.0, 383317.0, 384103.0, 384593.0, 384930.0, 27605.171844844688, 27930.0, 27960.58059129074, 27993.300167495974, 28009.859950700116, 45857.77071114623, 46712.29931551097, 47185.52814471811, 47726.284105737745, 47843.28235076407, 40245.1950960985, 40405.595944040186, 40859.79570102131, 40931.795341023106, 41570.376444352754, 38541.6145838538, 39556.80221598873, 40086.0, 40106.39840402338, 40339.394909076975, 39587.80206098951, 40540.797296013334, 41223.58776412318, 41252.38121428121, 41487.377689335284, 35153.48465153566, 35916.4612530807, 35985.28029439449, 36049.27901441904, 36333.818330909235, 27251.727482725713, 27612.861935690195, 27768.305792354546, 28046.0, 28076.71923280741], "value": 18619.837865571622, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.77042086010965, 404.65199928061844, 409.20205599081777, 410.2246753635628, 425.01608775684286, 17669.469915902526, 19268.614627707437, 19453.902730486327, 19550.022498875052, 20381.388558343275, 19158.329458468957, 19428.80571194291, 19674.11466484008, 19678.11448484818, 19826.1078251479, 5740.7129643517765, 5797.797077102302, 5886.323072846634, 5911.142884281798, 5958.2125362391325, 5837.795677151301, 5839.941600583982, 5902.2622172228475, 5912.911306330387, 5923.318818335882, 5763.0, 5860.531157507389, 5891.381404952483, 5910.0, 5924.88150236995, 5604.859878503029, 5817.534597232232, 5826.504747096502, 5849.795257165979, 5852.385499522553, 5218.947810521884, 5262.578993680497, 5292.761825717814, 5296.443873393277, 5301.602379821529, 12643.557475488406, 13442.395092220873, 13600.863991360058, 13814.447422103103, 22759.20342788011, 2270.3642979965634, 2352.447174913894, 2526.343150780792, 2580.8967641294325, 2636.1827833371717, 10166.440845753481, 10282.126019288295, 10892.183086268482, 11774.587889423914, 14583.489577864724, 1942.8639995200342, 2002.699595060738, 2041.5202427429542, 2075.284027010679, 2085.2076211039707, 85029.14970850336, 87980.56009719975, 88188.0, 89043.55478222632, 89913.0, 10787.838182427113, 10832.837507437394, 11116.38859862699, 11269.154813389028, 11295.209335346446, 15872.0, 15896.12571308566, 16015.919920400323, 16046.117463539618, 16055.277512511964, 7976.604094283477, 8117.472364296302, 8153.073256770263, 8270.8345833083, 8350.457220280663, 7698.730544430918, 7940.285374316224, 7987.800304992422, 8041.437099402986, 8193.139720329398, 4822.807087716452, 4826.662133650681, 4878.975415162856, 4887.975560122177, 4924.409070911442, 1949.9220031198877, 2020.9797902021085, 2023.5447024419389, 2032.5121970726918, 2035.3079952816113, 977.9559919803484, 1040.8022475729588, 1047.9161667066617, 1064.6965614799744, 1120.092724892823, 18988.335408260646, 19289.421317360502, 19332.323368682028, 19494.902525487283, 19921.60156796856, 1058.7194393485731, 1090.1660229924114, 1117.7205698575356, 1150.913681473893, 1160.9361485118231, 10831.350118992885, 10937.56249750001, 10983.890161098447, 11145.777084458428, 11155.498002589902, 445560.0, 446747.0, 487188.0, 489917.0, 494259.0, 74549.0, 87146.94985675471, 90930.0, 93974.0, 95814.52092739491, 1042.671558459083, 1071.1002757683427, 1083.8590983172137, 1084.810158222308, 1089.2919602258596, 17261.56846078808, 17415.651686965935, 17620.735688964418, 17793.822061779734, 17992.0, 40125.0, 40813.1837363257, 41442.0, 41669.0, 41930.0, 56864.14703779364, 58548.70725646344, 59078.40921590901, 59386.0, 59628.40371596228, 7561.6597253122645, 8714.346424018351, 8917.152870477294, 8936.687215947411, 8998.325125615474, 11641.243319184226, 13367.66580835448, 13468.86531134676, 13660.726785464434, 13940.442382305, 11782.587609433629, 11804.70488237801, 11996.76006479848, 12113.636590902288, 12166.148369614042, 11811.527538898692, 11818.76362472763, 11922.880771192524, 11963.76072478563, 12090.516379344728, 11956.222845515014, 12052.397380131133, 12059.69850753703, 12070.517179312728, 12439.067069969607, 7609.162992070978, 7881.724139655084, 8139.0, 8248.257656810916, 8315.625796839036, 11300.208985370946, 12157.75684486323, 12506.249625022529, 12511.56209532662, 12518.624441266777], "value": 9316.15028457463, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.309169327956, 1561.6017915431564, 1733.6012717075073, 1842.281510211018, 1856.0534127594922, 7455.329020388164, 8453.535055571941, 8455.492670439779, 9053.95473022634, 9063.773405664862, 8551.78620534487, 8775.868361974575, 8833.072527384613, 8885.777855553599, 8893.0, 2391.055533064443, 2409.3013026222375, 2413.070967677448, 2425.4300239443714, 2436.0377650827913, 2430.890609922558, 2432.5621388150125, 2468.7778099971, 2469.1234611712853, 2470.888810003545, 2427.7086749590076, 2433.3794882305074, 2449.7917676997386, 2460.237326428804, 2477.4549599088264, 2358.7641235876445, 2366.089055713554, 2372.2527403867725, 2373.8575685458927, 2385.6540801583674, 2306.3888069661552, 2347.119830063726, 2362.173239366225, 2369.4905595297096, 2378.143868207444, 8836.425632333878, 8967.955160224157, 8969.820603587892, 8971.147740964598, 8987.281017518648, 5413.350397952231, 5481.068218402881, 5540.445955404468, 5552.139418390156, 5553.9725150847225, 3543.7165026797793, 3556.2354093869944, 3587.7309201809967, 3623.547056617923, 3634.509341238925, 1088.0588291128197, 1127.520803658442, 1138.3283862521068, 1165.9766804663943, 1180.9409529523575, 12538.937305313506, 12602.0, 12608.11743177978, 12627.810582841264, 12650.987920966392, 4775.6418268629295, 4870.220764677634, 4901.705897646153, 4906.484819094015, 4975.5522003019905, 10479.423631700178, 10483.37099774016, 10506.632267870587, 10531.736706582244, 10580.894191058145, 5442.292501974718, 5520.227168196456, 5527.2538207342295, 5527.2538207342295, 5537.390887002426, 4276.2302785498905, 4954.8513544593, 5066.594672426197, 5094.2103973884105, 5117.437081920985, 4112.558436888154, 4113.958860411358, 4146.419501269825, 4162.146759914211, 4195.664346852244, 1327.6747196936813, 1331.7869140937403, 1334.5129027904939, 1339.4951440805755, 1347.42060913808, 961.4423634292094, 1040.953157107917, 1047.696168111239, 1053.942033188182, 1061.7451811565322, 6084.239470066242, 6111.0, 6243.781467648701, 6268.592541484789, 6373.3945275198785, 464.0, 469.27497017108647, 469.38276166840495, 471.21072204058066, 478.67689309715803, 4276.144771045803, 4377.015171586368, 4381.539938306496, 4389.780510974439, 4391.802368893344, 10838.349699018085, 11186.944065279622, 11420.31478111316, 11423.485943132579, 11476.655700329004, 11014.339139651647, 11265.098792096613, 11275.37985410794, 11296.435178241056, 11308.830367544493, 7602.50583712057, 7994.200579942076, 8425.620847061897, 8432.494050356998, 8452.1547845215, 5782.797602083907, 5929.970350148222, 5946.345901950868, 6274.905876411949, 6306.369363063657, 10167.796644067224, 10360.222983276133, 10504.212184086377, 10516.474176291307, 10528.157747380037, 10165.796684066425, 10381.480925953823, 10653.0, 10683.94658026705, 10689.30519516229, 7604.733834315773, 8149.755507334789, 8417.705380311905, 8510.48937063778, 8571.914280857112, 8807.251383632463, 8814.471131732116, 8829.470231786114, 8861.202491775513, 8871.822563548822, 7943.6822527100585, 7972.083210430875, 8074.192580741878, 8143.982002249719, 8173.632186551738, 7598.430117741081, 7774.378049756119, 7808.648610812414, 7868.881966770388, 7902.0, 6911.550749201487, 7380.926190738024, 7459.477836551389, 7475.962620186864, 7480.625968701652, 5399.217113518596, 5488.0, 5525.889482210253, 5571.415001424792, 5593.972030139823, 5173.0688476073165, 5298.443663415286, 5337.546308563816, 5479.863003424946, 5578.246936663499], "value": 4719.460912387502, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.6609824077681, 339.32474375991774, 340.9062507810353, 343.1952072390244, 345.66125197306656, 5572.247746554219, 5607.803726869561, 5610.270664813574, 5613.091548873383, 5632.718364081795, 5493.363185670881, 5513.7794488220425, 5529.364123125842, 5539.584531160169, 5551.861203469915, 4079.592040795919, 4132.855350062749, 4206.852760153395, 4255.425517555137, 4255.765932873691, 4228.344606585984, 4233.978830105845, 4292.377605247238, 4314.784260786963, 4320.675949303799, 4310.8145260053425, 4311.6335111515555, 4326.935095973563, 4337.132573485315, 4347.78261086946, 3990.04238982645, 4186.790660466964, 4194.203101410722, 4200.537940826506, 4301.204277208711, 3652.2330310634798, 3672.816359182057, 3687.944680829763, 3692.2061756722433, 3718.3307004739136, 5330.360356757214, 5338.839834804962, 5342.91985620216, 5397.595180361489, 5413.702246376448, 4594.701344412602, 4873.756312184377, 4878.243872199815, 4935.876603084916, 4937.506249375069, 5696.601237913348, 5751.338596061465, 5753.137029445575, 5757.193992841006, 5826.1843341931735, 4131.793410329472, 4135.56576559463, 4144.3990621359735, 4158.875233742962, 4169.374593810922, 5958.106284057383, 5996.550258730569, 6002.78990235344, 6024.246969128859, 6062.605930614496, 4179.373094035858, 4191.476065491814, 4204.66362690984, 4207.347861081537, 4207.368894665825, 4224.767637779952, 4232.576742325743, 4238.682098842537, 4264.402983582301, 4287.849925252601, 4586.747728874944, 4804.615630749532, 4832.420109586872, 4853.0, 4880.413865493729, 5809.622374545641, 5812.360640329561, 5812.7674893003805, 5887.0, 5894.440028197314, 1434.2398528779763, 1437.8849692024612, 1439.3379045638915, 1446.70342579773, 1449.463698431587, 916.2303664921365, 939.2157548447124, 967.874176357069, 972.6644307713827, 981.9656312029188, 5361.517463428232, 5381.0, 5397.919031214535, 5411.675299482044, 5424.864378390493, 5646.887062258732, 5675.0, 5721.485066344049, 5725.656460612377, 5750.338711048199, 5241.9516096780035, 5328.280682107943, 5354.223637572608, 5362.9888791703115, 5454.863628409322, 3019.969800302013, 3023.168628627145, 3029.0307101727235, 3063.4638938185726, 3078.7690923180853, 5856.0, 5903.793367232126, 5911.586188966817, 5942.554308426886, 5943.227380440515, 6103.633781973096, 6107.511399088063, 6107.816765497042, 6125.724342404603, 6162.168107305546, 6226.315105338409, 6232.220972378453, 6232.563720539519, 6252.280987686474, 6273.404026617464, 5686.891056243992, 6030.849228769316, 6033.698315084141, 6048.0, 6078.149059131813, 5924.851878703067, 5963.91054134197, 5964.0, 6030.427109424598, 6034.163942946808, 6148.661823599566, 6154.384386635751, 6230.968845155745, 6274.905876411766, 6310.337414571404, 4189.224993376235, 4207.431996680409, 4227.66178705709, 4231.238377092153, 4233.872983810491, 6035.215421995113, 6053.727582258897, 6059.757609695739, 6092.664903430354, 6100.359462256399, 5708.971455142698, 5836.270466191726, 5842.678652673973, 5865.090910908816, 5899.705014749159, 5788.7395067222915, 5844.736986835517, 5855.882882342244, 5864.413558644102, 5901.970490147522, 5454.372747133972, 5575.459583164638, 5758.2514273144225, 5758.481736643722, 5792.855178620568, 5781.768729250783, 5795.8551036224435, 5811.0, 5848.853778655568, 5856.506590819314, 5729.455701708331, 5761.337446193741, 5786.33457152416, 5821.592488525932, 5830.47525722687], "value": 4391.294841997475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.7405630198339, 841.8021764885254, 852.5737131434283, 862.4652715316505, 866.6923242249005, 13364.198148111109, 13388.732225355487, 13510.662233444169, 13841.100328478642, 14884.92557537212, 11190.776184476306, 12322.0, 12383.380830958438, 12499.875001249984, 12527.624171274854, 800.2837460472873, 827.3877330775213, 828.1470085811624, 829.999850180534, 830.3647709502236, 826.7726375246825, 830.3191383065888, 832.650286879509, 833.3250067445389, 833.4665813879122, 878.8066625342415, 882.9690960816373, 883.8364902493028, 885.5616469847403, 886.1492966751925, 878.3368556739684, 880.4937161132375, 880.8194320164351, 881.9647214111428, 884.7743825324566, 630.1209812311845, 632.3234139470768, 634.1407392982488, 634.9809505714836, 639.0510092512615, 13392.732145357135, 13415.530456433979, 13420.127691700009, 13436.328183590782, 13441.932790336083, 13188.274644894527, 13272.469101235938, 13368.131071480322, 13414.86585134146, 13457.12528685642, 11095.44522773866, 11236.831447528293, 11259.831102533468, 11679.0, 11761.470733817, 3799.4490798834013, 3805.4101614249835, 3854.3447613905705, 3886.106195575005, 3971.285168669638, 51639.48360516384, 51981.480185198045, 52510.47489525094, 52578.47421525736, 55141.0, 9916.900830991597, 10066.245031622657, 10165.0, 10232.744181395525, 10264.486775661187, 19558.0, 19641.705374419395, 19689.50776230577, 19690.40928772139, 19993.400197994084, 8136.0643525995265, 8325.750227493185, 8546.529940853312, 8741.213290803731, 8843.60203790831, 4716.127516409407, 4752.596029337545, 4798.928016079692, 4843.249296358999, 4911.87720306988, 3367.7642565020215, 3468.9479657805155, 3469.739769517246, 3472.7498100683733, 3481.9477707834403, 627.2911609880805, 630.4389093706604, 644.2011905237565, 647.3300134361008, 654.3914159831307, 702.3994484715495, 735.4006484715047, 737.3253473072186, 749.9775006749807, 764.8049747314399, 9312.674056407994, 9324.95337523308, 9333.533323333942, 9550.37922535033, 9722.368046076983, 668.5353679192914, 716.5915428205977, 728.5701436152696, 753.6947536247828, 809.5587904592012, 4373.497047839475, 4572.51988541205, 4696.8590942271785, 4703.835365762182, 4720.362751028567, 63158.36841631617, 66097.33902661008, 66376.6681166591, 66383.66808165929, 66490.0, 55278.17082743762, 57853.421465784806, 57876.421235787944, 57908.42091579115, 59030.0, 51078.0, 51603.0, 51898.0, 52255.73872130615, 52318.47681523212, 8353.916460835313, 8429.157084291766, 8595.65617375298, 8870.379073464796, 8886.333524985781, 31467.527987079753, 32996.50505242375, 33474.0, 34432.31135377228, 34438.311233774686, 40506.0, 42402.0, 46656.533434665216, 47529.86115624736, 47651.285230720874, 12356.752864942831, 12429.254244745343, 12494.625161245178, 12531.87468125307, 12586.811197831857, 13023.609291720884, 13072.206915382285, 13523.797143042666, 13996.37016334247, 14013.789793153315, 13145.60563183106, 13168.341582921008, 13226.470941162246, 13274.137181083199, 13420.194788312732, 12605.117641764988, 13452.192868427926, 13787.86212137906, 14508.202048887413, 14524.564263072125, 13388.531401400904, 13397.12918660284, 13610.523631672844, 13964.860351396355, 14237.857621423653, 10129.290949633454, 10349.793004140025, 10532.262741608014, 10901.291416057931, 11025.283356581796, 10347.896521034694, 10395.683453237229, 10879.1840611956, 10903.563857445613, 10921.563137474412], "value": 6821.954932660187, "unit": "score"}], "name": "dromaeo_css", "value": 7172.216352236004, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 105.0, 110.0, 111.0, 112.0, 104.0, 111.0, 110.0, 112.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 149.0, 212.0, 126.0, 152.0, 149.0, 126.0, 181.0, 126.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 163.0, 162.0, 162.0, 170.0, 164.0, 164.0, 162.0, 160.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 167.0, 77.0, 77.0, 77.0, 78.0, 160.0, 76.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 173.0, 92.0, 94.0, 91.0, 159.0, 91.0, 91.0, 149.0], "value": 112.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 148.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 64.0, 59.0, 57.0, 60.0, 58.0, 69.0, 107.0, 56.0, 56.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 59.0, 58.0, 58.0, 60.0, 60.0, 59.0, 60.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 80.0, 81.0, 80.0, 85.0, 80.0, 80.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 125.0, 125.0, 123.0, 138.0, 125.0, 129.0, 128.0, 194.0, 142.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 172.0, 171.0, 170.0, 169.0, 170.0, 170.0, 175.0, 173.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 65.0, 65.0, 65.0, 65.0, 71.0, 64.0, 64.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1565.0, "alertThreshold": 2.0}]} 07:29:34 INFO - Return code: 0 07:29:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:29:35 ERROR - # TBPL SUCCESS # 07:29:35 INFO - Running post-action listener: _resource_record_post_action 07:29:35 INFO - ##### 07:29:35 INFO - ##### Finished run-tests step (success) 07:29:35 INFO - ##### 07:29:35 INFO - Running post-run listener: _resource_record_post_run 07:29:36 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535621632; Read time: 8; Write time: 1260624 07:29:36 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 245071872; Read time: 0; Write time: 775096 07:29:36 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290549760; Read time: 8; Write time: 485528 07:29:36 INFO - Running post-run listener: _upload_blobber_files 07:29:36 INFO - Blob upload gear active. 07:29:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:29:36 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:36 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:36 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:36 INFO - (blobuploader) - INFO - Open directory for files ... 07:29:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:29:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:29:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:37 INFO - (blobuploader) - INFO - Done attempting. 07:29:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:29:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:29:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:38 INFO - (blobuploader) - INFO - Done attempting. 07:29:38 INFO - (blobuploader) - INFO - Iteration through files over. 07:29:38 INFO - Return code: 0 07:29:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:29:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:29:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9feac193fe9993c66c69b22920cbc023ce38fd5c81398763d3411a367a5a5d29270296428f6f1473abf0583745dcad15d8e386d29ddfc2e24fd542ca37898ccd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e15ebd2815a44ab7e488fa3a44ad4d51d70de4414d9df49612a18a37aa199ccae667220ca1e934064fce2ad809a58584141b2f7d447f23151f33a4b502010a95"} 07:29:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:29:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:29:38 INFO - Contents: 07:29:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9feac193fe9993c66c69b22920cbc023ce38fd5c81398763d3411a367a5a5d29270296428f6f1473abf0583745dcad15d8e386d29ddfc2e24fd542ca37898ccd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e15ebd2815a44ab7e488fa3a44ad4d51d70de4414d9df49612a18a37aa199ccae667220ca1e934064fce2ad809a58584141b2f7d447f23151f33a4b502010a95"} 07:29:38 INFO - Running post-run listener: copy_logs_to_upload_dir 07:29:38 INFO - Copying logs to upload dir... 07:29:38 INFO - mkdir: /builds/slave/test/build/upload/logs 07:29:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.973971 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-09 07:29:38.035793) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 07:29:38.039413) ========= 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=af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9feac193fe9993c66c69b22920cbc023ce38fd5c81398763d3411a367a5a5d29270296428f6f1473abf0583745dcad15d8e386d29ddfc2e24fd542ca37898ccd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e15ebd2815a44ab7e488fa3a44ad4d51d70de4414d9df49612a18a37aa199ccae667220ca1e934064fce2ad809a58584141b2f7d447f23151f33a4b502010a95"} build_url:https://queue.taskcluster.net/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011421 build_url: 'https://queue.taskcluster.net/v1/task/Dcgsn4kMSsGj5RXRx8KMTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9feac193fe9993c66c69b22920cbc023ce38fd5c81398763d3411a367a5a5d29270296428f6f1473abf0583745dcad15d8e386d29ddfc2e24fd542ca37898ccd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e15ebd2815a44ab7e488fa3a44ad4d51d70de4414d9df49612a18a37aa199ccae667220ca1e934064fce2ad809a58584141b2f7d447f23151f33a4b502010a95"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 07:29:38.064984) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:29:38.065306) ========= 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=af724c981e2a0f424dbabf99000001e7-1462802875.476848-423770988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:29:38.148289) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 07:29:38.148599) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 07:29:38.148900) ========= ========= Total master_lag: 0.17 =========