builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1473224734.15 results: success (0) buildid: 20160906190512 builduid: 5829d07410ef488194662e31981ec599 revision: 2374ab2d2b77a203efeef432a98f2b04c36f4749 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-06 22:05:34.153671) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-06 22:05:34.154160) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-06 22:05:34.154693) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-06 22:05:34.239344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 22:05:34.239651) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-06 22:05:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-09-06 22:05:34 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120434 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 22:05:34.377896) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 22:05:34.378248) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017945 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 22:05:34.428354) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 22:05:34.428759) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2374ab2d2b77a203efeef432a98f2b04c36f4749 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2374ab2d2b77a203efeef432a98f2b04c36f4749 --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=5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-06 22:05:34,907 truncating revision to first 12 chars 2016-09-06 22:05:34,907 Setting DEBUG logging. 2016-09-06 22:05:34,907 attempt 1/10 2016-09-06 22:05:34,907 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2374ab2d2b77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-06 22:05:35,224 unpacking tar archive at: mozilla-aurora-2374ab2d2b77/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647192 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 22:05:35.091386) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-06 22:05:35.091737) ========= script_repo_revision: 2374ab2d2b77a203efeef432a98f2b04c36f4749 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-06 22:05:35.092193) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-06 22:05:35.092532) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-06 22:05:35.103943) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-09-06 22:05:35.104335) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:05:35 INFO - MultiFileLogger online at 20160906 22:05:35 in /builds/slave/test 22:05:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 22:05:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:05:35 INFO - {'append_to_log': False, 22:05:35 INFO - 'base_work_dir': '/builds/slave/test', 22:05:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:05:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:05:35 INFO - 'branch': 'Mozilla-Aurora', 22:05:35 INFO - 'buildbot_json_path': 'buildprops.json', 22:05:35 INFO - 'config_files': ('talos/linux_config.py',), 22:05:35 INFO - 'default_actions': ('clobber', 22:05:35 INFO - 'read-buildbot-config', 22:05:35 INFO - 'download-and-extract', 22:05:35 INFO - 'populate-webroot', 22:05:35 INFO - 'create-virtualenv', 22:05:35 INFO - 'install', 22:05:35 INFO - 'run-tests'), 22:05:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:05:35 INFO - 'download_minidump_stackwalk': True, 22:05:35 INFO - 'download_symbols': 'ondemand', 22:05:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:05:35 INFO - 'tooltool.py': '/tools/tooltool.py', 22:05:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:05:35 INFO - '/tools/misc-python/virtualenv.py')}, 22:05:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:05:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:05:35 INFO - 'installer_path': 'installer.exe', 22:05:35 INFO - 'log_level': 'info', 22:05:35 INFO - 'log_name': 'talos', 22:05:35 INFO - 'log_to_console': True, 22:05:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:05:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:05:35 INFO - 'opt_config_files': (), 22:05:35 INFO - 'pip_index': False, 22:05:35 INFO - 'sps_profile': False, 22:05:35 INFO - 'sps_profile_interval': 0, 22:05:35 INFO - 'suite': 'dromaeojs-e10s', 22:05:35 INFO - 'system_bits': '32', 22:05:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:05:35 INFO - 'title': 'talos-linux64-ix-051', 22:05:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:05:35 INFO - 'use_talos_json': True, 22:05:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:05:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:05:35 INFO - 'work_dir': 'build'} 22:05:35 INFO - [mozharness: 2016-09-07 05:05:35.674723Z] Running clobber step. 22:05:35 INFO - Running pre-action listener: _resource_record_pre_action 22:05:35 INFO - Running main action method: clobber 22:05:35 INFO - rmtree: /builds/slave/test/build 22:05:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:05:36 INFO - Running post-action listener: _resource_record_post_action 22:05:36 INFO - [mozharness: 2016-09-07 05:05:36.642804Z] Finished clobber step (success) 22:05:36 INFO - [mozharness: 2016-09-07 05:05:36.642906Z] Running read-buildbot-config step. 22:05:36 INFO - Running pre-action listener: _resource_record_pre_action 22:05:36 INFO - Running main action method: read_buildbot_config 22:05:36 INFO - Using buildbot properties: 22:05:36 INFO - { 22:05:36 INFO - "project": "", 22:05:36 INFO - "product": "firefox", 22:05:36 INFO - "script_repo_revision": "production", 22:05:36 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 22:05:36 INFO - "repository": "", 22:05:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 22:05:36 INFO - "buildid": "20160906190512", 22:05:36 INFO - "pgo_build": "True", 22:05:36 INFO - "basedir": "/builds/slave/test", 22:05:36 INFO - "buildnumber": 487, 22:05:36 INFO - "slavename": "talos-linux64-ix-051", 22:05:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:05:36 INFO - "platform": "ubuntu64_hw", 22:05:36 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 22:05:36 INFO - "branch": "mozilla-aurora", 22:05:36 INFO - "repo_path": "releases/mozilla-aurora", 22:05:36 INFO - "revision": "2374ab2d2b77a203efeef432a98f2b04c36f4749", 22:05:36 INFO - "stage_platform": "linux64-pgo", 22:05:36 INFO - "builduid": "5829d07410ef488194662e31981ec599", 22:05:36 INFO - "slavebuilddir": "test" 22:05:36 INFO - } 22:05:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 22:05:36 INFO - Running post-action listener: _resource_record_post_action 22:05:36 INFO - [mozharness: 2016-09-07 05:05:36.645818Z] Finished read-buildbot-config step (success) 22:05:36 INFO - [mozharness: 2016-09-07 05:05:36.645907Z] Running download-and-extract step. 22:05:36 INFO - Running pre-action listener: _resource_record_pre_action 22:05:36 INFO - Running main action method: download_and_extract 22:05:36 INFO - mkdir: /builds/slave/test/build/tests 22:05:36 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')]} 22:05:36 INFO - https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:05:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 22:05:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 22:05:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 22:05:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:05:36 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 22:05:36 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:05:36 INFO - retry: Failed, sleeping 30 seconds before retrying 22:06:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 22:06:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 22:06:06 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:06:06 INFO - retry: Failed, sleeping 60 seconds before retrying 22:07:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 22:07:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 22:07:06 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:07:06 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 22:07:06 INFO - Caught exception: HTTP Error 404: Not Found 22:07:06 INFO - Caught exception: HTTP Error 404: Not Found 22:07:06 INFO - Caught exception: HTTP Error 404: Not Found 22:07:06 INFO - trying https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 22:07:06 INFO - Downloading https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 22:07:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:07:07 INFO - Downloaded 1361 bytes. 22:07:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 22:07:07 INFO - Using the following test package requirements: 22:07:07 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 22:07:07 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 22:07:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 22:07:07 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 22:07:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 22:07:07 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 22:07:07 INFO - u'jsshell-linux-x86_64.zip'], 22:07:07 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 22:07:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 22:07:07 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 22:07:07 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 22:07:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 22:07:07 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 22:07:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 22:07:07 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 22:07:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 22:07:07 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 22:07:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 22:07:07 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:07:07 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')]} 22:07:07 INFO - https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:07:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:07:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:07:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:07:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:07:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:07:07 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:07:07 INFO - retry: Failed, sleeping 30 seconds before retrying 22:07:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 22:07:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:07:37 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:07:37 INFO - retry: Failed, sleeping 60 seconds before retrying 22:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 22:08:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:08:37 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:08:37 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 22:08:37 INFO - Caught exception: HTTP Error 404: Not Found 22:08:37 INFO - Caught exception: HTTP Error 404: Not Found 22:08:37 INFO - Caught exception: HTTP Error 404: Not Found 22:08:37 INFO - trying https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:08:37 INFO - Downloading https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:08:38 INFO - Downloaded 21769663 bytes. 22:08:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:08:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:08:39 INFO - Return code: 0 22:08:39 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:08:39 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')]} 22:08:39 INFO - https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:08:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:08:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:08:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:08:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:08:39 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:08:39 INFO - retry: Failed, sleeping 30 seconds before retrying 22:09:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 22:09:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:09:09 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:09:09 INFO - retry: Failed, sleeping 60 seconds before retrying 22:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 22:10:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:10:09 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:10:09 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 22:10:09 INFO - Caught exception: HTTP Error 404: Not Found 22:10:09 INFO - Caught exception: HTTP Error 404: Not Found 22:10:09 INFO - Caught exception: HTTP Error 404: Not Found 22:10:09 INFO - trying https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:10:09 INFO - Downloading https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 22:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:10:10 INFO - Downloaded 21769663 bytes. 22:10:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:10:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:10:11 INFO - Return code: 0 22:10:11 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')]} 22:10:11 INFO - https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:10:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 22:10:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 22:10:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 22:10:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:10:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 22:10:11 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:10:11 INFO - retry: Failed, sleeping 30 seconds before retrying 22:10:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 22:10:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 22:10:41 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:10:41 INFO - retry: Failed, sleeping 60 seconds before retrying 22:11:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 22:11:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 22:11:41 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:11:41 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 22:11:41 INFO - Caught exception: HTTP Error 404: Not Found 22:11:41 INFO - Caught exception: HTTP Error 404: Not Found 22:11:41 INFO - Caught exception: HTTP Error 404: Not Found 22:11:41 INFO - trying https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 22:11:41 INFO - Downloading https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 22:11:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:11:42 INFO - Downloaded 14413740 bytes. 22:11:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:11:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:11:43 INFO - Return code: 0 22:11:43 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')]} 22:11:43 INFO - https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:11:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 22:11:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 22:11:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 22:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:11:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 22:11:43 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:11:43 INFO - retry: Failed, sleeping 30 seconds before retrying 22:12:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 22:12:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 22:12:13 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:12:13 INFO - retry: Failed, sleeping 60 seconds before retrying 22:13:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 22:13:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 22:13:13 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:13:13 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 22:13:13 INFO - Caught exception: HTTP Error 404: Not Found 22:13:13 INFO - Caught exception: HTTP Error 404: Not Found 22:13:13 INFO - Caught exception: HTTP Error 404: Not Found 22:13:13 INFO - trying https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 22:13:13 INFO - Downloading https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 22:13:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:13:14 INFO - Downloaded 63933934 bytes. 22:13:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 22:13:14 INFO - mkdir: /builds/slave/test/properties 22:13:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:13:14 INFO - Writing to file /builds/slave/test/properties/build_url 22:13:14 INFO - Contents: 22:13:14 INFO - build_url:https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 22:13:14 INFO - Running post-action listener: _resource_record_post_action 22:13:14 INFO - Running post-action listener: set_extra_try_arguments 22:13:14 INFO - [mozharness: 2016-09-07 05:13:14.950522Z] Finished download-and-extract step (success) 22:13:14 INFO - [mozharness: 2016-09-07 05:13:14.950758Z] Running populate-webroot step. 22:13:14 INFO - Running pre-action listener: _resource_record_pre_action 22:13:14 INFO - Running main action method: populate_webroot 22:13:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:13:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:13:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:13:14 INFO - '--tppagecycles', 22:13:14 INFO - '7'], 22:13:14 INFO - 'tests': ['tsvgm']}}, 22:13:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:13:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:13:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:13:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:13:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:13:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:13:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:14 INFO - 'talos_options': ['--disable-e10s'], 22:13:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:14 INFO - 'talos_options': ['--disable-e10s'], 22:13:14 INFO - 'tests': ['damp', 'tps']}, 22:13:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:14 INFO - 'tests': ['damp', 'tps']}, 22:13:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:13:14 INFO - 'tests': ['dromaeo_dom']}, 22:13:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:13:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:13:14 INFO - 'tests': ['basic_compositor_video']}, 22:13:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:13:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:13:14 INFO - 'tests': ['a11yr', 22:13:14 INFO - 'ts_paint', 22:13:14 INFO - 'tpaint', 22:13:14 INFO - 'sessionrestore', 22:13:14 INFO - 'sessionrestore_no_auto_restore', 22:13:14 INFO - 'tabpaint']}, 22:13:14 INFO - 'other-e10s': {'tests': ['a11yr', 22:13:14 INFO - 'ts_paint', 22:13:14 INFO - 'tpaint', 22:13:14 INFO - 'sessionrestore', 22:13:14 INFO - 'sessionrestore_no_auto_restore', 22:13:14 INFO - 'tabpaint']}, 22:13:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:13:14 INFO - 'ts_paint', 22:13:14 INFO - 'tpaint', 22:13:14 INFO - 'sessionrestore', 22:13:14 INFO - 'sessionrestore_no_auto_restore', 22:13:14 INFO - 'tabpaint']}, 22:13:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:13:14 INFO - 'ts_paint', 22:13:14 INFO - 'tpaint', 22:13:14 INFO - 'sessionrestore', 22:13:14 INFO - 'sessionrestore_no_auto_restore', 22:13:14 INFO - 'tabpaint']}, 22:13:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:13:14 INFO - 'tests': ['a11yr', 22:13:14 INFO - 'ts_paint', 22:13:14 INFO - 'tpaint', 22:13:14 INFO - 'sessionrestore', 22:13:14 INFO - 'sessionrestore_no_auto_restore', 22:13:14 INFO - 'tabpaint']}, 22:13:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:13:14 INFO - 'tests': ['a11yr', 22:13:14 INFO - 'ts_paint', 22:13:14 INFO - 'tpaint', 22:13:14 INFO - 'sessionrestore', 22:13:14 INFO - 'sessionrestore_no_auto_restore', 22:13:14 INFO - 'tabpaint']}, 22:13:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:13:14 INFO - 'tests': ['tsvgx', 22:13:14 INFO - 'tsvgr_opacity', 22:13:14 INFO - 'tart', 22:13:14 INFO - 'tscrollx', 22:13:14 INFO - 'cart']}, 22:13:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:13:14 INFO - 'tsvgr_opacity', 22:13:14 INFO - 'tart', 22:13:14 INFO - 'tscrollx', 22:13:14 INFO - 'cart']}, 22:13:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:14 INFO - 'talos_options': ['--disable-e10s'], 22:13:14 INFO - 'tests': ['tp5o']}, 22:13:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:14 INFO - 'tests': ['tp5o']}, 22:13:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:14 INFO - 'talos_options': ['--disable-e10s', 22:13:14 INFO - '--xperf_path', 22:13:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:14 INFO - 'tests': ['tp5n']}, 22:13:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:14 INFO - 'talos_options': ['--xperf_path', 22:13:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:14 INFO - 'tests': ['tp5n']}}, 22:13:14 INFO - 'talos.zip': {'path': '', 22:13:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:13:14 INFO - Running post-action listener: _resource_record_post_action 22:13:14 INFO - [mozharness: 2016-09-07 05:13:14.968042Z] Finished populate-webroot step (success) 22:13:14 INFO - [mozharness: 2016-09-07 05:13:14.968130Z] Running create-virtualenv step. 22:13:14 INFO - Running pre-action listener: _resource_record_pre_action 22:13:14 INFO - Running main action method: create_virtualenv 22:13:14 INFO - Creating virtualenv /builds/slave/test/build/venv 22:13:14 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 22:13:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:13:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:13:15 INFO - Using real prefix '/usr' 22:13:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:13:15 INFO - Installing distribute.............................................................................................................................................................................................done. 22:13:17 INFO - Installing pip.................done. 22:13:17 INFO - Return code: 0 22:13:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:13:17 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')]} 22:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:17 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')]} 22:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:17 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 0x10f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1328400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b7570>, '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 0x13b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b8900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', '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 22:13:17 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 22:13:17 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 22:13:17 INFO - Using env: {'DISPLAY': ':0', 22:13:17 INFO - 'HOME': '/home/cltbld', 22:13:17 INFO - 'LANG': 'en_US.UTF-8', 22:13:17 INFO - 'LANGUAGE': 'en_US:en', 22:13:17 INFO - 'LOGNAME': 'cltbld', 22:13:17 INFO - 'MAIL': '/var/mail/cltbld', 22:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:17 INFO - 'MOZ_NO_REMOTE': '1', 22:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:17 INFO - 'NO_EM_RESTART': '1', 22:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:17 INFO - 'PWD': '/builds/slave/test', 22:13:17 INFO - 'SHELL': '/bin/bash', 22:13:17 INFO - 'SHLVL': '1', 22:13:17 INFO - 'TERM': 'linux', 22:13:17 INFO - 'TMOUT': '86400', 22:13:17 INFO - 'USER': 'cltbld', 22:13:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', 22:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:17 INFO - '_': '/tools/buildbot/bin/python'} 22:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:17 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 22:13:17 INFO - Cleaning up... 22:13:17 INFO - Return code: 0 22:13:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:13:17 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')]} 22:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:17 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')]} 22:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:17 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1328400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b7570>, '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 0x13b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b8900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', '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 22:13:17 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>=3.1.1'] in /builds/slave/test/build 22:13:17 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>=3.1.1 22:13:17 INFO - Using env: {'DISPLAY': ':0', 22:13:17 INFO - 'HOME': '/home/cltbld', 22:13:17 INFO - 'LANG': 'en_US.UTF-8', 22:13:17 INFO - 'LANGUAGE': 'en_US:en', 22:13:17 INFO - 'LOGNAME': 'cltbld', 22:13:17 INFO - 'MAIL': '/var/mail/cltbld', 22:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:17 INFO - 'MOZ_NO_REMOTE': '1', 22:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:17 INFO - 'NO_EM_RESTART': '1', 22:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:17 INFO - 'PWD': '/builds/slave/test', 22:13:17 INFO - 'SHELL': '/bin/bash', 22:13:17 INFO - 'SHLVL': '1', 22:13:17 INFO - 'TERM': 'linux', 22:13:17 INFO - 'TMOUT': '86400', 22:13:17 INFO - 'USER': 'cltbld', 22:13:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', 22:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:17 INFO - '_': '/tools/buildbot/bin/python'} 22:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:17 INFO - Downloading/unpacking psutil>=3.1.1 22:13:17 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 22:13:17 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 22:13:17 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 22:13:17 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 22:13:17 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 22:13:17 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 22:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:13:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:19 INFO - Installing collected packages: psutil 22:13:19 INFO - Running setup.py install for psutil 22:13:20 INFO - building 'psutil._psutil_linux' extension 22:13:20 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 22:13:20 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 22:13:20 INFO - building 'psutil._psutil_posix' extension 22:13:20 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 22:13:20 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 22:13:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:20 INFO - Successfully installed psutil 22:13:20 INFO - Cleaning up... 22:13:20 INFO - Return code: 0 22:13:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:13:20 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')]} 22:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:20 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')]} 22:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:20 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1328400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b7570>, '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 0x13b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b8900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', '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 22:13:20 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.3'] in /builds/slave/test/build 22:13:20 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.3 22:13:20 INFO - Using env: {'DISPLAY': ':0', 22:13:20 INFO - 'HOME': '/home/cltbld', 22:13:20 INFO - 'LANG': 'en_US.UTF-8', 22:13:20 INFO - 'LANGUAGE': 'en_US:en', 22:13:20 INFO - 'LOGNAME': 'cltbld', 22:13:20 INFO - 'MAIL': '/var/mail/cltbld', 22:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:20 INFO - 'MOZ_NO_REMOTE': '1', 22:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:20 INFO - 'NO_EM_RESTART': '1', 22:13:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:20 INFO - 'PWD': '/builds/slave/test', 22:13:20 INFO - 'SHELL': '/bin/bash', 22:13:20 INFO - 'SHLVL': '1', 22:13:20 INFO - 'TERM': 'linux', 22:13:20 INFO - 'TMOUT': '86400', 22:13:20 INFO - 'USER': 'cltbld', 22:13:20 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', 22:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:20 INFO - '_': '/tools/buildbot/bin/python'} 22:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:13:20 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 22:13:20 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 22:13:20 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 22:13:20 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 22:13:20 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 22:13:20 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 22:13:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:13:22 INFO - Installing collected packages: mozsystemmonitor 22:13:22 INFO - Running setup.py install for mozsystemmonitor 22:13:22 INFO - Successfully installed mozsystemmonitor 22:13:22 INFO - Cleaning up... 22:13:22 INFO - Return code: 0 22:13:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:13:22 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')]} 22:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:22 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')]} 22:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:22 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1328400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b7570>, '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 0x13b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b8900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', '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 22:13:22 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==2.5.1'] in /builds/slave/test/build 22:13:22 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==2.5.1 22:13:22 INFO - Using env: {'DISPLAY': ':0', 22:13:22 INFO - 'HOME': '/home/cltbld', 22:13:22 INFO - 'LANG': 'en_US.UTF-8', 22:13:22 INFO - 'LANGUAGE': 'en_US:en', 22:13:22 INFO - 'LOGNAME': 'cltbld', 22:13:22 INFO - 'MAIL': '/var/mail/cltbld', 22:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:22 INFO - 'MOZ_NO_REMOTE': '1', 22:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:22 INFO - 'NO_EM_RESTART': '1', 22:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:22 INFO - 'PWD': '/builds/slave/test', 22:13:22 INFO - 'SHELL': '/bin/bash', 22:13:22 INFO - 'SHLVL': '1', 22:13:22 INFO - 'TERM': 'linux', 22:13:22 INFO - 'TMOUT': '86400', 22:13:22 INFO - 'USER': 'cltbld', 22:13:22 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', 22:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:22 INFO - '_': '/tools/buildbot/bin/python'} 22:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:22 INFO - Downloading/unpacking jsonschema==2.5.1 22:13:22 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 22:13:22 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 22:13:22 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 22:13:22 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 22:13:22 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 22:13:22 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 22:13:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:13:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:13: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 22:13: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 22:13: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 22:13: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 22:13: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 22:13: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 22:13:25 INFO - Downloading functools32-3.2.3-2.tar.gz 22:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:13:25 INFO - warning: no files found matching '*.txt' 22:13:25 INFO - no previously-included directories found matching 'build' 22:13:25 INFO - no previously-included directories found matching 'dist' 22:13:25 INFO - no previously-included directories found matching '.git*' 22:13:25 INFO - Installing collected packages: jsonschema, functools32 22:13:25 INFO - Running setup.py install for functools32 22:13:25 INFO - warning: no files found matching '*.txt' 22:13:25 INFO - no previously-included directories found matching 'build' 22:13:25 INFO - no previously-included directories found matching 'dist' 22:13:25 INFO - no previously-included directories found matching '.git*' 22:13:25 INFO - Successfully installed jsonschema functools32 22:13:25 INFO - Cleaning up... 22:13:25 INFO - Return code: 0 22:13:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:13:25 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')]} 22:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:25 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')]} 22:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:25 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1328400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b7570>, '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 0x13b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b8900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', '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 22:13:25 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:13:25 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 functools32==3.2.3-2 22:13:25 INFO - Using env: {'DISPLAY': ':0', 22:13:25 INFO - 'HOME': '/home/cltbld', 22:13:25 INFO - 'LANG': 'en_US.UTF-8', 22:13:25 INFO - 'LANGUAGE': 'en_US:en', 22:13:25 INFO - 'LOGNAME': 'cltbld', 22:13:25 INFO - 'MAIL': '/var/mail/cltbld', 22:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:25 INFO - 'MOZ_NO_REMOTE': '1', 22:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:25 INFO - 'NO_EM_RESTART': '1', 22:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:25 INFO - 'PWD': '/builds/slave/test', 22:13:25 INFO - 'SHELL': '/bin/bash', 22:13:25 INFO - 'SHLVL': '1', 22:13:25 INFO - 'TERM': 'linux', 22:13:25 INFO - 'TMOUT': '86400', 22:13:25 INFO - 'USER': 'cltbld', 22:13:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', 22:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:25 INFO - '_': '/tools/buildbot/bin/python'} 22:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:13:25 INFO - Cleaning up... 22:13:25 INFO - Return code: 0 22:13:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:13:25 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')]} 22:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:25 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')]} 22:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:25 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 0x10f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1328400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b7570>, '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 0x13b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b8900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', '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 22:13:25 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 22:13:25 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 22:13:25 INFO - Using env: {'DISPLAY': ':0', 22:13:25 INFO - 'HOME': '/home/cltbld', 22:13:25 INFO - 'LANG': 'en_US.UTF-8', 22:13:25 INFO - 'LANGUAGE': 'en_US:en', 22:13:25 INFO - 'LOGNAME': 'cltbld', 22:13:25 INFO - 'MAIL': '/var/mail/cltbld', 22:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:25 INFO - 'MOZ_NO_REMOTE': '1', 22:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:25 INFO - 'NO_EM_RESTART': '1', 22:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:25 INFO - 'PWD': '/builds/slave/test', 22:13:25 INFO - 'SHELL': '/bin/bash', 22:13:25 INFO - 'SHLVL': '1', 22:13:25 INFO - 'TERM': 'linux', 22:13:25 INFO - 'TMOUT': '86400', 22:13:25 INFO - 'USER': 'cltbld', 22:13:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', 22:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:25 INFO - '_': '/tools/buildbot/bin/python'} 22:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:25 INFO - Downloading/unpacking blobuploader==1.2.4 22:13:25 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 22:13:25 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 22:13:25 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 22:13:25 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 22:13:25 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 22:13:25 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 22:13:27 INFO - Downloading blobuploader-1.2.4.tar.gz 22:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:13:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:13:27 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 22:13:27 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 22:13:27 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 22:13:27 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 22:13:27 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 22:13:27 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 22:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:13:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:13:28 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 22:13:28 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 22:13:28 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 22:13:28 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 22:13:28 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 22:13:28 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 22:13:28 INFO - Downloading docopt-0.6.1.tar.gz 22:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:13:28 INFO - Installing collected packages: blobuploader, requests, docopt 22:13:28 INFO - Running setup.py install for blobuploader 22:13:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:13:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:13:28 INFO - Running setup.py install for requests 22:13:28 INFO - Running setup.py install for docopt 22:13:28 INFO - Successfully installed blobuploader requests docopt 22:13:28 INFO - Cleaning up... 22:13:28 INFO - Return code: 0 22:13:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:28 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')]} 22:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:28 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')]} 22:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:28 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 0x10f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1328400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b7570>, '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 0x13b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b8900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', '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 22:13:28 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 22:13:28 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 22:13:28 INFO - Using env: {'DISPLAY': ':0', 22:13:28 INFO - 'HOME': '/home/cltbld', 22:13:28 INFO - 'LANG': 'en_US.UTF-8', 22:13:28 INFO - 'LANGUAGE': 'en_US:en', 22:13:28 INFO - 'LOGNAME': 'cltbld', 22:13:28 INFO - 'MAIL': '/var/mail/cltbld', 22:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:28 INFO - 'MOZ_NO_REMOTE': '1', 22:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:28 INFO - 'NO_EM_RESTART': '1', 22:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:28 INFO - 'PWD': '/builds/slave/test', 22:13:28 INFO - 'SHELL': '/bin/bash', 22:13:28 INFO - 'SHLVL': '1', 22:13:28 INFO - 'TERM': 'linux', 22:13:28 INFO - 'TMOUT': '86400', 22:13:28 INFO - 'USER': 'cltbld', 22:13:28 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', 22:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:28 INFO - '_': '/tools/buildbot/bin/python'} 22:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:29 INFO - Running setup.py (path:/tmp/pip-HrQ2ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:29 INFO - Running setup.py (path:/tmp/pip-GfP9bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:13:29 INFO - Running setup.py (path:/tmp/pip-GEHbuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:13:29 INFO - Running setup.py (path:/tmp/pip-eW20yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:13:29 INFO - Running setup.py (path:/tmp/pip-irDnEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:13:29 INFO - Running setup.py (path:/tmp/pip-UfSbKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:13:29 INFO - Running setup.py (path:/tmp/pip-lGQDlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:13:29 INFO - Running setup.py (path:/tmp/pip-baYqDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:13:29 INFO - Running setup.py (path:/tmp/pip-MsDFjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:13:29 INFO - Running setup.py (path:/tmp/pip-3fiT5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:29 INFO - Running setup.py (path:/tmp/pip-da3qcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:29 INFO - Running setup.py (path:/tmp/pip-kDTx9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:30 INFO - Running setup.py (path:/tmp/pip-sPbgA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:30 INFO - Running setup.py (path:/tmp/pip-rfdmPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:30 INFO - Running setup.py (path:/tmp/pip-aJMrbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:30 INFO - Running setup.py (path:/tmp/pip-Gp_nWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:30 INFO - Running setup.py (path:/tmp/pip-zTkSlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:13:30 INFO - Running setup.py install for manifestparser 22:13:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:13:30 INFO - Running setup.py install for mozcrash 22:13:30 INFO - Running setup.py install for mozdebug 22:13:30 INFO - Running setup.py install for mozdevice 22:13:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:13:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:13:30 INFO - Running setup.py install for mozfile 22:13:30 INFO - Running setup.py install for mozhttpd 22:13:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:13:31 INFO - Running setup.py install for mozinfo 22:13:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:13:31 INFO - Running setup.py install for mozInstall 22:13:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:13:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:13:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:13:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:13:31 INFO - Running setup.py install for mozleak 22:13:31 INFO - Running setup.py install for mozlog 22:13:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:13:31 INFO - Running setup.py install for moznetwork 22:13:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:13:31 INFO - Running setup.py install for mozprocess 22:13:31 INFO - Running setup.py install for mozprofile 22:13:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:13:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:13:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:13:31 INFO - Running setup.py install for mozrunner 22:13:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:13:31 INFO - Running setup.py install for mozscreenshot 22:13:31 INFO - Running setup.py install for moztest 22:13:32 INFO - Running setup.py install for mozversion 22:13:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:13:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:13:32 INFO - Cleaning up... 22:13:32 INFO - Return code: 0 22:13:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:32 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')]} 22:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:32 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')]} 22:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:32 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 0x10f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1328400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b7570>, '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 0x13b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b8900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', '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 22:13:32 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 22:13:32 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 22:13:32 INFO - Using env: {'DISPLAY': ':0', 22:13:32 INFO - 'HOME': '/home/cltbld', 22:13:32 INFO - 'LANG': 'en_US.UTF-8', 22:13:32 INFO - 'LANGUAGE': 'en_US:en', 22:13:32 INFO - 'LOGNAME': 'cltbld', 22:13:32 INFO - 'MAIL': '/var/mail/cltbld', 22:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:32 INFO - 'MOZ_NO_REMOTE': '1', 22:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:32 INFO - 'NO_EM_RESTART': '1', 22:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:32 INFO - 'PWD': '/builds/slave/test', 22:13:32 INFO - 'SHELL': '/bin/bash', 22:13:32 INFO - 'SHLVL': '1', 22:13:32 INFO - 'TERM': 'linux', 22:13:32 INFO - 'TMOUT': '86400', 22:13:32 INFO - 'USER': 'cltbld', 22:13:32 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', 22:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:32 INFO - '_': '/tools/buildbot/bin/python'} 22:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:32 INFO - Running setup.py (path:/tmp/pip-ef8b8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:32 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)) 22:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:32 INFO - Running setup.py (path:/tmp/pip-J2iovZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:13:32 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)) 22:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:13:32 INFO - Running setup.py (path:/tmp/pip-XgZxki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:13:32 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)) 22:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:13:32 INFO - Running setup.py (path:/tmp/pip-Gh9oAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:13:32 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)) 22:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:13:32 INFO - Running setup.py (path:/tmp/pip-OMfCyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:13:32 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)) 22:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:13:32 INFO - Running setup.py (path:/tmp/pip-JrgwqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:13:32 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)) 22:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:13:32 INFO - Running setup.py (path:/tmp/pip-zULHfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:13:32 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)) 22:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:13:32 INFO - Running setup.py (path:/tmp/pip-4FbHyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:13:33 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)) 22:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:13:33 INFO - Running setup.py (path:/tmp/pip-Um2Kiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:13:33 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)) 22:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:13:33 INFO - Running setup.py (path:/tmp/pip-hQTMmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 22:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:33 INFO - Running setup.py (path:/tmp/pip-hwll7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:33 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)) 22:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:33 INFO - Running setup.py (path:/tmp/pip-tsSt9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 22:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:33 INFO - Running setup.py (path:/tmp/pip-hLDSkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:33 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)) 22:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:33 INFO - Running setup.py (path:/tmp/pip-QI8ru8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 22:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:33 INFO - Running setup.py (path:/tmp/pip-o85tO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:33 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)) 22:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:33 INFO - Running setup.py (path:/tmp/pip-xnYe5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:33 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)) 22:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:33 INFO - Running setup.py (path:/tmp/pip-BJsL8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:33 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)) 22:13:33 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)) 22:13:33 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)) 22:13:33 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)) 22:13:33 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)) 22:13:33 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)) 22:13:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:13:33 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 22:13:33 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 22:13:33 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 22:13:33 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 22:13:33 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 22:13:33 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 22:13:35 INFO - Downloading blessings-1.6.tar.gz 22:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:13:35 INFO - Installing collected packages: blessings 22:13:35 INFO - Running setup.py install for blessings 22:13:35 INFO - Successfully installed blessings 22:13:35 INFO - Cleaning up... 22:13:35 INFO - Return code: 0 22:13:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:13:35 INFO - Reading from file tmpfile_stdout 22:13:36 INFO - Current package versions: 22:13:36 INFO - argparse == 1.2.1 22:13:36 INFO - blessings == 1.6 22:13:36 INFO - blobuploader == 1.2.4 22:13:36 INFO - docopt == 0.6.1 22:13:36 INFO - functools32 == 3.2.3-2 22:13:36 INFO - jsonschema == 2.5.1 22:13:36 INFO - manifestparser == 1.1 22:13:36 INFO - mozInstall == 1.12 22:13:36 INFO - mozcrash == 0.17 22:13:36 INFO - mozdebug == 0.1 22:13:36 INFO - mozdevice == 0.48 22:13:36 INFO - mozfile == 1.2 22:13:36 INFO - mozhttpd == 0.7 22:13:36 INFO - mozinfo == 0.9 22:13:36 INFO - mozleak == 0.1 22:13:36 INFO - mozlog == 3.3 22:13:36 INFO - moznetwork == 0.27 22:13:36 INFO - mozprocess == 0.23 22:13:36 INFO - mozprofile == 0.28 22:13:36 INFO - mozrunner == 6.12 22:13:36 INFO - mozscreenshot == 0.1 22:13:36 INFO - mozsystemmonitor == 0.3 22:13:36 INFO - moztest == 0.7 22:13:36 INFO - mozversion == 1.4 22:13:36 INFO - psutil == 3.1.1 22:13:36 INFO - requests == 1.2.3 22:13:36 INFO - wsgiref == 0.1.2 22:13:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:36 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')]} 22:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:36 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')]} 22:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:36 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 0x10f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1328400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b7570>, '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 0x13b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b8900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', '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 22:13:36 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 22:13:36 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 22:13:36 INFO - Using env: {'DISPLAY': ':0', 22:13:36 INFO - 'HOME': '/home/cltbld', 22:13:36 INFO - 'LANG': 'en_US.UTF-8', 22:13:36 INFO - 'LANGUAGE': 'en_US:en', 22:13:36 INFO - 'LOGNAME': 'cltbld', 22:13:36 INFO - 'MAIL': '/var/mail/cltbld', 22:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:36 INFO - 'MOZ_NO_REMOTE': '1', 22:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:36 INFO - 'NO_EM_RESTART': '1', 22:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:36 INFO - 'PWD': '/builds/slave/test', 22:13:36 INFO - 'SHELL': '/bin/bash', 22:13:36 INFO - 'SHLVL': '1', 22:13:36 INFO - 'TERM': 'linux', 22:13:36 INFO - 'TMOUT': '86400', 22:13:36 INFO - 'USER': 'cltbld', 22:13:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', 22:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:36 INFO - '_': '/tools/buildbot/bin/python'} 22:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:36 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)) 22:13:36 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)) 22:13:36 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)) 22:13:36 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)) 22:13:36 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)) 22:13:36 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)) 22:13:36 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)) 22:13:36 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)) 22:13:36 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)) 22:13:36 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)) 22:13:36 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)) 22:13:36 INFO - Cleaning up... 22:13:36 INFO - Return code: 0 22:13:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:13:36 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')]} 22:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:36 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')]} 22:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:36 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 0x10f9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1328400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b7570>, '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 0x13b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b8900>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', '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 22:13:36 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 22:13:36 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 22:13:36 INFO - Using env: {'DISPLAY': ':0', 22:13:36 INFO - 'HOME': '/home/cltbld', 22:13:36 INFO - 'LANG': 'en_US.UTF-8', 22:13:36 INFO - 'LANGUAGE': 'en_US:en', 22:13:36 INFO - 'LOGNAME': 'cltbld', 22:13:36 INFO - 'MAIL': '/var/mail/cltbld', 22:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:36 INFO - 'MOZ_NO_REMOTE': '1', 22:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:36 INFO - 'NO_EM_RESTART': '1', 22:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:36 INFO - 'PWD': '/builds/slave/test', 22:13:36 INFO - 'SHELL': '/bin/bash', 22:13:36 INFO - 'SHLVL': '1', 22:13:36 INFO - 'TERM': 'linux', 22:13:36 INFO - 'TMOUT': '86400', 22:13:36 INFO - 'USER': 'cltbld', 22:13:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', 22:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:36 INFO - '_': '/tools/buildbot/bin/python'} 22:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:13:36 INFO - Cleaning up... 22:13:36 INFO - Return code: 0 22:13:36 INFO - Running post-action listener: _resource_record_post_action 22:13:36 INFO - Running post-action listener: _start_resource_monitoring 22:13:36 INFO - Starting resource monitoring. 22:13:36 INFO - [mozharness: 2016-09-07 05:13:36.474401Z] Finished create-virtualenv step (success) 22:13:36 INFO - [mozharness: 2016-09-07 05:13:36.474837Z] Running install step. 22:13:36 INFO - Running pre-action listener: _resource_record_pre_action 22:13:36 INFO - Running main action method: install 22:13:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:13:36 INFO - Reading from file tmpfile_stdout 22:13:36 INFO - Detecting whether we're running mozinstall >=1.0... 22:13:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:13:36 INFO - Reading from file tmpfile_stdout 22:13:36 INFO - Output received: 22:13:36 INFO - Usage: mozinstall [options] installer 22:13:36 INFO - Options: 22:13:36 INFO - -h, --help show this help message and exit 22:13:36 INFO - -d DEST, --destination=DEST 22:13:36 INFO - Directory to install application into. [default: 22:13:36 INFO - "/builds/slave/test"] 22:13:36 INFO - --app=APP Application being installed. [default: firefox] 22:13:36 INFO - mkdir: /builds/slave/test/build/application 22:13:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:13:52 INFO - Reading from file tmpfile_stdout 22:13:52 INFO - Output received: 22:13:52 INFO - /builds/slave/test/build/application/firefox/firefox 22:13:52 INFO - Running post-action listener: _resource_record_post_action 22:13:52 INFO - [mozharness: 2016-09-07 05:13:52.798197Z] Finished install step (success) 22:13:52 INFO - [mozharness: 2016-09-07 05:13:52.798542Z] Running run-tests step. 22:13:52 INFO - Running pre-action listener: _resource_record_pre_action 22:13:52 INFO - Running main action method: run_tests 22:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:13:52 INFO - Python 2.7.3 22:13:52 INFO - Return code: 0 22:13:52 INFO - grabbing minidump binary from tooltool 22:13:52 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')]} 22:13:52 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b7570>, '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 0x13b8470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b8900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:13:52 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 22:13:52 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 22:13:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:13:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:13:52 INFO - Return code: 0 22:13:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:13:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:13:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:13:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:13:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 22:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 22:13:52 INFO - Using env: {'DISPLAY': ':0', 22:13:52 INFO - 'HOME': '/home/cltbld', 22:13:52 INFO - 'LANG': 'en_US.UTF-8', 22:13:52 INFO - 'LANGUAGE': 'en_US:en', 22:13:52 INFO - 'LOGNAME': 'cltbld', 22:13:52 INFO - 'MAIL': '/var/mail/cltbld', 22:13:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:13:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:52 INFO - 'MOZ_NO_REMOTE': '1', 22:13:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:52 INFO - 'NO_EM_RESTART': '1', 22:13:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:52 INFO - 'PWD': '/builds/slave/test', 22:13:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:13:52 INFO - 'SHELL': '/bin/bash', 22:13:52 INFO - 'SHLVL': '1', 22:13:52 INFO - 'TERM': 'linux', 22:13:52 INFO - 'TMOUT': '86400', 22:13:52 INFO - 'USER': 'cltbld', 22:13:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508', 22:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:52 INFO - '_': '/tools/buildbot/bin/python'} 22:13:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 22:13:53 INFO - mozversion application_buildid: 20160906190512 22:13:53 INFO - mozversion application_changeset: 2374ab2d2b77a203efeef432a98f2b04c36f4749 22:13:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:13:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:13:53 INFO - mozversion application_name: Firefox 22:13:53 INFO - mozversion application_remotingname: firefox-dev 22:13:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:13:53 INFO - mozversion application_vendor: Mozilla 22:13:53 INFO - mozversion application_version: 50.0a2 22:13:53 INFO - mozversion platform_buildid: 20160906190512 22:13:53 INFO - mozversion platform_changeset: 2374ab2d2b77a203efeef432a98f2b04c36f4749 22:13:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:13:53 INFO - mozversion platform_version: 50.0a2 22:13:53 INFO - using testdate: 1473225233 22:13:53 INFO - actual date: 1473225233 22:13:53 INFO - starting webserver on 'localhost:52475' 22:13:53 INFO - SUITE-START | Running 2 tests 22:13:53 INFO - TEST-START | dromaeo_css 22:13:53 INFO - operating with platform_type : linux_ 22:13:53 INFO - Initialising browser for dromaeo_css test... 22:13:53 INFO - TEST-INFO | started process 8800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHu_cII/profile http://localhost:52475/getInfo.html) 22:13:57 INFO - PROCESS | 8800 | __metrics Screen width/height:1600/1200 22:13:57 INFO - PROCESS | 8800 | colorDepth:24 22:13:57 INFO - PROCESS | 8800 | Browser inner width/height: 1024/697 22:13:57 INFO - PROCESS | 8800 | __metrics 22:13:58 ERROR - PROCESS | 8800 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:13:59 INFO - TEST-INFO | 8800: exit 0 22:13:59 INFO - Browser initialized. 22:13:59 INFO - Running cycle 1/1 for dromaeo_css test... 22:13:59 INFO - TEST-INFO | started process 8924 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHu_cII/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:10 INFO - PROCESS | 8924 | RSS: Main: 152645632 22:14:10 INFO - PROCESS | 8924 | 22:15:00 INFO - PROCESS | 8924 | 1473225300356 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] 22:17:08 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:52475/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52475/tests/dromaeo/cssquery-ext.html) 22:17:10 INFO - PROCESS | 8924 | RSS: Main: 158154752 22:17:10 INFO - PROCESS | 8924 | 22:20:12 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:52475/tests/dromaeo/cssquery-ext.html (next: http://localhost:52475/tests/dromaeo/cssquery-jquery.html) 22:20:12 INFO - PROCESS | 8924 | RSS: Main: 154476544 22:20:12 INFO - PROCESS | 8924 | 22:23:14 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:52475/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52475/tests/dromaeo/cssquery-mootools.html) 22:23:15 INFO - PROCESS | 8924 | RSS: Main: 154759168 22:23:15 INFO - PROCESS | 8924 | 22:26:16 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:52475/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52475/tests/dromaeo/cssquery-prototype.html) 22:26:17 INFO - PROCESS | 8924 | RSS: Main: 153407488 22:26:17 INFO - PROCESS | 8924 | 22:29:20 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:52475/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52475/tests/dromaeo/cssquery-yui.html) 22:29:20 INFO - PROCESS | 8924 | RSS: Main: 155959296 22:29:20 INFO - PROCESS | 8924 | 22:32:23 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:52475/tests/dromaeo/cssquery-yui.html (next: http://localhost:52475/tests/dromaeo/cssquery-dojo.html) 22:32:23 INFO - PROCESS | 8924 | RSS: Main: 156254208 22:32:23 INFO - PROCESS | 8924 | 22:32:23 INFO - PROCESS | 8924 | __start_tp_report 22:32:23 INFO - PROCESS | 8924 | _x_x_mozilla_page_load 22:32:23 INFO - PROCESS | 8924 | _x_x_mozilla_page_load_details 22:32:23 INFO - PROCESS | 8924 | |i|pagename|runs| 22:32:23 INFO - PROCESS | 8924 | |0;dojo.html;3292.2098696312883;3309.098524967837;3311.0728995881163;3325.1188435064696;3335.983320083399;5690.089585666295;5733.54131669466;5748.367679555246;5785.334686511058;5786.276715410574;5833.066709326508;5879;5916.911246331309;5920.141579470974;5946.078357854529;5333.333333333324;5355.758990845421;5393.7033463159705;5400;5453.672779633234;5252.474752524755;5258.106121959276;5262.789488420478;5270.499302566269;5303.681779093247;5284.682919024871;5338.599605029619;5345.973270133644;5373.596980226499;5404.972975135119;5388.191771234307;5395.10980688186;5404;5405;5414.593905457106;5033.949660503385;5084.694918304914;5192;5305.1776974569;5416.133418653036;5662.405447428002;5732.856678583069;5743.54051675865;5746.195532625436;5768.653880767126;6117.6023558469005;6132.662703551303;6144.754209831646;6184.257889053298;6243.032329988859;6084.665343406111;6135.5398345124295;6240.126382306481;6242.500599951993;6280.120783090371;5784.161296611967;5825.650460972355;5825.776586916711;5858.47273745365;5864.7067646617925;6355.713992870332;6370.267419246753;6379.617222966637;6399.488040956712;6419.807405777834;5987.221661184105;6013.0980352946535;6094;6153.353897840751;6156.722947467375;6133.815985520441;6201.472874805692;6204.7828326008375;6210.192674952227;6225.28409232944;6114.174586430775;6153.784617538454;6159.1069294951985;6167.537434692326;6169.5064394848305;6061.575689701678;6108.2813625860135;6170.444659980533;6172.753089876444;6173.104899789505;4720.976395118071;4746.928796068062;4768.284757286366;4791.544803243686;4791.904161916742;4161.126163505637;4196.013936724868;4197.895052623648;4222.556631553704;4244.575542445731;5830.883382332329;5951.672658003851;5979.641221526722;6033.125196846433;6034.607750496291;6135.60118592299;6177.69111544421;6179.62922224668;6190.133381326618;6196.287426945959;5917.378675239124;5921.467067963904;5943.078822782476;5953.28560572734;5987.760489580368;5290.153575427913;5333.813316533902;5350.8662283442445;5374.086405311028;5377.892442151135;6422.550421470546;6525.412712855866;6546.149000629887;6569.507286953498;6579.440747536513;6348.301686814354;6355.396237357444;6359.109724638647;6371.267304259884;6383.872322553616;6206.038064100072;6350.68246587678;6517.478601711947;6521.478281737354;6593.505487088583;5954.7320370582565;6009.819705408845;6016.819495415145;6038.064100064497;6044.15381846533;6111.960966635594;6120.081987701702;6123.663198524124;6128.4790792783115;6142.416470435302;5964.582479226413;5967.880642387215;5973.074173503114;5988;6074.453299203093;6088.5737998341465;6151.907721384094;6179.258488981351;6201.782937597343;6207;6167.5374346925055;6172.444479996821;6175.073738939195;6179.721912513858;6184.845378865564;5931.288245410578;6061.242344706911;6141.7543298267565;6181;6244.812655620339;5960.165576819336;6024.819255422344;6059.000264956233;6069.939300606938;6080.452759251689 22:32:23 INFO - PROCESS | 8924 | |1;ext.html;579.3424463234228;646.3471893387679;653.1933062667605;662.2913482573645;707.9221285658573;41782.164356712885;45574.08851822962;45576;45824.31263531045;45899.31151032733;47513.76243118788;47733.28400073993;47856.28215576761;48164.51835481644;48211.276830847564;9111;9212.907870921306;9216.078392160764;9230.16928476437;9253.722388328328;9173.816523669522;9181.127792859701;9209.539523023856;9236.3996340238;9263.861042084374;9208.723738287828;9266.629334826599;9312.25501959845;9318.86021709675;9326.440413575174;9137.588808503633;9255.722328330161;9264.6294148234;9284.814303713922;9303.116203960613;9156;9178.586963586587;9208.631654733803;9222.53887305632;9271.165595096474;45118.54881451176;45528.31707524357;45555.31667024997;45589.31616025762;45701.314480282825;3850.5571859236265;3952.822123004443;4104.733192342488;4258.339957306623;4344.91310173798;35929.64070359289;36069.819650901576;36366.27267454636;36691;36745.265094697956;4141.855035073788;4147.232761939051;4157.334826427757;4220.85227017056;4276.3157894737005;360725;361900;364461;364611;366075.9999999973;64413;64523.67738161279;64930.675346622964;64988.675056624415;65193.67403162954;39871;40714.59285407108;40730;42851;67890;19859.503512412306;19876.304329348404;19968.400947971582;19982.70025949612;20035.499112522302;14694.63263418423;14722.043067200597;14724.705505889822;14726.558203253919;14756;21067.68398474024;21117.68323475149;21126.894365528075;21129.26047588327;21309.46726331854;7198.460115491359;7334.9266507335315;7380.261973802577;7443.292887175709;7460.575313023289;936.0966667166217;1046.6232156423682;1134.3477500437116;1158.195054437158;1195.1275568834626;34412.65587344144;34633.134171645404;34689.82655086759;34876.65123348785;34973.47539786905;1206.6259459567561;1207.2032458577296;1215.143323956626;1255.993720031394;1278.8017857231957;17690.469285921445;17967.37114201023;18128.637427251382;18294.451166465027;18347.266109355478;558512;558803;564527;568248;568880;62776.37223627705;63531;63640;63784.68107659525;63833;1391.290441874631;1447.1027962663006;1465.5969608357786;1486.8884833637737;1489.4414594527052;28753.856230718713;28879.42241155123;28882;29387;29414.55878161872;56533.434665652814;56987;57058;57133.143002855824;57208.71395642995;367060;367999;368328;369541;371550;30974.22564435907;31124.844375777975;31303.686963130076;32116.839415802773;32191.839040804647;52479.21281180862;53015.734921326686;53172.202416963;53877.46122538725;54478.72760636172;43542.78228608837;46036.76981615071;46490.35593557421;46491;46536.301955471376;44605;45432.318515222956;45654.77172614116;46289.305660414444;47965.5203447961;39502.60497395104;44831.053802218215;46132.769336154444;46863.531364685914;48245.75877120592;38320.94175960374;39736.80131599324;39934;39994.20011599694;40222;30527.329976061494;30592.694073058985;30646.233844154074;30915.69084309128;31012.844935775178 22:32:23 INFO - PROCESS | 8924 | |2;jquery.html;393.9881803545895;395.76847544186666;405.5336363182341;409.6620288262184;435.79735423028285;19217;20525.48686282844;20806.959652017395;20908.581828363443;21083.262085827;11826.349550774705;12097.576584819511;18319.450416487492;20643.793562064377;21024;5340.359156901177;5360.2763626910455;5375.81184658537;5383.838484845451;5388.218708287296;4017.5580686124504;5179.378474583055;5308;5353.625246232766;5662.518685911702;5962.25471816023;6014.939850601503;6015.699215039231;6033.517318614522;6040.516758659297;5991;5998.640081595118;6768.424683901874;6835.213950395719;6841.62371069591;5816.098504731774;6066.696665166768;6068.393160683941;6072.271327440735;6075.635461872302;13072.673183170402;13306.467741290337;13370;13373.732525349536;13392.995525335638;2440.853548787061;2467.802575793932;2580.780633646142;2607.4915391498475;2834.7590454811366;10002.749931251705;13024.804627930589;15040.473583424528;15645.374185032699;15823.683526329523;1909.9018064612903;2025.9696104558443;2068.338131797825;2091.372588223542;2101.13853320138;83612.99999999939;85069.57465212696;85270;86754;88916;11525.081472299458;11696.70758231034;11816.291022538675;11849.644510664693;11851.111166662535;16718.498445046425;16733.91633041827;16744.413945512093;16810.411635592696;16879.24043418049;8486.702965396182;8519.659213631508;8921.330900182513;8923;9025.909740902507;8942.46345219289;8944.955275223712;9057.411268267542;9155.54222288883;9175.128362805523;4480.126375356775;4557.339185818038;4796.208625576811;5156.355455568054;5171.629518177686;1742.851857592119;1858.5260758506495;2079.480129967508;2090.268406057898;2101.6112019276484;967.8257913575624;1029.1509504658686;1031.3347890610664;1037.4345981440133;1108.6784832398675;19338.323158689378;20598.485037874172;20881;21044.579108417747;21172.682409763867;1061.7557961668706;1069.7379142110078;1092.9508172132273;1098.8296813993843;1103.1836441033577;10671.573137074585;11453.370064646524;11513.88486115145;11579.073674106052;11623.360715160747;495062;498595;503416;509983;510656;90437.54781226051;90535.54732226429;92793;95503;96735.51632241794;1025.9384436933658;1036.18659352408;1038.0346277961569;1039.449091981251;1046.0794500839213;17550.210240538952;18132.637347252716;18333.08334583292;18478.815211848247;18679.813201867808;43918.12163756643;44923.550764493244;45280.77359613181;46097.769511152226;46927.29609055799;57932.13101803561;61261.38738612557;61319.38680613137;61578.38421615906;61997.690011549654;7843.294103530709;7957.482763620346;7960.442769006114;8213.260806527442;8302.916970830456;9610.567524461276;12933.611991640266;13199.07606467538;13948.16311021342;13987.370568324246;12061.51753929868;12294.262344259372;12301.753964920472;12597;12757.362131893182;12447.626571202878;12544.749105017667;12552.87447125517;12565.93717031409;12611.74776504483;12443.75112497763;12622.43199056063;12645.178063425848;12651.430685619353;12910.708929107013;8429.157084291523;8490.915090849012;8646.135386461303;9090.09099090112;9254.583543740413;11722.882771172179;11919.404029798301;12390.690232744253;12440.129190956546;12491.938830092933 22:32:23 INFO - PROCESS | 8924 | |3;mootools.html;1531.150211632544;1558.8441155884414;1722.9913850430746;1812.2479171143975;1828.6434145341664;8412.327013838894;8931.55342232889;8946.776330591738;9732.805343893127;9737.07497787709;9115.863262051074;9355.391899526527;9424.52877356133;9441.433513989165;9442.527873606326;2467.7778999890006;2492.264781889347;2497.67530221071;2502.5995840665496;2512.6733524641772;2443.780059794618;2514.5222407742563;2521.7982561395042;2527.772500474957;2531.227975467491;2518.508890766301;2529;2533.075427468979;2549.757773011561;2550.5536531107073;2415.4927465232236;2426.4055306449854;2436.0864675746593;2506.035176457059;2509.6988361396566;2465.494573612423;2468.827182097254;2476.8761561921833;2479.256223133053;2480.5038992201453;9355.578998945064;9429.245660347156;9448;9450.716478505656;9472.005439428898;5604.2714447122025;5629.971850140764;5689.6586204827845;5714.314282286111;5783.739731712041;3490.912727181815;3523.4714792781288;3575.910602234939;3670.119171398872;3686.8525258989607;1158.3513232589776;1198.8261702053242;1212.4786341872991;1217.732098938241;1237.6596435980086;12945.288009159493;12987.935060324733;13001.544945926848;13002.544910928073;13057.80413293792;4855.271709243571;4897.1674815281485;4977.328060711758;5009.048280826704;5089.083964886356;10842.40366779819;10953.561857525769;10987.670369888916;10997.945010274898;11057.834132488018;5635.6618602883955;5704.572157088152;5720.570957178145;5731.398203188689;5745.2818397700285;4805.8558243252755;4997.525235102732;5188;5226.398964119099;5315.893682126336;4373.846915357947;4388.648908087345;4444.6666500012625;4447.6219521341045;4460.643148548108;1366.064245991499;1368.7467818453617;1374.3609221711952;1389.2220356600337;1419.4676996126452;1068.7969285835823;1070.1652710885367;1076.822324316479;1097.8572785537829;1104.4146602300793;6183.227096612924;6244.906326405107;6402.839929001719;6430.164078669743;6519.4132528072705;511.5779481927425;515.0985774893935;1095.90684791792;1121.058311018732;1143.3311512765126;4557.635389168859;4569.97175635486;4621.237495813153;4685.1332503486965;4782.569568738831;11629.127815413878;11995.580154694544;12000.759984800256;12007.279563226235;12072.154949153475;11067.225294229487;11498.195126341243;11948.283103013848;11973.940130299467;11981.520739170335;8760.95619521911;8871.778205544784;8901.554922253861;8928.99999999987;8937.821243575223;6662.966685166543;6749;6822.658867056726;6866.690998905161;6905.343992320722;10487;10794;11046.723831904266;11067.889321107008;11141.888581114084;10715.35707857531;11136.721581960515;11138.832917506406;11173.776524469302;11287.266327689002;7834.0599128105;8106.8783968241705;8298.419110662197;8300.83398332042;8557.786055348666;9098.090190980849;9132;9137.954310228406;9172;9219.308551858503;8217.219364160395;8319.459235149696;8329.708460203863;8376.7905802353;8412.284955778583;8113.107558168715;8183.79540511492;8186.467879587808;8204.261616454309;8331.375146863887;7456.32893039629;7506.099268087864;7550.433717471322;7579.279968402993;7579.469437139347;5469.972650136724;5764.250647415809;5771.94228057714;5820.912686309624;5847.707614619167;5542.528885044655;5662.292213473316;5673.205751194919;5712.971435142797;5827.863566604471 22:32:23 INFO - PROCESS | 8924 | |4;prototype.html;351.5113991551743;352.1688814398021;352.36398301066566;356.12926394964325;356.2003302585695;5788.594798364116;5792.333881603617;5815;5829.941700582993;5929.644221346712;5764.9135262970985;5767.452092051259;5798.246227990366;5888.823335299937;5898.262717160355;4266.59467350602;4445.977770111145;4501.234790085693;4515.3227015947705;4537.977310113445;4471.977640111795;4478.126765280772;4506.369108324837;4525.389072475223;4528.97735511322;4500;4523.2762757958735;4524.5249248828895;4537.183307004738;4539.137563862855;4408.470983481987;4424.380586717862;4447.755373454459;4482.843100491484;4509.774511274423;3869.767813931145;3874.3994680824517;3912.197999410114;3912.3544615138753;3943.2902077626018;5611.915821262684;5649.830505084854;5650.915236271459;5652.123920792284;5655.095184770417;5033.874153146164;5100.897982040338;5102.698811803004;5107.259447380146;5182.818601348972;6035.155078289043;6044.788432404845;6052;6061.969690151521;6115.960286751263;4344.23975804233;4383.495897971742;4385.7149285296355;4400.295952647593;4419.204543182226;6058.878822423527;6089.634621922654;6321;6353.4281914627445;6358.904616430711;4396.758178300224;4406.405135306757;4417.867463976086;4481.955180448153;4491.630052833917;4537.954620453819;4545.8408955687055;4545.886352841139;4549.977250113794;4557.088582283556;5026.6123591293845;5164.690118592896;5225.947740522623;5233.685978841282;5245.580353571705;6122.816315510542;6144.109104179869;6144.600600960924;6146.170267013896;6204.720787564571;1549.4422008077083;1562.8827837912202;1563.1012168003444;1563.9443375721341;1572.7798108264851;938.7981583959481;984.7390441532999;986.240594742059;992.9524351808911;1005.5123265216364;5190.261262477113;5243.239730239094;5274.894502109936;5294.57643388528;5368.543673787772;5480.835574932758;5487.146683724441;5490.972545137329;5510.586705997066;5579.0515612346;4992.8751781205765;5264.9736751315995;5310.495502927216;5336.67979921206;5340.49265319794;2952.320966177791;2966.5846781450614;2982.746466550324;2983.7165469280385;3005.233665415305;5519.779208831602;5721.77112915487;5725.255716756795;5771.567132465082;5791.552111972007;5358.19627055937;5511.779528818803;5589;5595.412481689364;5610.607257491936;5694.4590263924865;5723.846864620549;5731.283589551223;5741.741621627037;5773.797917072882;5328;5408.269883565668;5449.7275136243825;5452.372977107525;5532.399772107104;5369.570434365163;5399.055165346127;5403.7838486460105;5412.648177868426;5424.972875135599;6241.21984751906;6258.499320054294;6436.8390790230615;6486.054183744952;6488.923544465726;4415.315626077963;4430.645548356059;4437.800298986618;4471.374007638999;4522.186006518858;6181.381861813962;6256.280527739186;6257.186565746424;6422.389872962061;6450.774222902176;6049.485793707584;6070.7875224366935;6071.666058366833;6079.209702738793;6100.511959043355;5827.329857066492;6078.483328917092;6085.361037091042;6126.846828829315;6167.969160154171;5998.890205312031;6039.792041591611;6088.4215999479975;6089;6106.664133472702;6073.514118870391;6114.694265286629;6135.233095863017;6135.969320153371;6138.570300078952;5783.652980821164;5956.642601443928;5961.390424585425;5988.760449581968;6007.939920600913 22:32:23 INFO - PROCESS | 8924 | |5;yui.html;784.7959530522064;819.4264015189369;842.9199226073524;890.5369208011834;914.8399030169719;13622.863771362283;17105.572360690974;17147.228374723138;17279.654406911854;17352.392666256685;15248.161351125684;15532.068075915453;15672;15722.842771572281;15766.605834854134;869.1742844297927;887.9378443508957;889;891.3448615267773;892.3575025981315;863.5078005536847;868.1708967935638;868.3487384461654;868.4919322196523;868.8957325120963;931.3806318797991;935.5135329628589;935.5602866652696;935.8830146231721;938.3290946972913;911.4030310146865;918.2286879021588;920.7099763574453;923.6859467780953;926.3098991251493;677.7593954146306;686.5674624986227;686.9278725733776;687.1067612104295;687.6458623808743;13552.864471355357;13574.457021719218;13669.726605467835;13677.521286754916;13692.110012849133;13648.658783530393;14127.788083178657;14611;14626.707465850623;14873;11645.301281923112;12591.496340146383;12852.55016074433;12927.87072129276;13038.282894440801;4807.302941073524;4864.343313652683;4883.926741098886;4938.38270216223;4998.500149985009;80921.19078809254;81243;82109;83565;83837.58081209616;12077.818832717516;12338.753224935452;12363.134580579454;12418.627441176779;12513.562025329069;22281.777182228296;22295.665565016538;22299.777002230094;22444.55110897773;22500.32499025032;9162.083791620918;9324.393914395543;9384.62461501546;9413.76465588352;9432.056794320513;5217.6347655664495;5239.371275446894;5290.391604965478;5332.093544097513;5422.8915421691345;4044.6359827615656;4148.730332528376;4204.642605378516;4204.747715137101;4208;684.5995092870627;691.1257259566652;694.1689805632725;697.3235961117708;716.8566286742672;796.7530065679658;817.4604760857806;819.1194465949128;820.3150369441464;859.9484030958163;8428.620712067972;10477.476126193813;10527.947360263302;10627.681169564925;10812.297200681931;718.9245129261457;787.8345547435102;813.3655748516167;819.9877001844977;846.4667259626395;4893.363862697826;5073.797048118034;5089.262057001714;5103.209002604528;5110.2590124431745;73312.26687733055;73864.63067684627;87367;125985;129283;77818;92417;94625;107511.46244268885;108555;86523;87734;90038;92510.07489925149;94691.05308946823;10072.54673539707;10230.181585472996;10302.33034852732;10379.429131397847;10448.283446303863;39439.408408873314;42243;51104;51250;52545.737271313395;72753.63623182062;75613;80913.59543202247;81058.59470702845;81742.59128704318;13663.111897726616;14011.649708757363;14242.857571424152;14394.568162955127;14618.707625847635;15316.693666126392;17047.829521704625;17079.40222092221;17205.741913871552;18091.36680216186;14410.207438590558;14736.410543578137;14792.334344954717;14840.10959342443;15206.315715792594;12941.676458088623;14223.933205009458;14245;14299.920544892102;14596.562103136923;13428.93285533566;14127.505537306144;14580.416783328548;14633.122012678847;15438.5368438947;11607.355391573543;11651.76696466049;11740.06079513654;11870.643880683594;12174.391280435766;11559.30644161353;11774.470148843151;12052.638420847388;12058.879411205775;12248.938755306523 22:32:23 INFO - PROCESS | 8924 | __end_tp_report 22:32:23 INFO - PROCESS | 8924 | __start_cc_report 22:32:23 INFO - PROCESS | 8924 | _x_x_mozilla_cycle_collect,333 22:32:23 INFO - PROCESS | 8924 | __end_cc_report 22:32:23 INFO - PROCESS | 8924 | __startTimestamp1473226343321__endTimestamp 22:32:23 INFO - PROCESS | 8924 | 22:32:23 INFO - PROCESS | 8924 | ------- Summary: start ------- 22:32:23 INFO - PROCESS | 8924 | Number of tests: 6 22:32:23 INFO - PROCESS | 8924 | 22:32:23 INFO - PROCESS | 8924 | [#0] dojo.html Cycles:165 Average:5781.99 Median:6013.10 stddev:663.52 (11.0%) stddev-sans-first:636.16 22:32:23 INFO - PROCESS | 8924 | Values: 3292.2 3309.1 3311.1 3325.1 3336.0 5690.1 5733.5 5748.4 5785.3 5786.3 5833.1 5879.0 5916.9 5920.1 5946.1 5333.3 5355.8 5393.7 5400.0 5453.7 5252.5 5258.1 5262.8 5270.5 5303.7 5284.7 5338.6 5346.0 5373.6 5405.0 5388.2 5395.1 5404.0 5405.0 5414.6 5033.9 5084.7 5192.0 5305.2 5416.1 5662.4 5732.9 5743.5 5746.2 5768.7 6117.6 6132.7 6144.8 6184.3 6243.0 6084.7 6135.5 6240.1 6242.5 6280.1 5784.2 5825.7 5825.8 5858.5 5864.7 6355.7 6370.3 6379.6 6399.5 6419.8 5987.2 6013.1 6094.0 6153.4 6156.7 6133.8 6201.5 6204.8 6210.2 6225.3 6114.2 6153.8 6159.1 6167.5 6169.5 6061.6 6108.3 6170.4 6172.8 6173.1 4721.0 4746.9 4768.3 4791.5 4791.9 4161.1 4196.0 4197.9 4222.6 4244.6 5830.9 5951.7 5979.6 6033.1 6034.6 6135.6 6177.7 6179.6 6190.1 6196.3 5917.4 5921.5 5943.1 5953.3 5987.8 5290.2 5333.8 5350.9 5374.1 5377.9 6422.6 6525.4 6546.1 6569.5 6579.4 6348.3 6355.4 6359.1 6371.3 6383.9 6206.0 6350.7 6517.5 6521.5 6593.5 5954.7 6009.8 6016.8 6038.1 6044.2 6112.0 6120.1 6123.7 6128.5 6142.4 5964.6 5967.9 5973.1 5988.0 6074.5 6088.6 6151.9 6179.3 6201.8 6207.0 6167.5 6172.4 6175.1 6179.7 6184.8 5931.3 6061.2 6141.8 6181.0 6244.8 5960.2 6024.8 6059.0 6069.9 6080.5 22:32:23 INFO - PROCESS | 8924 | 22:32:23 INFO - PROCESS | 8924 | [#1] ext.html Cycles:180 Average:61078.71 Median:44073.89 stddev:116978.81 (265.4%) stddev-sans-first:117218.78 22:32:23 INFO - PROCESS | 8924 | Values: 579.3 646.3 653.2 662.3 707.9 41782.2 45574.1 45576.0 45824.3 45899.3 47513.8 47733.3 47856.3 48164.5 48211.3 9111.0 9212.9 9216.1 9230.2 9253.7 9173.8 9181.1 9209.5 9236.4 9263.9 9208.7 9266.6 9312.3 9318.9 9326.4 9137.6 9255.7 9264.6 9284.8 9303.1 9156.0 9178.6 9208.6 9222.5 9271.2 45118.5 45528.3 45555.3 45589.3 45701.3 3850.6 3952.8 4104.7 4258.3 4344.9 35929.6 36069.8 36366.3 36691.0 36745.3 4141.9 4147.2 4157.3 4220.9 4276.3 360725.0 361900.0 364461.0 364611.0 366076.0 64413.0 64523.7 64930.7 64988.7 65193.7 39871.0 40714.6 40730.0 42851.0 67890.0 19859.5 19876.3 19968.4 19982.7 20035.5 14694.6 14722.0 14724.7 14726.6 14756.0 21067.7 21117.7 21126.9 21129.3 21309.5 7198.5 7334.9 7380.3 7443.3 7460.6 936.1 1046.6 1134.3 1158.2 1195.1 34412.7 34633.1 34689.8 34876.7 34973.5 1206.6 1207.2 1215.1 1256.0 1278.8 17690.5 17967.4 18128.6 18294.5 18347.3 558512.0 558803.0 564527.0 568248.0 568880.0 62776.4 63531.0 63640.0 63784.7 63833.0 1391.3 1447.1 1465.6 1486.9 1489.4 28753.9 28879.4 28882.0 29387.0 29414.6 56533.4 56987.0 57058.0 57133.1 57208.7 367060.0 367999.0 368328.0 369541.0 371550.0 30974.2 31124.8 31303.7 32116.8 32191.8 52479.2 53015.7 53172.2 53877.5 54478.7 43542.8 46036.8 46490.4 46491.0 46536.3 44605.0 45432.3 45654.8 46289.3 47965.5 39502.6 44831.1 46132.8 46863.5 48245.8 38320.9 39736.8 39934.0 39994.2 40222.0 30527.3 30592.7 30646.2 30915.7 31012.8 22:32:23 INFO - PROCESS | 8924 | 22:32:23 INFO - PROCESS | 8924 | [#2] jquery.html Cycles:180 Average:29815.06 Median:21063.92 stddev:83085.50 (394.4%) stddev-sans-first:83289.21 22:32:23 INFO - PROCESS | 8924 | Values: 394.0 395.8 405.5 409.7 435.8 19217.0 20525.5 20807.0 20908.6 21083.3 11826.3 12097.6 18319.5 20643.8 21024.0 5340.4 5360.3 5375.8 5383.8 5388.2 4017.6 5179.4 5308.0 5353.6 5662.5 5962.3 6014.9 6015.7 6033.5 6040.5 5991.0 5998.6 6768.4 6835.2 6841.6 5816.1 6066.7 6068.4 6072.3 6075.6 13072.7 13306.5 13370.0 13373.7 13393.0 2440.9 2467.8 2580.8 2607.5 2834.8 10002.7 13024.8 15040.5 15645.4 15823.7 1909.9 2026.0 2068.3 2091.4 2101.1 83613.0 85069.6 85270.0 86754.0 88916.0 11525.1 11696.7 11816.3 11849.6 11851.1 16718.5 16733.9 16744.4 16810.4 16879.2 8486.7 8519.7 8921.3 8923.0 9025.9 8942.5 8945.0 9057.4 9155.5 9175.1 4480.1 4557.3 4796.2 5156.4 5171.6 1742.9 1858.5 2079.5 2090.3 2101.6 967.8 1029.2 1031.3 1037.4 1108.7 19338.3 20598.5 20881.0 21044.6 21172.7 1061.8 1069.7 1093.0 1098.8 1103.2 10671.6 11453.4 11513.9 11579.1 11623.4 495062.0 498595.0 503416.0 509983.0 510656.0 90437.5 90535.5 92793.0 95503.0 96735.5 1025.9 1036.2 1038.0 1039.4 1046.1 17550.2 18132.6 18333.1 18478.8 18679.8 43918.1 44923.6 45280.8 46097.8 46927.3 57932.1 61261.4 61319.4 61578.4 61997.7 7843.3 7957.5 7960.4 8213.3 8302.9 9610.6 12933.6 13199.1 13948.2 13987.4 12061.5 12294.3 12301.8 12597.0 12757.4 12447.6 12544.7 12552.9 12565.9 12611.7 12443.8 12622.4 12645.2 12651.4 12910.7 8429.2 8490.9 8646.1 9090.1 9254.6 11722.9 11919.4 12390.7 12440.1 12491.9 22:32:23 INFO - PROCESS | 8924 | 22:32:23 INFO - PROCESS | 8924 | [#3] mootools.html Cycles:180 Average:6257.44 Median:4653.19 stddev:3531.44 (75.9%) stddev-sans-first:3523.48 22:32:23 INFO - PROCESS | 8924 | Values: 1531.2 1558.8 1723.0 1812.2 1828.6 8412.3 8931.6 8946.8 9732.8 9737.1 9115.9 9355.4 9424.5 9441.4 9442.5 2467.8 2492.3 2497.7 2502.6 2512.7 2443.8 2514.5 2521.8 2527.8 2531.2 2518.5 2529.0 2533.1 2549.8 2550.6 2415.5 2426.4 2436.1 2506.0 2509.7 2465.5 2468.8 2476.9 2479.3 2480.5 9355.6 9429.2 9448.0 9450.7 9472.0 5604.3 5630.0 5689.7 5714.3 5783.7 3490.9 3523.5 3575.9 3670.1 3686.9 1158.4 1198.8 1212.5 1217.7 1237.7 12945.3 12987.9 13001.5 13002.5 13057.8 4855.3 4897.2 4977.3 5009.0 5089.1 10842.4 10953.6 10987.7 10997.9 11057.8 5635.7 5704.6 5720.6 5731.4 5745.3 4805.9 4997.5 5188.0 5226.4 5315.9 4373.8 4388.6 4444.7 4447.6 4460.6 1366.1 1368.7 1374.4 1389.2 1419.5 1068.8 1070.2 1076.8 1097.9 1104.4 6183.2 6244.9 6402.8 6430.2 6519.4 511.6 515.1 1095.9 1121.1 1143.3 4557.6 4570.0 4621.2 4685.1 4782.6 11629.1 11995.6 12000.8 12007.3 12072.2 11067.2 11498.2 11948.3 11973.9 11981.5 8761.0 8871.8 8901.6 8929.0 8937.8 6663.0 6749.0 6822.7 6866.7 6905.3 10487.0 10794.0 11046.7 11067.9 11141.9 10715.4 11136.7 11138.8 11173.8 11287.3 7834.1 8106.9 8298.4 8300.8 8557.8 9098.1 9132.0 9138.0 9172.0 9219.3 8217.2 8319.5 8329.7 8376.8 8412.3 8113.1 8183.8 8186.5 8204.3 8331.4 7456.3 7506.1 7550.4 7579.3 7579.5 5470.0 5764.3 5771.9 5820.9 5847.7 5542.5 5662.3 5673.2 5713.0 5827.9 22:32:23 INFO - PROCESS | 8924 | 22:32:23 INFO - PROCESS | 8924 | [#4] prototype.html Cycles:180 Average:4954.68 Median:5466.60 stddev:1439.98 (26.3%) stddev-sans-first:1401.96 22:32:23 INFO - PROCESS | 8924 | Values: 351.5 352.2 352.4 356.1 356.2 5788.6 5792.3 5815.0 5829.9 5929.6 5764.9 5767.5 5798.2 5888.8 5898.3 4266.6 4446.0 4501.2 4515.3 4538.0 4472.0 4478.1 4506.4 4525.4 4529.0 4500.0 4523.3 4524.5 4537.2 4539.1 4408.5 4424.4 4447.8 4482.8 4509.8 3869.8 3874.4 3912.2 3912.4 3943.3 5611.9 5649.8 5650.9 5652.1 5655.1 5033.9 5100.9 5102.7 5107.3 5182.8 6035.2 6044.8 6052.0 6062.0 6116.0 4344.2 4383.5 4385.7 4400.3 4419.2 6058.9 6089.6 6321.0 6353.4 6358.9 4396.8 4406.4 4417.9 4482.0 4491.6 4538.0 4545.8 4545.9 4550.0 4557.1 5026.6 5164.7 5225.9 5233.7 5245.6 6122.8 6144.1 6144.6 6146.2 6204.7 1549.4 1562.9 1563.1 1563.9 1572.8 938.8 984.7 986.2 993.0 1005.5 5190.3 5243.2 5274.9 5294.6 5368.5 5480.8 5487.1 5491.0 5510.6 5579.1 4992.9 5265.0 5310.5 5336.7 5340.5 2952.3 2966.6 2982.7 2983.7 3005.2 5519.8 5721.8 5725.3 5771.6 5791.6 5358.2 5511.8 5589.0 5595.4 5610.6 5694.5 5723.8 5731.3 5741.7 5773.8 5328.0 5408.3 5449.7 5452.4 5532.4 5369.6 5399.1 5403.8 5412.6 5425.0 6241.2 6258.5 6436.8 6486.1 6488.9 4415.3 4430.6 4437.8 4471.4 4522.2 6181.4 6256.3 6257.2 6422.4 6450.8 6049.5 6070.8 6071.7 6079.2 6100.5 5827.3 6078.5 6085.4 6126.8 6168.0 5998.9 6039.8 6088.4 6089.0 6106.7 6073.5 6114.7 6135.2 6136.0 6138.6 5783.7 5956.6 5961.4 5988.8 6007.9 22:32:23 INFO - PROCESS | 8924 | 22:32:23 INFO - PROCESS | 8924 | [#5] yui.html Cycles:180 Average:20966.58 Median:4835.82 stddev:29262.17 (605.1%) stddev-sans-first:29305.02 22:32:23 INFO - PROCESS | 8924 | Values: 784.8 819.4 842.9 890.5 914.8 13622.9 17105.6 17147.2 17279.7 17352.4 15248.2 15532.1 15672.0 15722.8 15766.6 869.2 887.9 889.0 891.3 892.4 863.5 868.2 868.3 868.5 868.9 931.4 935.5 935.6 935.9 938.3 911.4 918.2 920.7 923.7 926.3 677.8 686.6 686.9 687.1 687.6 13552.9 13574.5 13669.7 13677.5 13692.1 13648.7 14127.8 14611.0 14626.7 14873.0 11645.3 12591.5 12852.6 12927.9 13038.3 4807.3 4864.3 4883.9 4938.4 4998.5 80921.2 81243.0 82109.0 83565.0 83837.6 12077.8 12338.8 12363.1 12418.6 12513.6 22281.8 22295.7 22299.8 22444.6 22500.3 9162.1 9324.4 9384.6 9413.8 9432.1 5217.6 5239.4 5290.4 5332.1 5422.9 4044.6 4148.7 4204.6 4204.7 4208.0 684.6 691.1 694.2 697.3 716.9 796.8 817.5 819.1 820.3 859.9 8428.6 10477.5 10527.9 10627.7 10812.3 718.9 787.8 813.4 820.0 846.5 4893.4 5073.8 5089.3 5103.2 5110.3 73312.3 73864.6 87367.0 125985.0 129283.0 77818.0 92417.0 94625.0 107511.5 108555.0 86523.0 87734.0 90038.0 92510.1 94691.1 10072.5 10230.2 10302.3 10379.4 10448.3 39439.4 42243.0 51104.0 51250.0 52545.7 72753.6 75613.0 80913.6 81058.6 81742.6 13663.1 14011.6 14242.9 14394.6 14618.7 15316.7 17047.8 17079.4 17205.7 18091.4 14410.2 14736.4 14792.3 14840.1 15206.3 12941.7 14223.9 14245.0 14299.9 14596.6 13428.9 14127.5 14580.4 14633.1 15438.5 11607.4 11651.8 11740.1 11870.6 12174.4 11559.3 11774.5 12052.6 12058.9 12248.9 22:32:23 INFO - PROCESS | 8924 | -------- Summary: end -------- 22:32:23 INFO - PROCESS | 8924 | 22:32:24 INFO - TEST-INFO | 8924: exit 0 22:32:24 INFO - TEST-OK | dromaeo_css | took 1110997ms 22:32:24 INFO - TEST-START | kraken 22:32:24 INFO - operating with platform_type : linux_ 22:32:24 INFO - Initialising browser for kraken test... 22:32:24 INFO - TEST-INFO | started process 9193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUcsPkL/profile http://localhost:52475/getInfo.html) 22:32:28 INFO - PROCESS | 9193 | __metrics Screen width/height:1600/1200 22:32:28 INFO - PROCESS | 9193 | colorDepth:24 22:32:28 INFO - PROCESS | 9193 | Browser inner width/height: 1024/697 22:32:28 INFO - PROCESS | 9193 | __metrics 22:32:29 ERROR - PROCESS | 9193 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:32:29 INFO - TEST-INFO | 9193: exit 0 22:32:29 INFO - Browser initialized. 22:32:29 INFO - Running cycle 1/1 for kraken test... 22:32:29 INFO - TEST-INFO | started process 9320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUcsPkL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:32:41 INFO - PROCESS | 9320 | RSS: Main: 153436160 22:32:41 INFO - PROCESS | 9320 | 22:32:44 INFO - PROCESS | 9320 | Cycle 1(1): loaded http://localhost:52475/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52475/tests/kraken/driver.html?testName=audio-beat-detection) 22:32:44 INFO - PROCESS | 9320 | RSS: Main: 158842880 22:32:44 INFO - PROCESS | 9320 | 22:32:47 INFO - PROCESS | 9320 | Cycle 1(1): loaded http://localhost:52475/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52475/tests/kraken/driver.html?testName=audio-dft) 22:32:48 INFO - PROCESS | 9320 | RSS: Main: 157020160 22:32:48 INFO - PROCESS | 9320 | 22:32:51 INFO - PROCESS | 9320 | Cycle 1(1): loaded http://localhost:52475/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52475/tests/kraken/driver.html?testName=audio-fft) 22:32:51 INFO - PROCESS | 9320 | RSS: Main: 158076928 22:32:51 INFO - PROCESS | 9320 | 22:32:53 INFO - PROCESS | 9320 | Cycle 1(1): loaded http://localhost:52475/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52475/tests/kraken/driver.html?testName=audio-oscillator) 22:32:54 INFO - PROCESS | 9320 | RSS: Main: 157728768 22:32:54 INFO - PROCESS | 9320 | 22:32:56 INFO - PROCESS | 9320 | Cycle 1(1): loaded http://localhost:52475/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52475/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:32:57 INFO - PROCESS | 9320 | RSS: Main: 157343744 22:32:57 INFO - PROCESS | 9320 | 22:33:00 INFO - PROCESS | 9320 | Cycle 1(1): loaded http://localhost:52475/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52475/tests/kraken/driver.html?testName=imaging-darkroom) 22:33:00 INFO - PROCESS | 9320 | RSS: Main: 157077504 22:33:00 INFO - PROCESS | 9320 | 22:33:04 INFO - PROCESS | 9320 | Cycle 1(1): loaded http://localhost:52475/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52475/tests/kraken/driver.html?testName=imaging-desaturate) 22:33:04 INFO - PROCESS | 9320 | RSS: Main: 155918336 22:33:04 INFO - PROCESS | 9320 | 22:33:07 INFO - PROCESS | 9320 | Cycle 1(1): loaded http://localhost:52475/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52475/tests/kraken/driver.html?testName=json-parse-financial) 22:33:08 INFO - PROCESS | 9320 | RSS: Main: 157327360 22:33:08 INFO - PROCESS | 9320 | 22:33:09 INFO - PROCESS | 9320 | Cycle 1(1): loaded http://localhost:52475/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52475/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:33:10 INFO - PROCESS | 9320 | RSS: Main: 156512256 22:33:10 INFO - PROCESS | 9320 | 22:33:12 INFO - PROCESS | 9320 | Cycle 1(1): loaded http://localhost:52475/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52475/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:33:13 INFO - PROCESS | 9320 | RSS: Main: 157351936 22:33:13 INFO - PROCESS | 9320 | 22:33:15 INFO - PROCESS | 9320 | Cycle 1(1): loaded http://localhost:52475/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52475/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:33:15 INFO - PROCESS | 9320 | RSS: Main: 157302784 22:33:15 INFO - PROCESS | 9320 | 22:33:18 INFO - PROCESS | 9320 | Cycle 1(1): loaded http://localhost:52475/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:33:18 INFO - PROCESS | 9320 | RSS: Main: 157872128 22:33:18 INFO - PROCESS | 9320 | 22:33:21 INFO - PROCESS | 9320 | Cycle 1(1): loaded http://localhost:52475/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:33:22 INFO - PROCESS | 9320 | RSS: Main: 158093312 22:33:22 INFO - PROCESS | 9320 | 22:33:23 INFO - PROCESS | 9320 | Cycle 1(1): loaded http://localhost:52475/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52475/tests/kraken/driver.html?testName=ai-astar) 22:33:24 INFO - PROCESS | 9320 | RSS: Main: 159457280 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - PROCESS | 9320 | __start_tp_report 22:33:24 INFO - PROCESS | 9320 | _x_x_mozilla_page_load 22:33:24 INFO - PROCESS | 9320 | _x_x_mozilla_page_load_details 22:33:24 INFO - PROCESS | 9320 | |i|pagename|runs| 22:33:24 INFO - PROCESS | 9320 | |0;ai-astar;103;110;106;110;111;110;111;110;111;112 22:33:24 INFO - PROCESS | 9320 | |1;audio-beat-detection;141;116;142;169;119;144;150;122;178;120 22:33:24 INFO - PROCESS | 9320 | |2;audio-dft;162;165;165;163;162;162;163;162;163;167 22:33:24 INFO - PROCESS | 9320 | |3;audio-fft;74;74;76;173;75;76;75;76;165;76 22:33:24 INFO - PROCESS | 9320 | |4;audio-oscillator;84;84;144;86;87;85;138;87;84;136 22:33:24 INFO - PROCESS | 9320 | |5;imaging-gaussian-blur;118;121;117;120;118;117;117;117;117;117 22:33:24 INFO - PROCESS | 9320 | |6;imaging-darkroom;146;147;148;148;148;149;150;147;148;148 22:33:24 INFO - PROCESS | 9320 | |7;imaging-desaturate;95;95;97;96;95;95;96;96;95;95 22:33:24 INFO - PROCESS | 9320 | |8;json-parse-financial;53;53;59;52;52;52;54;53;51;54 22:33:24 INFO - PROCESS | 9320 | |9;json-stringify-tinderbox;60;62;61;60;61;60;60;60;61;61 22:33:24 INFO - PROCESS | 9320 | |10;stanford-crypto-aes;75;73;81;81;77;72;78;71;83;78 22:33:24 INFO - PROCESS | 9320 | |11;stanford-crypto-ccm;130;117;129;125;118;118;127;120;145;129 22:33:24 INFO - PROCESS | 9320 | |12;stanford-crypto-pbkdf2;152;151;153;152;151;152;152;152;154;156 22:33:24 INFO - PROCESS | 9320 | |13;stanford-crypto-sha256-iterative;62;63;61;61;65;62;63;62;62;63 22:33:24 INFO - PROCESS | 9320 | __end_tp_report 22:33:24 INFO - PROCESS | 9320 | __start_cc_report 22:33:24 INFO - PROCESS | 9320 | _x_x_mozilla_cycle_collect,901 22:33:24 INFO - PROCESS | 9320 | __end_cc_report 22:33:24 INFO - PROCESS | 9320 | __startTimestamp1473226404063__endTimestamp 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - PROCESS | 9320 | ------- Summary: start ------- 22:33:24 INFO - PROCESS | 9320 | Number of tests: 14 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - PROCESS | 9320 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.50 stddev:2.76 (2.5%) stddev-sans-first:1.69 22:33:24 INFO - PROCESS | 9320 | Values: 103.0 110.0 106.0 110.0 111.0 110.0 111.0 110.0 111.0 112.0 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - PROCESS | 9320 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:143.00 stddev:21.47 (15.0%) stddev-sans-first:22.77 22:33:24 INFO - PROCESS | 9320 | Values: 141.0 116.0 142.0 169.0 119.0 144.0 150.0 122.0 178.0 120.0 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - PROCESS | 9320 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:1.71 (1.1%) stddev-sans-first:1.74 22:33:24 INFO - PROCESS | 9320 | Values: 162.0 165.0 165.0 163.0 162.0 162.0 163.0 162.0 163.0 167.0 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - PROCESS | 9320 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.50 stddev:39.58 (52.4%) stddev-sans-first:41.32 22:33:24 INFO - PROCESS | 9320 | Values: 74.0 74.0 76.0 173.0 75.0 76.0 75.0 76.0 165.0 76.0 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - PROCESS | 9320 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:84.50 stddev:26.21 (31.0%) stddev-sans-first:27.02 22:33:24 INFO - PROCESS | 9320 | Values: 84.0 84.0 144.0 86.0 87.0 85.0 138.0 87.0 84.0 136.0 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - PROCESS | 9320 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:117.50 stddev:1.45 (1.2%) stddev-sans-first:1.54 22:33:24 INFO - PROCESS | 9320 | Values: 118.0 121.0 117.0 120.0 118.0 117.0 117.0 117.0 117.0 117.0 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - PROCESS | 9320 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.10 (0.7%) stddev-sans-first:0.93 22:33:24 INFO - PROCESS | 9320 | Values: 146.0 147.0 148.0 148.0 148.0 149.0 150.0 147.0 148.0 148.0 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - PROCESS | 9320 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 22:33:24 INFO - PROCESS | 9320 | Values: 95.0 95.0 97.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - PROCESS | 9320 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:2.21 (4.2%) stddev-sans-first:2.35 22:33:24 INFO - PROCESS | 9320 | Values: 53.0 53.0 59.0 52.0 52.0 52.0 54.0 53.0 51.0 54.0 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - PROCESS | 9320 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 22:33:24 INFO - PROCESS | 9320 | Values: 60.0 62.0 61.0 60.0 61.0 60.0 60.0 60.0 61.0 61.0 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - PROCESS | 9320 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:78.00 stddev:4.09 (5.2%) stddev-sans-first:4.28 22:33:24 INFO - PROCESS | 9320 | Values: 75.0 73.0 81.0 81.0 77.0 72.0 78.0 71.0 83.0 78.0 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - PROCESS | 9320 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:128.00 stddev:8.44 (6.6%) stddev-sans-first:8.82 22:33:24 INFO - PROCESS | 9320 | Values: 130.0 117.0 129.0 125.0 118.0 118.0 127.0 120.0 145.0 129.0 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - PROCESS | 9320 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:152.00 stddev:1.51 (1.0%) stddev-sans-first:1.59 22:33:24 INFO - PROCESS | 9320 | Values: 152.0 151.0 153.0 152.0 151.0 152.0 152.0 152.0 154.0 156.0 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - PROCESS | 9320 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.50 stddev:1.17 (1.9%) stddev-sans-first:1.24 22:33:24 INFO - PROCESS | 9320 | Values: 62.0 63.0 61.0 61.0 65.0 62.0 63.0 62.0 62.0 63.0 22:33:24 INFO - PROCESS | 9320 | -------- Summary: end -------- 22:33:24 INFO - PROCESS | 9320 | 22:33:24 INFO - TEST-INFO | 9320: exit 0 22:33:24 INFO - TEST-OK | kraken | took 60926ms 22:33:24 INFO - SUITE-END | took 1171s 22:33:25 INFO - Completed test suite (00:19:32) 22:33:25 INFO - javascript benchmark 22:33:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7715.863698051345, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3292.2098696312883, 3309.098524967837, 3311.0728995881163, 3325.1188435064696, 3335.983320083399, 5690.089585666295, 5733.54131669466, 5748.367679555246, 5785.334686511058, 5786.276715410574, 5833.066709326508, 5879.0, 5916.911246331309, 5920.141579470974, 5946.078357854529, 5333.333333333324, 5355.758990845421, 5393.7033463159705, 5400.0, 5453.672779633234, 5252.474752524755, 5258.106121959276, 5262.789488420478, 5270.499302566269, 5303.681779093247, 5284.682919024871, 5338.599605029619, 5345.973270133644, 5373.596980226499, 5404.972975135119, 5388.191771234307, 5395.10980688186, 5404.0, 5405.0, 5414.593905457106, 5033.949660503385, 5084.694918304914, 5192.0, 5305.1776974569, 5416.133418653036, 5662.405447428002, 5732.856678583069, 5743.54051675865, 5746.195532625436, 5768.653880767126, 6117.6023558469005, 6132.662703551303, 6144.754209831646, 6184.257889053298, 6243.032329988859, 6084.665343406111, 6135.5398345124295, 6240.126382306481, 6242.500599951993, 6280.120783090371, 5784.161296611967, 5825.650460972355, 5825.776586916711, 5858.47273745365, 5864.7067646617925, 6355.713992870332, 6370.267419246753, 6379.617222966637, 6399.488040956712, 6419.807405777834, 5987.221661184105, 6013.0980352946535, 6094.0, 6153.353897840751, 6156.722947467375, 6133.815985520441, 6201.472874805692, 6204.7828326008375, 6210.192674952227, 6225.28409232944, 6114.174586430775, 6153.784617538454, 6159.1069294951985, 6167.537434692326, 6169.5064394848305, 6061.575689701678, 6108.2813625860135, 6170.444659980533, 6172.753089876444, 6173.104899789505, 4720.976395118071, 4746.928796068062, 4768.284757286366, 4791.544803243686, 4791.904161916742, 4161.126163505637, 4196.013936724868, 4197.895052623648, 4222.556631553704, 4244.575542445731, 5830.883382332329, 5951.672658003851, 5979.641221526722, 6033.125196846433, 6034.607750496291, 6135.60118592299, 6177.69111544421, 6179.62922224668, 6190.133381326618, 6196.287426945959, 5917.378675239124, 5921.467067963904, 5943.078822782476, 5953.28560572734, 5987.760489580368, 5290.153575427913, 5333.813316533902, 5350.8662283442445, 5374.086405311028, 5377.892442151135, 6422.550421470546, 6525.412712855866, 6546.149000629887, 6569.507286953498, 6579.440747536513, 6348.301686814354, 6355.396237357444, 6359.109724638647, 6371.267304259884, 6383.872322553616, 6206.038064100072, 6350.68246587678, 6517.478601711947, 6521.478281737354, 6593.505487088583, 5954.7320370582565, 6009.819705408845, 6016.819495415145, 6038.064100064497, 6044.15381846533, 6111.960966635594, 6120.081987701702, 6123.663198524124, 6128.4790792783115, 6142.416470435302, 5964.582479226413, 5967.880642387215, 5973.074173503114, 5988.0, 6074.453299203093, 6088.5737998341465, 6151.907721384094, 6179.258488981351, 6201.782937597343, 6207.0, 6167.5374346925055, 6172.444479996821, 6175.073738939195, 6179.721912513858, 6184.845378865564, 5931.288245410578, 6061.242344706911, 6141.7543298267565, 6181.0, 6244.812655620339, 5960.165576819336, 6024.819255422344, 6059.000264956233, 6069.939300606938, 6080.452759251689], "value": 5736.251057995956, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.3424463234228, 646.3471893387679, 653.1933062667605, 662.2913482573645, 707.9221285658573, 41782.164356712885, 45574.08851822962, 45576.0, 45824.31263531045, 45899.31151032733, 47513.76243118788, 47733.28400073993, 47856.28215576761, 48164.51835481644, 48211.276830847564, 9111.0, 9212.907870921306, 9216.078392160764, 9230.16928476437, 9253.722388328328, 9173.816523669522, 9181.127792859701, 9209.539523023856, 9236.3996340238, 9263.861042084374, 9208.723738287828, 9266.629334826599, 9312.25501959845, 9318.86021709675, 9326.440413575174, 9137.588808503633, 9255.722328330161, 9264.6294148234, 9284.814303713922, 9303.116203960613, 9156.0, 9178.586963586587, 9208.631654733803, 9222.53887305632, 9271.165595096474, 45118.54881451176, 45528.31707524357, 45555.31667024997, 45589.31616025762, 45701.314480282825, 3850.5571859236265, 3952.822123004443, 4104.733192342488, 4258.339957306623, 4344.91310173798, 35929.64070359289, 36069.819650901576, 36366.27267454636, 36691.0, 36745.265094697956, 4141.855035073788, 4147.232761939051, 4157.334826427757, 4220.85227017056, 4276.3157894737005, 360725.0, 361900.0, 364461.0, 364611.0, 366075.9999999973, 64413.0, 64523.67738161279, 64930.675346622964, 64988.675056624415, 65193.67403162954, 39871.0, 40714.59285407108, 40730.0, 42851.0, 67890.0, 19859.503512412306, 19876.304329348404, 19968.400947971582, 19982.70025949612, 20035.499112522302, 14694.63263418423, 14722.043067200597, 14724.705505889822, 14726.558203253919, 14756.0, 21067.68398474024, 21117.68323475149, 21126.894365528075, 21129.26047588327, 21309.46726331854, 7198.460115491359, 7334.9266507335315, 7380.261973802577, 7443.292887175709, 7460.575313023289, 936.0966667166217, 1046.6232156423682, 1134.3477500437116, 1158.195054437158, 1195.1275568834626, 34412.65587344144, 34633.134171645404, 34689.82655086759, 34876.65123348785, 34973.47539786905, 1206.6259459567561, 1207.2032458577296, 1215.143323956626, 1255.993720031394, 1278.8017857231957, 17690.469285921445, 17967.37114201023, 18128.637427251382, 18294.451166465027, 18347.266109355478, 558512.0, 558803.0, 564527.0, 568248.0, 568880.0, 62776.37223627705, 63531.0, 63640.0, 63784.68107659525, 63833.0, 1391.290441874631, 1447.1027962663006, 1465.5969608357786, 1486.8884833637737, 1489.4414594527052, 28753.856230718713, 28879.42241155123, 28882.0, 29387.0, 29414.55878161872, 56533.434665652814, 56987.0, 57058.0, 57133.143002855824, 57208.71395642995, 367060.0, 367999.0, 368328.0, 369541.0, 371550.0, 30974.22564435907, 31124.844375777975, 31303.686963130076, 32116.839415802773, 32191.839040804647, 52479.21281180862, 53015.734921326686, 53172.202416963, 53877.46122538725, 54478.72760636172, 43542.78228608837, 46036.76981615071, 46490.35593557421, 46491.0, 46536.301955471376, 44605.0, 45432.318515222956, 45654.77172614116, 46289.305660414444, 47965.5203447961, 39502.60497395104, 44831.053802218215, 46132.769336154444, 46863.531364685914, 48245.75877120592, 38320.94175960374, 39736.80131599324, 39934.0, 39994.20011599694, 40222.0, 30527.329976061494, 30592.694073058985, 30646.233844154074, 30915.69084309128, 31012.844935775178], "value": 21335.97899141675, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.9881803545895, 395.76847544186666, 405.5336363182341, 409.6620288262184, 435.79735423028285, 19217.0, 20525.48686282844, 20806.959652017395, 20908.581828363443, 21083.262085827, 11826.349550774705, 12097.576584819511, 18319.450416487492, 20643.793562064377, 21024.0, 5340.359156901177, 5360.2763626910455, 5375.81184658537, 5383.838484845451, 5388.218708287296, 4017.5580686124504, 5179.378474583055, 5308.0, 5353.625246232766, 5662.518685911702, 5962.25471816023, 6014.939850601503, 6015.699215039231, 6033.517318614522, 6040.516758659297, 5991.0, 5998.640081595118, 6768.424683901874, 6835.213950395719, 6841.62371069591, 5816.098504731774, 6066.696665166768, 6068.393160683941, 6072.271327440735, 6075.635461872302, 13072.673183170402, 13306.467741290337, 13370.0, 13373.732525349536, 13392.995525335638, 2440.853548787061, 2467.802575793932, 2580.780633646142, 2607.4915391498475, 2834.7590454811366, 10002.749931251705, 13024.804627930589, 15040.473583424528, 15645.374185032699, 15823.683526329523, 1909.9018064612903, 2025.9696104558443, 2068.338131797825, 2091.372588223542, 2101.13853320138, 83612.99999999939, 85069.57465212696, 85270.0, 86754.0, 88916.0, 11525.081472299458, 11696.70758231034, 11816.291022538675, 11849.644510664693, 11851.111166662535, 16718.498445046425, 16733.91633041827, 16744.413945512093, 16810.411635592696, 16879.24043418049, 8486.702965396182, 8519.659213631508, 8921.330900182513, 8923.0, 9025.909740902507, 8942.46345219289, 8944.955275223712, 9057.411268267542, 9155.54222288883, 9175.128362805523, 4480.126375356775, 4557.339185818038, 4796.208625576811, 5156.355455568054, 5171.629518177686, 1742.851857592119, 1858.5260758506495, 2079.480129967508, 2090.268406057898, 2101.6112019276484, 967.8257913575624, 1029.1509504658686, 1031.3347890610664, 1037.4345981440133, 1108.6784832398675, 19338.323158689378, 20598.485037874172, 20881.0, 21044.579108417747, 21172.682409763867, 1061.7557961668706, 1069.7379142110078, 1092.9508172132273, 1098.8296813993843, 1103.1836441033577, 10671.573137074585, 11453.370064646524, 11513.88486115145, 11579.073674106052, 11623.360715160747, 495062.0, 498595.0, 503416.0, 509983.0, 510656.0, 90437.54781226051, 90535.54732226429, 92793.0, 95503.0, 96735.51632241794, 1025.9384436933658, 1036.18659352408, 1038.0346277961569, 1039.449091981251, 1046.0794500839213, 17550.210240538952, 18132.637347252716, 18333.08334583292, 18478.815211848247, 18679.813201867808, 43918.12163756643, 44923.550764493244, 45280.77359613181, 46097.769511152226, 46927.29609055799, 57932.13101803561, 61261.38738612557, 61319.38680613137, 61578.38421615906, 61997.690011549654, 7843.294103530709, 7957.482763620346, 7960.442769006114, 8213.260806527442, 8302.916970830456, 9610.567524461276, 12933.611991640266, 13199.07606467538, 13948.16311021342, 13987.370568324246, 12061.51753929868, 12294.262344259372, 12301.753964920472, 12597.0, 12757.362131893182, 12447.626571202878, 12544.749105017667, 12552.87447125517, 12565.93717031409, 12611.74776504483, 12443.75112497763, 12622.43199056063, 12645.178063425848, 12651.430685619353, 12910.708929107013, 8429.157084291523, 8490.915090849012, 8646.135386461303, 9090.09099090112, 9254.583543740413, 11722.882771172179, 11919.404029798301, 12390.690232744253, 12440.129190956546, 12491.938830092933], "value": 9501.982094030305, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1531.150211632544, 1558.8441155884414, 1722.9913850430746, 1812.2479171143975, 1828.6434145341664, 8412.327013838894, 8931.55342232889, 8946.776330591738, 9732.805343893127, 9737.07497787709, 9115.863262051074, 9355.391899526527, 9424.52877356133, 9441.433513989165, 9442.527873606326, 2467.7778999890006, 2492.264781889347, 2497.67530221071, 2502.5995840665496, 2512.6733524641772, 2443.780059794618, 2514.5222407742563, 2521.7982561395042, 2527.772500474957, 2531.227975467491, 2518.508890766301, 2529.0, 2533.075427468979, 2549.757773011561, 2550.5536531107073, 2415.4927465232236, 2426.4055306449854, 2436.0864675746593, 2506.035176457059, 2509.6988361396566, 2465.494573612423, 2468.827182097254, 2476.8761561921833, 2479.256223133053, 2480.5038992201453, 9355.578998945064, 9429.245660347156, 9448.0, 9450.716478505656, 9472.005439428898, 5604.2714447122025, 5629.971850140764, 5689.6586204827845, 5714.314282286111, 5783.739731712041, 3490.912727181815, 3523.4714792781288, 3575.910602234939, 3670.119171398872, 3686.8525258989607, 1158.3513232589776, 1198.8261702053242, 1212.4786341872991, 1217.732098938241, 1237.6596435980086, 12945.288009159493, 12987.935060324733, 13001.544945926848, 13002.544910928073, 13057.80413293792, 4855.271709243571, 4897.1674815281485, 4977.328060711758, 5009.048280826704, 5089.083964886356, 10842.40366779819, 10953.561857525769, 10987.670369888916, 10997.945010274898, 11057.834132488018, 5635.6618602883955, 5704.572157088152, 5720.570957178145, 5731.398203188689, 5745.2818397700285, 4805.8558243252755, 4997.525235102732, 5188.0, 5226.398964119099, 5315.893682126336, 4373.846915357947, 4388.648908087345, 4444.6666500012625, 4447.6219521341045, 4460.643148548108, 1366.064245991499, 1368.7467818453617, 1374.3609221711952, 1389.2220356600337, 1419.4676996126452, 1068.7969285835823, 1070.1652710885367, 1076.822324316479, 1097.8572785537829, 1104.4146602300793, 6183.227096612924, 6244.906326405107, 6402.839929001719, 6430.164078669743, 6519.4132528072705, 511.5779481927425, 515.0985774893935, 1095.90684791792, 1121.058311018732, 1143.3311512765126, 4557.635389168859, 4569.97175635486, 4621.237495813153, 4685.1332503486965, 4782.569568738831, 11629.127815413878, 11995.580154694544, 12000.759984800256, 12007.279563226235, 12072.154949153475, 11067.225294229487, 11498.195126341243, 11948.283103013848, 11973.940130299467, 11981.520739170335, 8760.95619521911, 8871.778205544784, 8901.554922253861, 8928.99999999987, 8937.821243575223, 6662.966685166543, 6749.0, 6822.658867056726, 6866.690998905161, 6905.343992320722, 10487.0, 10794.0, 11046.723831904266, 11067.889321107008, 11141.888581114084, 10715.35707857531, 11136.721581960515, 11138.832917506406, 11173.776524469302, 11287.266327689002, 7834.0599128105, 8106.8783968241705, 8298.419110662197, 8300.83398332042, 8557.786055348666, 9098.090190980849, 9132.0, 9137.954310228406, 9172.0, 9219.308551858503, 8217.219364160395, 8319.459235149696, 8329.708460203863, 8376.7905802353, 8412.284955778583, 8113.107558168715, 8183.79540511492, 8186.467879587808, 8204.261616454309, 8331.375146863887, 7456.32893039629, 7506.099268087864, 7550.433717471322, 7579.279968402993, 7579.469437139347, 5469.972650136724, 5764.250647415809, 5771.94228057714, 5820.912686309624, 5847.707614619167, 5542.528885044655, 5662.292213473316, 5673.205751194919, 5712.971435142797, 5827.863566604471], "value": 5002.628554056851, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.5113991551743, 352.1688814398021, 352.36398301066566, 356.12926394964325, 356.2003302585695, 5788.594798364116, 5792.333881603617, 5815.0, 5829.941700582993, 5929.644221346712, 5764.9135262970985, 5767.452092051259, 5798.246227990366, 5888.823335299937, 5898.262717160355, 4266.59467350602, 4445.977770111145, 4501.234790085693, 4515.3227015947705, 4537.977310113445, 4471.977640111795, 4478.126765280772, 4506.369108324837, 4525.389072475223, 4528.97735511322, 4500.0, 4523.2762757958735, 4524.5249248828895, 4537.183307004738, 4539.137563862855, 4408.470983481987, 4424.380586717862, 4447.755373454459, 4482.843100491484, 4509.774511274423, 3869.767813931145, 3874.3994680824517, 3912.197999410114, 3912.3544615138753, 3943.2902077626018, 5611.915821262684, 5649.830505084854, 5650.915236271459, 5652.123920792284, 5655.095184770417, 5033.874153146164, 5100.897982040338, 5102.698811803004, 5107.259447380146, 5182.818601348972, 6035.155078289043, 6044.788432404845, 6052.0, 6061.969690151521, 6115.960286751263, 4344.23975804233, 4383.495897971742, 4385.7149285296355, 4400.295952647593, 4419.204543182226, 6058.878822423527, 6089.634621922654, 6321.0, 6353.4281914627445, 6358.904616430711, 4396.758178300224, 4406.405135306757, 4417.867463976086, 4481.955180448153, 4491.630052833917, 4537.954620453819, 4545.8408955687055, 4545.886352841139, 4549.977250113794, 4557.088582283556, 5026.6123591293845, 5164.690118592896, 5225.947740522623, 5233.685978841282, 5245.580353571705, 6122.816315510542, 6144.109104179869, 6144.600600960924, 6146.170267013896, 6204.720787564571, 1549.4422008077083, 1562.8827837912202, 1563.1012168003444, 1563.9443375721341, 1572.7798108264851, 938.7981583959481, 984.7390441532999, 986.240594742059, 992.9524351808911, 1005.5123265216364, 5190.261262477113, 5243.239730239094, 5274.894502109936, 5294.57643388528, 5368.543673787772, 5480.835574932758, 5487.146683724441, 5490.972545137329, 5510.586705997066, 5579.0515612346, 4992.8751781205765, 5264.9736751315995, 5310.495502927216, 5336.67979921206, 5340.49265319794, 2952.320966177791, 2966.5846781450614, 2982.746466550324, 2983.7165469280385, 3005.233665415305, 5519.779208831602, 5721.77112915487, 5725.255716756795, 5771.567132465082, 5791.552111972007, 5358.19627055937, 5511.779528818803, 5589.0, 5595.412481689364, 5610.607257491936, 5694.4590263924865, 5723.846864620549, 5731.283589551223, 5741.741621627037, 5773.797917072882, 5328.0, 5408.269883565668, 5449.7275136243825, 5452.372977107525, 5532.399772107104, 5369.570434365163, 5399.055165346127, 5403.7838486460105, 5412.648177868426, 5424.972875135599, 6241.21984751906, 6258.499320054294, 6436.8390790230615, 6486.054183744952, 6488.923544465726, 4415.315626077963, 4430.645548356059, 4437.800298986618, 4471.374007638999, 4522.186006518858, 6181.381861813962, 6256.280527739186, 6257.186565746424, 6422.389872962061, 6450.774222902176, 6049.485793707584, 6070.7875224366935, 6071.666058366833, 6079.209702738793, 6100.511959043355, 5827.329857066492, 6078.483328917092, 6085.361037091042, 6126.846828829315, 6167.969160154171, 5998.890205312031, 6039.792041591611, 6088.4215999479975, 6089.0, 6106.664133472702, 6073.514118870391, 6114.694265286629, 6135.233095863017, 6135.969320153371, 6138.570300078952, 5783.652980821164, 5956.642601443928, 5961.390424585425, 5988.760449581968, 6007.939920600913], "value": 4494.9059956826, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.7959530522064, 819.4264015189369, 842.9199226073524, 890.5369208011834, 914.8399030169719, 13622.863771362283, 17105.572360690974, 17147.228374723138, 17279.654406911854, 17352.392666256685, 15248.161351125684, 15532.068075915453, 15672.0, 15722.842771572281, 15766.605834854134, 869.1742844297927, 887.9378443508957, 889.0, 891.3448615267773, 892.3575025981315, 863.5078005536847, 868.1708967935638, 868.3487384461654, 868.4919322196523, 868.8957325120963, 931.3806318797991, 935.5135329628589, 935.5602866652696, 935.8830146231721, 938.3290946972913, 911.4030310146865, 918.2286879021588, 920.7099763574453, 923.6859467780953, 926.3098991251493, 677.7593954146306, 686.5674624986227, 686.9278725733776, 687.1067612104295, 687.6458623808743, 13552.864471355357, 13574.457021719218, 13669.726605467835, 13677.521286754916, 13692.110012849133, 13648.658783530393, 14127.788083178657, 14611.0, 14626.707465850623, 14873.0, 11645.301281923112, 12591.496340146383, 12852.55016074433, 12927.87072129276, 13038.282894440801, 4807.302941073524, 4864.343313652683, 4883.926741098886, 4938.38270216223, 4998.500149985009, 80921.19078809254, 81243.0, 82109.0, 83565.0, 83837.58081209616, 12077.818832717516, 12338.753224935452, 12363.134580579454, 12418.627441176779, 12513.562025329069, 22281.777182228296, 22295.665565016538, 22299.777002230094, 22444.55110897773, 22500.32499025032, 9162.083791620918, 9324.393914395543, 9384.62461501546, 9413.76465588352, 9432.056794320513, 5217.6347655664495, 5239.371275446894, 5290.391604965478, 5332.093544097513, 5422.8915421691345, 4044.6359827615656, 4148.730332528376, 4204.642605378516, 4204.747715137101, 4208.0, 684.5995092870627, 691.1257259566652, 694.1689805632725, 697.3235961117708, 716.8566286742672, 796.7530065679658, 817.4604760857806, 819.1194465949128, 820.3150369441464, 859.9484030958163, 8428.620712067972, 10477.476126193813, 10527.947360263302, 10627.681169564925, 10812.297200681931, 718.9245129261457, 787.8345547435102, 813.3655748516167, 819.9877001844977, 846.4667259626395, 4893.363862697826, 5073.797048118034, 5089.262057001714, 5103.209002604528, 5110.2590124431745, 73312.26687733055, 73864.63067684627, 87367.0, 125985.0, 129283.0, 77818.0, 92417.0, 94625.0, 107511.46244268885, 108555.0, 86523.0, 87734.0, 90038.0, 92510.07489925149, 94691.05308946823, 10072.54673539707, 10230.181585472996, 10302.33034852732, 10379.429131397847, 10448.283446303863, 39439.408408873314, 42243.0, 51104.0, 51250.0, 52545.737271313395, 72753.63623182062, 75613.0, 80913.59543202247, 81058.59470702845, 81742.59128704318, 13663.111897726616, 14011.649708757363, 14242.857571424152, 14394.568162955127, 14618.707625847635, 15316.693666126392, 17047.829521704625, 17079.40222092221, 17205.741913871552, 18091.36680216186, 14410.207438590558, 14736.410543578137, 14792.334344954717, 14840.10959342443, 15206.315715792594, 12941.676458088623, 14223.933205009458, 14245.0, 14299.920544892102, 14596.562103136923, 13428.93285533566, 14127.505537306144, 14580.416783328548, 14633.122012678847, 15438.5368438947, 11607.355391573543, 11651.76696466049, 11740.06079513654, 11870.643880683594, 12174.391280435766, 11559.30644161353, 11774.470148843151, 12052.638420847388, 12058.879411205775, 12248.938755306523], "value": 8068.488314901851, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1501.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 106.0, 110.0, 111.0, 110.0, 111.0, 110.0, 111.0, 112.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 142.0, 169.0, 119.0, 144.0, 150.0, 122.0, 178.0, 120.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 165.0, 163.0, 162.0, 162.0, 163.0, 162.0, 163.0, 167.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 173.0, 75.0, 76.0, 75.0, 76.0, 165.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 144.0, 86.0, 87.0, 85.0, 138.0, 87.0, 84.0, 136.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 121.0, 117.0, 120.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 148.0, 148.0, 149.0, 150.0, 147.0, 148.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 59.0, 52.0, 52.0, 52.0, 54.0, 53.0, 51.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 60.0, 61.0, 60.0, 60.0, 60.0, 61.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 81.0, 81.0, 77.0, 72.0, 78.0, 71.0, 83.0, 78.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 117.0, 129.0, 125.0, 118.0, 118.0, 127.0, 120.0, 145.0, 129.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 153.0, 152.0, 151.0, 152.0, 152.0, 152.0, 154.0, 156.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 61.0, 65.0, 62.0, 63.0, 62.0, 62.0, 63.0], "value": 62.4, "unit": "score"}]}]} 22:33:25 INFO - Return code: 0 22:33:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:33:25 ERROR - # TBPL SUCCESS # 22:33:25 INFO - Running post-action listener: _resource_record_post_action 22:33:25 INFO - [mozharness: 2016-09-07 05:33:25.385223Z] Finished run-tests step (success) 22:33:25 INFO - Running post-run listener: _resource_record_post_run 22:33:25 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 329039872; Read time: 0; Write time: 305888 22:33:25 INFO - TinderboxPrint: CPU usage
13.3% 22:33:25 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:33:25 INFO - TinderboxPrint: I/O write bytes / time
329,039,872 / 305,888 22:33:25 INFO - TinderboxPrint: CPU idle
8,216.5 (86.7%) 22:33:25 INFO - TinderboxPrint: CPU user
1,205.0 (12.7%) 22:33:25 INFO - TinderboxPrint: Swap in / out
0 / 0 22:33:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 78606336; Read time: 0; Write time: 116352 22:33:25 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 249905152; Read time: 0; Write time: 189476 22:33:26 INFO - Running post-run listener: _upload_blobber_files 22:33:26 INFO - Blob upload gear active. 22:33:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:33:26 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 22:33:26 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:33:26 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:33:26 INFO - (blobuploader) - INFO - Open directory for files ... 22:33:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:33:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:33:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:27 INFO - (blobuploader) - INFO - Done attempting. 22:33:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:33:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:33:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:30 INFO - (blobuploader) - INFO - Done attempting. 22:33:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:33:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:33:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:31 INFO - (blobuploader) - INFO - Done attempting. 22:33:31 INFO - (blobuploader) - INFO - Iteration through files over. 22:33:31 INFO - Return code: 0 22:33:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:33:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:33:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1fa3a6326d771c084df456e4c7a291aefdc4e6c4cfc8849a2ab5121ca5d90a6a1356df5a651efefda78c770d8e4aecf586f798580c6a43015f0f6f830ffca7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea792beea076317ebd4fe1b61636a73a08c020c774479cc6d7575c82d74e87a1cae1d2d67310b43bef892b2c03a3afa13167601b6abc37d284fe41738736d00b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5450dec6e3234b860ac3a3975f694ac0d2eb2f3d33365c4f3858f187abcf030c02c3f7c39739943d763e7885a42b0e369afd010c4331523e5eef7c128fd0c9f8"} 22:33:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:33:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:33:31 INFO - Contents: 22:33:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1fa3a6326d771c084df456e4c7a291aefdc4e6c4cfc8849a2ab5121ca5d90a6a1356df5a651efefda78c770d8e4aecf586f798580c6a43015f0f6f830ffca7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea792beea076317ebd4fe1b61636a73a08c020c774479cc6d7575c82d74e87a1cae1d2d67310b43bef892b2c03a3afa13167601b6abc37d284fe41738736d00b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5450dec6e3234b860ac3a3975f694ac0d2eb2f3d33365c4f3858f187abcf030c02c3f7c39739943d763e7885a42b0e369afd010c4331523e5eef7c128fd0c9f8"} 22:33:31 INFO - Running post-run listener: copy_logs_to_upload_dir 22:33:31 INFO - Copying logs to upload dir... 22:33:31 INFO - mkdir: /builds/slave/test/build/upload/logs 22:33:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1676.263745 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-09-06 22:33:31.377998) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-06 22:33:31.381857) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508 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/Mozilla-Aurora/sha512/e1fa3a6326d771c084df456e4c7a291aefdc4e6c4cfc8849a2ab5121ca5d90a6a1356df5a651efefda78c770d8e4aecf586f798580c6a43015f0f6f830ffca7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea792beea076317ebd4fe1b61636a73a08c020c774479cc6d7575c82d74e87a1cae1d2d67310b43bef892b2c03a3afa13167601b6abc37d284fe41738736d00b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5450dec6e3234b860ac3a3975f694ac0d2eb2f3d33365c4f3858f187abcf030c02c3f7c39739943d763e7885a42b0e369afd010c4331523e5eef7c128fd0c9f8"} build_url:https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/anuEFSGWQbyDmDSOCi7a7g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1fa3a6326d771c084df456e4c7a291aefdc4e6c4cfc8849a2ab5121ca5d90a6a1356df5a651efefda78c770d8e4aecf586f798580c6a43015f0f6f830ffca7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea792beea076317ebd4fe1b61636a73a08c020c774479cc6d7575c82d74e87a1cae1d2d67310b43bef892b2c03a3afa13167601b6abc37d284fe41738736d00b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5450dec6e3234b860ac3a3975f694ac0d2eb2f3d33365c4f3858f187abcf030c02c3f7c39739943d763e7885a42b0e369afd010c4331523e5eef7c128fd0c9f8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-06 22:33:31.407706) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 22:33:31.408077) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1473224414.873862-1226804508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 22:33:31.495885) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-06 22:33:31.496476) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-06 22:33:31.497011) ========= ========= Total master_lag: 0.17 =========