builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1470499153.14 results: success (0) buildid: 20160805072232 builduid: 16f5b19919d6424fb6c268c5705c0fd7 revision: 307fe134b473938131cb0f28db52cf371883f663 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.143135) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.143622) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.143901) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.197462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.197735) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-06 08:59:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.3M=0s 2016-08-06 08:59:14 (69.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135698 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.353955) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.354247) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019893 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.403687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.404014) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 307fe134b473938131cb0f28db52cf371883f663 --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 307fe134b473938131cb0f28db52cf371883f663 --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=e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-06 08:59:14,170 truncating revision to first 12 chars 2016-08-06 08:59:14,171 Setting DEBUG logging. 2016-08-06 08:59:14,171 attempt 1/10 2016-08-06 08:59:14,171 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/307fe134b473?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-06 08:59:14,486 unpacking tar archive at: mozilla-aurora-307fe134b473/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661113 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:14.079195) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:14.079504) ========= script_repo_revision: 307fe134b473938131cb0f28db52cf371883f663 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:14.080096) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:14.080379) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:14.097917) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-08-06 08:59:14.098197) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:59:14 INFO - MultiFileLogger online at 20160806 08:59:14 in /builds/slave/test 08:59:14 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 08:59:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:59:14 INFO - {'append_to_log': False, 08:59:14 INFO - 'base_work_dir': '/builds/slave/test', 08:59:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:59:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:59:14 INFO - 'branch': 'Mozilla-Aurora', 08:59:14 INFO - 'buildbot_json_path': 'buildprops.json', 08:59:14 INFO - 'config_files': ('talos/linux_config.py',), 08:59:14 INFO - 'default_actions': ('clobber', 08:59:14 INFO - 'read-buildbot-config', 08:59:14 INFO - 'download-and-extract', 08:59:14 INFO - 'populate-webroot', 08:59:14 INFO - 'create-virtualenv', 08:59:14 INFO - 'install', 08:59:14 INFO - 'run-tests'), 08:59:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:59:14 INFO - 'download_minidump_stackwalk': True, 08:59:14 INFO - 'download_symbols': 'ondemand', 08:59:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:59:14 INFO - 'tooltool.py': '/tools/tooltool.py', 08:59:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:59:14 INFO - '/tools/misc-python/virtualenv.py')}, 08:59:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:59:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:59:14 INFO - 'installer_path': 'installer.exe', 08:59:14 INFO - 'log_level': 'info', 08:59:14 INFO - 'log_name': 'talos', 08:59:14 INFO - 'log_to_console': True, 08:59:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:59:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:59:14 INFO - 'opt_config_files': (), 08:59:14 INFO - 'pip_index': False, 08:59:14 INFO - 'sps_profile': False, 08:59:14 INFO - 'sps_profile_interval': 0, 08:59:14 INFO - 'suite': 'dromaeojs-e10s', 08:59:14 INFO - 'system_bits': '32', 08:59:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:59:14 INFO - 'title': 'talos-linux64-ix-006', 08:59:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:59:14 INFO - 'use_talos_json': True, 08:59:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:59:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:59:14 INFO - 'work_dir': 'build'} 08:59:14 INFO - [mozharness: 2016-08-06 15:59:14.955633Z] Running clobber step. 08:59:14 INFO - Running pre-action listener: _resource_record_pre_action 08:59:14 INFO - Running main action method: clobber 08:59:14 INFO - rmtree: /builds/slave/test/build 08:59:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:59:15 INFO - Running post-action listener: _resource_record_post_action 08:59:15 INFO - [mozharness: 2016-08-06 15:59:15.419528Z] Finished clobber step (success) 08:59:15 INFO - [mozharness: 2016-08-06 15:59:15.419629Z] Running read-buildbot-config step. 08:59:15 INFO - Running pre-action listener: _resource_record_pre_action 08:59:15 INFO - Running main action method: read_buildbot_config 08:59:15 INFO - Using buildbot properties: 08:59:15 INFO - { 08:59:15 INFO - "project": "", 08:59:15 INFO - "product": "firefox", 08:59:15 INFO - "script_repo_revision": "production", 08:59:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 08:59:15 INFO - "repository": "", 08:59:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 08:59:15 INFO - "buildid": "20160805072232", 08:59:15 INFO - "pgo_build": "True", 08:59:15 INFO - "basedir": "/builds/slave/test", 08:59:15 INFO - "buildnumber": 443, 08:59:15 INFO - "slavename": "talos-linux64-ix-006", 08:59:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:59:15 INFO - "platform": "ubuntu64_hw", 08:59:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:59:15 INFO - "branch": "mozilla-aurora", 08:59:15 INFO - "repo_path": "releases/mozilla-aurora", 08:59:15 INFO - "revision": "307fe134b473938131cb0f28db52cf371883f663", 08:59:15 INFO - "stage_platform": "linux64-pgo", 08:59:15 INFO - "builduid": "16f5b19919d6424fb6c268c5705c0fd7", 08:59:15 INFO - "slavebuilddir": "test" 08:59:15 INFO - } 08:59:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 08:59:15 INFO - Running post-action listener: _resource_record_post_action 08:59:15 INFO - [mozharness: 2016-08-06 15:59:15.422051Z] Finished read-buildbot-config step (success) 08:59:15 INFO - [mozharness: 2016-08-06 15:59:15.422139Z] Running download-and-extract step. 08:59:15 INFO - Running pre-action listener: _resource_record_pre_action 08:59:15 INFO - Running main action method: download_and_extract 08:59:15 INFO - mkdir: /builds/slave/test/build/tests 08:59:15 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')]} 08:59:15 INFO - https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:59:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:59:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:59:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 08:59:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 08:59:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:59:15 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:59:15 INFO - retry: Failed, sleeping 30 seconds before retrying 08:59:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 08:59:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:59:45 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:59:45 INFO - retry: Failed, sleeping 60 seconds before retrying 09:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:00:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 09:00:45 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:00:45 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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! 09:00:45 INFO - Caught exception: HTTP Error 404: Not Found 09:00:45 INFO - Caught exception: HTTP Error 404: Not Found 09:00:45 INFO - Caught exception: HTTP Error 404: Not Found 09:00:45 INFO - trying https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 09:00:45 INFO - Downloading https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:00:46 INFO - Downloaded 1361 bytes. 09:00:46 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 09:00:46 INFO - Using the following test package requirements: 09:00:46 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 09:00:46 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:46 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:00:46 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:46 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:00:46 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:46 INFO - u'jsshell-linux-x86_64.zip'], 09:00:46 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:46 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:00:46 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 09:00:46 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:46 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:00:46 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:46 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:00:46 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:46 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:00:46 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:46 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:00:46 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:00:46 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')]} 09:00:46 INFO - https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:00:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:00:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:00:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:00:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:00:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:00:46 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:00:46 INFO - retry: Failed, sleeping 30 seconds before retrying 09:01:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:01:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:01:16 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:01:16 INFO - retry: Failed, sleeping 60 seconds before retrying 09:02:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:02:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:02:16 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:02:16 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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! 09:02:16 INFO - Caught exception: HTTP Error 404: Not Found 09:02:16 INFO - Caught exception: HTTP Error 404: Not Found 09:02:16 INFO - Caught exception: HTTP Error 404: Not Found 09:02:16 INFO - trying https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:02:16 INFO - Downloading https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:02:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:02:17 INFO - Downloaded 21765973 bytes. 09:02:17 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'] 09:02:17 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 09:02:18 INFO - Return code: 0 09:02:18 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 09:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:18 INFO - https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:02:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:02:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:02:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:02:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:02:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:02:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:02:18 INFO - retry: Failed, sleeping 30 seconds before retrying 09:02:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:02:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:02:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:02:48 INFO - retry: Failed, sleeping 60 seconds before retrying 09:03:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:03:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:03:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:03:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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! 09:03:48 INFO - Caught exception: HTTP Error 404: Not Found 09:03:48 INFO - Caught exception: HTTP Error 404: Not Found 09:03:48 INFO - Caught exception: HTTP Error 404: Not Found 09:03:48 INFO - trying https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:03:48 INFO - Downloading https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:03:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:03:49 INFO - Downloaded 21765973 bytes. 09:03:49 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'] 09:03:49 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 09:03:51 INFO - Return code: 0 09:03:51 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')]} 09:03:51 INFO - https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:03:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 09:03:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 09:03:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:03:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:03:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 09:03:51 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:03:51 INFO - retry: Failed, sleeping 30 seconds before retrying 09:04:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:04:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 09:04:21 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:04:21 INFO - retry: Failed, sleeping 60 seconds before retrying 09:05:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:05:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 09:05:21 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:05:21 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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! 09:05:21 INFO - Caught exception: HTTP Error 404: Not Found 09:05:21 INFO - Caught exception: HTTP Error 404: Not Found 09:05:21 INFO - Caught exception: HTTP Error 404: Not Found 09:05:21 INFO - trying https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 09:05:21 INFO - Downloading https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:05:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:05:22 INFO - Downloaded 14413723 bytes. 09:05:22 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'] 09:05:22 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 09:05:22 INFO - Return code: 0 09:05: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')]} 09:05:22 INFO - https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:05:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:05:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:05:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:05:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:05:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:05:22 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:05:22 INFO - retry: Failed, sleeping 30 seconds before retrying 09:05:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:05:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:05:52 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:05:52 INFO - retry: Failed, sleeping 60 seconds before retrying 09:06:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:06:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:06:52 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:06:52 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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! 09:06:52 INFO - Caught exception: HTTP Error 404: Not Found 09:06:52 INFO - Caught exception: HTTP Error 404: Not Found 09:06:52 INFO - Caught exception: HTTP Error 404: Not Found 09:06:52 INFO - trying https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:06:52 INFO - Downloading https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:06:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:06:54 INFO - Downloaded 63764898 bytes. 09:06:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:06:54 INFO - mkdir: /builds/slave/test/properties 09:06:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:06:54 INFO - Writing to file /builds/slave/test/properties/build_url 09:06:54 INFO - Contents: 09:06:54 INFO - build_url:https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:06:54 INFO - Running post-action listener: _resource_record_post_action 09:06:54 INFO - Running post-action listener: set_extra_try_arguments 09:06:54 INFO - [mozharness: 2016-08-06 16:06:54.730067Z] Finished download-and-extract step (success) 09:06:54 INFO - [mozharness: 2016-08-06 16:06:54.730299Z] Running populate-webroot step. 09:06:54 INFO - Running pre-action listener: _resource_record_pre_action 09:06:54 INFO - Running main action method: populate_webroot 09:06:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:06:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:06:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:06:54 INFO - '--tppagecycles', 09:06:54 INFO - '7'], 09:06:54 INFO - 'tests': ['tsvgm']}}, 09:06:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:06:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:06:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:06:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:06:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:06:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:06:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:54 INFO - 'talos_options': ['--disable-e10s'], 09:06:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:54 INFO - 'talos_options': ['--disable-e10s'], 09:06:54 INFO - 'tests': ['damp', 'tps']}, 09:06:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:54 INFO - 'tests': ['damp', 'tps']}, 09:06:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:06:54 INFO - 'tests': ['dromaeo_dom']}, 09:06:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:06:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:06:54 INFO - 'tests': ['basic_compositor_video']}, 09:06:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:06:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:06:54 INFO - 'tests': ['a11yr', 09:06:54 INFO - 'ts_paint', 09:06:54 INFO - 'tpaint', 09:06:54 INFO - 'sessionrestore', 09:06:54 INFO - 'sessionrestore_no_auto_restore', 09:06:54 INFO - 'tabpaint']}, 09:06:54 INFO - 'other-e10s': {'tests': ['a11yr', 09:06:54 INFO - 'ts_paint', 09:06:54 INFO - 'tpaint', 09:06:54 INFO - 'sessionrestore', 09:06:54 INFO - 'sessionrestore_no_auto_restore', 09:06:54 INFO - 'tabpaint']}, 09:06:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:06:54 INFO - 'ts_paint', 09:06:54 INFO - 'tpaint', 09:06:54 INFO - 'sessionrestore', 09:06:54 INFO - 'sessionrestore_no_auto_restore', 09:06:54 INFO - 'tabpaint']}, 09:06:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:06:54 INFO - 'ts_paint', 09:06:54 INFO - 'tpaint', 09:06:54 INFO - 'sessionrestore', 09:06:54 INFO - 'sessionrestore_no_auto_restore', 09:06:54 INFO - 'tabpaint']}, 09:06:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:06:54 INFO - 'tests': ['a11yr', 09:06:54 INFO - 'ts_paint', 09:06:54 INFO - 'tpaint', 09:06:54 INFO - 'sessionrestore', 09:06:54 INFO - 'sessionrestore_no_auto_restore', 09:06:54 INFO - 'tabpaint']}, 09:06:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:06:54 INFO - 'tests': ['a11yr', 09:06:54 INFO - 'ts_paint', 09:06:54 INFO - 'tpaint', 09:06:54 INFO - 'sessionrestore', 09:06:54 INFO - 'sessionrestore_no_auto_restore', 09:06:54 INFO - 'tabpaint']}, 09:06:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:06:54 INFO - 'tests': ['tsvgx', 09:06:54 INFO - 'tsvgr_opacity', 09:06:54 INFO - 'tart', 09:06:54 INFO - 'tscrollx', 09:06:54 INFO - 'cart']}, 09:06:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:06:54 INFO - 'tsvgr_opacity', 09:06:54 INFO - 'tart', 09:06:54 INFO - 'tscrollx', 09:06:54 INFO - 'cart']}, 09:06:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:54 INFO - 'talos_options': ['--disable-e10s'], 09:06:54 INFO - 'tests': ['tp5o']}, 09:06:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:54 INFO - 'tests': ['tp5o']}, 09:06:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:54 INFO - 'talos_options': ['--disable-e10s', 09:06:54 INFO - '--xperf_path', 09:06:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:54 INFO - 'tests': ['tp5n']}, 09:06:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:54 INFO - 'talos_options': ['--xperf_path', 09:06:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:54 INFO - 'tests': ['tp5n']}}, 09:06:54 INFO - 'talos.zip': {'path': '', 09:06:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:06:54 INFO - Running post-action listener: _resource_record_post_action 09:06:54 INFO - [mozharness: 2016-08-06 16:06:54.751833Z] Finished populate-webroot step (success) 09:06:54 INFO - [mozharness: 2016-08-06 16:06:54.751922Z] Running create-virtualenv step. 09:06:54 INFO - Running pre-action listener: _resource_record_pre_action 09:06:54 INFO - Running main action method: create_virtualenv 09:06:54 INFO - Creating virtualenv /builds/slave/test/build/venv 09:06:54 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 09:06:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:06:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:06:54 INFO - Using real prefix '/usr' 09:06:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:06:55 INFO - Installing distribute.............................................................................................................................................................................................done. 09:06:57 INFO - Installing pip.................done. 09:06:57 INFO - Return code: 0 09:06:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:57 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e2570>, '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 0x17e3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', '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 09:06:57 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 09:06:57 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 09:06:57 INFO - Using env: {'DISPLAY': ':0', 09:06:57 INFO - 'HOME': '/home/cltbld', 09:06:57 INFO - 'LANG': 'en_US.UTF-8', 09:06:57 INFO - 'LANGUAGE': 'en_US:en', 09:06:57 INFO - 'LOGNAME': 'cltbld', 09:06:57 INFO - 'MAIL': '/var/mail/cltbld', 09:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:57 INFO - 'MOZ_NO_REMOTE': '1', 09:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:57 INFO - 'NO_EM_RESTART': '1', 09:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:57 INFO - 'PWD': '/builds/slave/test', 09:06:57 INFO - 'SHELL': '/bin/bash', 09:06:57 INFO - 'SHLVL': '1', 09:06:57 INFO - 'TERM': 'linux', 09:06:57 INFO - 'TMOUT': '86400', 09:06:57 INFO - 'USER': 'cltbld', 09:06:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', 09:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:57 INFO - '_': '/tools/buildbot/bin/python'} 09:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:57 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 09:06:57 INFO - Cleaning up... 09:06:57 INFO - Return code: 0 09:06:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:57 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e2570>, '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 0x17e3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', '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 09:06:57 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 09:06:57 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 09:06:57 INFO - Using env: {'DISPLAY': ':0', 09:06:57 INFO - 'HOME': '/home/cltbld', 09:06:57 INFO - 'LANG': 'en_US.UTF-8', 09:06:57 INFO - 'LANGUAGE': 'en_US:en', 09:06:57 INFO - 'LOGNAME': 'cltbld', 09:06:57 INFO - 'MAIL': '/var/mail/cltbld', 09:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:57 INFO - 'MOZ_NO_REMOTE': '1', 09:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:57 INFO - 'NO_EM_RESTART': '1', 09:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:57 INFO - 'PWD': '/builds/slave/test', 09:06:57 INFO - 'SHELL': '/bin/bash', 09:06:57 INFO - 'SHLVL': '1', 09:06:57 INFO - 'TERM': 'linux', 09:06:57 INFO - 'TMOUT': '86400', 09:06:57 INFO - 'USER': 'cltbld', 09:06:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', 09:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:57 INFO - '_': '/tools/buildbot/bin/python'} 09:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:57 INFO - Downloading/unpacking psutil>=3.1.1 09:06:57 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 09:06:57 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 09:06:57 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 09:06:57 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 09:06:57 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 09:06:57 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 09:06:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:06:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:59 INFO - Installing collected packages: psutil 09:06:59 INFO - Running setup.py install for psutil 09:06:59 INFO - building 'psutil._psutil_linux' extension 09:06:59 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 09:06:59 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 09:07:00 INFO - building 'psutil._psutil_posix' extension 09:07:00 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 09:07:00 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 09:07:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:00 INFO - Successfully installed psutil 09:07:00 INFO - Cleaning up... 09:07:00 INFO - Return code: 0 09:07:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:07:00 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')]} 09:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:00 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')]} 09:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e2570>, '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 0x17e3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', '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 09:07:00 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 09:07:00 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 09:07:00 INFO - Using env: {'DISPLAY': ':0', 09:07:00 INFO - 'HOME': '/home/cltbld', 09:07:00 INFO - 'LANG': 'en_US.UTF-8', 09:07:00 INFO - 'LANGUAGE': 'en_US:en', 09:07:00 INFO - 'LOGNAME': 'cltbld', 09:07:00 INFO - 'MAIL': '/var/mail/cltbld', 09:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:00 INFO - 'MOZ_NO_REMOTE': '1', 09:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:00 INFO - 'NO_EM_RESTART': '1', 09:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:00 INFO - 'PWD': '/builds/slave/test', 09:07:00 INFO - 'SHELL': '/bin/bash', 09:07:00 INFO - 'SHLVL': '1', 09:07:00 INFO - 'TERM': 'linux', 09:07:00 INFO - 'TMOUT': '86400', 09:07:00 INFO - 'USER': 'cltbld', 09:07:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', 09:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:00 INFO - '_': '/tools/buildbot/bin/python'} 09:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:07:00 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 09:07:00 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 09:07:00 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 09:07:00 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 09:07:00 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 09:07:00 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 09:07:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:07:02 INFO - Installing collected packages: mozsystemmonitor 09:07:02 INFO - Running setup.py install for mozsystemmonitor 09:07:02 INFO - Successfully installed mozsystemmonitor 09:07:02 INFO - Cleaning up... 09:07:02 INFO - Return code: 0 09:07:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:07:02 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')]} 09:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:02 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')]} 09:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:02 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e2570>, '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 0x17e3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', '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 09:07:02 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 09:07:02 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 09:07:02 INFO - Using env: {'DISPLAY': ':0', 09:07:02 INFO - 'HOME': '/home/cltbld', 09:07:02 INFO - 'LANG': 'en_US.UTF-8', 09:07:02 INFO - 'LANGUAGE': 'en_US:en', 09:07:02 INFO - 'LOGNAME': 'cltbld', 09:07:02 INFO - 'MAIL': '/var/mail/cltbld', 09:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:02 INFO - 'MOZ_NO_REMOTE': '1', 09:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:02 INFO - 'NO_EM_RESTART': '1', 09:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:02 INFO - 'PWD': '/builds/slave/test', 09:07:02 INFO - 'SHELL': '/bin/bash', 09:07:02 INFO - 'SHLVL': '1', 09:07:02 INFO - 'TERM': 'linux', 09:07:02 INFO - 'TMOUT': '86400', 09:07:02 INFO - 'USER': 'cltbld', 09:07:02 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', 09:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:02 INFO - '_': '/tools/buildbot/bin/python'} 09:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:02 INFO - Downloading/unpacking jsonschema==2.5.1 09:07:02 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 09:07:02 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 09:07:02 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 09:07:02 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 09:07:02 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 09:07:02 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 09:07:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:07:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:07:04 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 09:07:04 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 09:07:04 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 09:07:04 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 09:07:04 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 09:07:04 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 09:07:04 INFO - Downloading functools32-3.2.3-2.tar.gz 09:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:07:04 INFO - warning: no files found matching '*.txt' 09:07:04 INFO - no previously-included directories found matching 'build' 09:07:04 INFO - no previously-included directories found matching 'dist' 09:07:04 INFO - no previously-included directories found matching '.git*' 09:07:04 INFO - Installing collected packages: jsonschema, functools32 09:07:05 INFO - Running setup.py install for functools32 09:07:05 INFO - warning: no files found matching '*.txt' 09:07:05 INFO - no previously-included directories found matching 'build' 09:07:05 INFO - no previously-included directories found matching 'dist' 09:07:05 INFO - no previously-included directories found matching '.git*' 09:07:05 INFO - Successfully installed jsonschema functools32 09:07:05 INFO - Cleaning up... 09:07:05 INFO - Return code: 0 09:07:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:05 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e2570>, '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 0x17e3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', '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 09:07:05 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 09:07:05 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 09:07:05 INFO - Using env: {'DISPLAY': ':0', 09:07:05 INFO - 'HOME': '/home/cltbld', 09:07:05 INFO - 'LANG': 'en_US.UTF-8', 09:07:05 INFO - 'LANGUAGE': 'en_US:en', 09:07:05 INFO - 'LOGNAME': 'cltbld', 09:07:05 INFO - 'MAIL': '/var/mail/cltbld', 09:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:05 INFO - 'MOZ_NO_REMOTE': '1', 09:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:05 INFO - 'NO_EM_RESTART': '1', 09:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:05 INFO - 'PWD': '/builds/slave/test', 09:07:05 INFO - 'SHELL': '/bin/bash', 09:07:05 INFO - 'SHLVL': '1', 09:07:05 INFO - 'TERM': 'linux', 09:07:05 INFO - 'TMOUT': '86400', 09:07:05 INFO - 'USER': 'cltbld', 09:07:05 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', 09:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:05 INFO - '_': '/tools/buildbot/bin/python'} 09:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:07:05 INFO - Cleaning up... 09:07:05 INFO - Return code: 0 09:07:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:05 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e2570>, '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 0x17e3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', '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 09:07:05 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 09:07:05 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 09:07:05 INFO - Using env: {'DISPLAY': ':0', 09:07:05 INFO - 'HOME': '/home/cltbld', 09:07:05 INFO - 'LANG': 'en_US.UTF-8', 09:07:05 INFO - 'LANGUAGE': 'en_US:en', 09:07:05 INFO - 'LOGNAME': 'cltbld', 09:07:05 INFO - 'MAIL': '/var/mail/cltbld', 09:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:05 INFO - 'MOZ_NO_REMOTE': '1', 09:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:05 INFO - 'NO_EM_RESTART': '1', 09:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:05 INFO - 'PWD': '/builds/slave/test', 09:07:05 INFO - 'SHELL': '/bin/bash', 09:07:05 INFO - 'SHLVL': '1', 09:07:05 INFO - 'TERM': 'linux', 09:07:05 INFO - 'TMOUT': '86400', 09:07:05 INFO - 'USER': 'cltbld', 09:07:05 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', 09:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:05 INFO - '_': '/tools/buildbot/bin/python'} 09:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:05 INFO - Downloading/unpacking blobuploader==1.2.4 09:07:05 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 09:07:05 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 09:07:05 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 09:07:05 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 09:07:05 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 09:07:05 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 09:07:07 INFO - Downloading blobuploader-1.2.4.tar.gz 09:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:07:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:07:07 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 09:07:07 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 09:07:07 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 09:07:07 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 09:07:07 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 09:07:07 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 09:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:07:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:07:07 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 09:07:07 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 09:07:07 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 09:07:07 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 09:07:07 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 09:07:07 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 09:07:08 INFO - Downloading docopt-0.6.1.tar.gz 09:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:07:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:07:08 INFO - Running setup.py install for blobuploader 09:07:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:07:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:07:08 INFO - Running setup.py install for requests 09:07:08 INFO - Running setup.py install for docopt 09:07:08 INFO - Successfully installed blobuploader requests docopt 09:07:08 INFO - Cleaning up... 09:07:08 INFO - Return code: 0 09:07:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:08 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e2570>, '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 0x17e3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', '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 09:07:08 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 09:07:08 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 09:07:08 INFO - Using env: {'DISPLAY': ':0', 09:07:08 INFO - 'HOME': '/home/cltbld', 09:07:08 INFO - 'LANG': 'en_US.UTF-8', 09:07:08 INFO - 'LANGUAGE': 'en_US:en', 09:07:08 INFO - 'LOGNAME': 'cltbld', 09:07:08 INFO - 'MAIL': '/var/mail/cltbld', 09:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:08 INFO - 'MOZ_NO_REMOTE': '1', 09:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:08 INFO - 'NO_EM_RESTART': '1', 09:07:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:08 INFO - 'PWD': '/builds/slave/test', 09:07:08 INFO - 'SHELL': '/bin/bash', 09:07:08 INFO - 'SHLVL': '1', 09:07:08 INFO - 'TERM': 'linux', 09:07:08 INFO - 'TMOUT': '86400', 09:07:08 INFO - 'USER': 'cltbld', 09:07:08 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', 09:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:08 INFO - '_': '/tools/buildbot/bin/python'} 09:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:09 INFO - Running setup.py (path:/tmp/pip-B9fPh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:09 INFO - Running setup.py (path:/tmp/pip-Zstj61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:09 INFO - Running setup.py (path:/tmp/pip-ygXrn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:09 INFO - Running setup.py (path:/tmp/pip-FcDsMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:09 INFO - Running setup.py (path:/tmp/pip-LAnvcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:09 INFO - Running setup.py (path:/tmp/pip-uOhayg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:09 INFO - Running setup.py (path:/tmp/pip-jxvnUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:09 INFO - Running setup.py (path:/tmp/pip-yQv1GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:09 INFO - Running setup.py (path:/tmp/pip-Im3Jlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:09 INFO - Running setup.py (path:/tmp/pip-SioXIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:09 INFO - Running setup.py (path:/tmp/pip-pwnAP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:09 INFO - Running setup.py (path:/tmp/pip-Qz6PMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:09 INFO - Running setup.py (path:/tmp/pip-1Nebxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:10 INFO - Running setup.py (path:/tmp/pip-MN0uWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:10 INFO - Running setup.py (path:/tmp/pip-xVdUQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:10 INFO - Running setup.py (path:/tmp/pip-Qx63Kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:10 INFO - Running setup.py (path:/tmp/pip-rWu9pR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:07:10 INFO - Running setup.py install for manifestparser 09:07:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:07:10 INFO - Running setup.py install for mozcrash 09:07:10 INFO - Running setup.py install for mozdebug 09:07:10 INFO - Running setup.py install for mozdevice 09:07:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:07:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:07:10 INFO - Running setup.py install for mozfile 09:07:10 INFO - Running setup.py install for mozhttpd 09:07:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:07:10 INFO - Running setup.py install for mozinfo 09:07:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Running setup.py install for mozInstall 09:07:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Running setup.py install for mozleak 09:07:11 INFO - Running setup.py install for mozlog 09:07:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Running setup.py install for moznetwork 09:07:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Running setup.py install for mozprocess 09:07:11 INFO - Running setup.py install for mozprofile 09:07:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Running setup.py install for mozrunner 09:07:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Running setup.py install for mozscreenshot 09:07:11 INFO - Running setup.py install for moztest 09:07:11 INFO - Running setup.py install for mozversion 09:07:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:07:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:07:12 INFO - Cleaning up... 09:07:12 INFO - Return code: 0 09:07:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:12 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e2570>, '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 0x17e3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', '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 09:07:12 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 09:07:12 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 09:07:12 INFO - Using env: {'DISPLAY': ':0', 09:07:12 INFO - 'HOME': '/home/cltbld', 09:07:12 INFO - 'LANG': 'en_US.UTF-8', 09:07:12 INFO - 'LANGUAGE': 'en_US:en', 09:07:12 INFO - 'LOGNAME': 'cltbld', 09:07:12 INFO - 'MAIL': '/var/mail/cltbld', 09:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:12 INFO - 'MOZ_NO_REMOTE': '1', 09:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:12 INFO - 'NO_EM_RESTART': '1', 09:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:12 INFO - 'PWD': '/builds/slave/test', 09:07:12 INFO - 'SHELL': '/bin/bash', 09:07:12 INFO - 'SHLVL': '1', 09:07:12 INFO - 'TERM': 'linux', 09:07:12 INFO - 'TMOUT': '86400', 09:07:12 INFO - 'USER': 'cltbld', 09:07:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', 09:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:12 INFO - '_': '/tools/buildbot/bin/python'} 09:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:12 INFO - Running setup.py (path:/tmp/pip-In0peE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:12 INFO - Running setup.py (path:/tmp/pip-utK9Z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:12 INFO - Running setup.py (path:/tmp/pip-4XVNaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:12 INFO - Running setup.py (path:/tmp/pip-HvhvlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:12 INFO - Running setup.py (path:/tmp/pip-ESxy2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:12 INFO - Running setup.py (path:/tmp/pip-ZWsjMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:12 INFO - Running setup.py (path:/tmp/pip-zw9HhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:12 INFO - Running setup.py (path:/tmp/pip-TS6oyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:12 INFO - Running setup.py (path:/tmp/pip-HjgPDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:12 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)) 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:12 INFO - Running setup.py (path:/tmp/pip-sDJZ5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:13 INFO - Running setup.py (path:/tmp/pip-3TyxTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:13 INFO - Running setup.py (path:/tmp/pip-sIwBv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:13 INFO - Running setup.py (path:/tmp/pip-_Hu_5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:13 INFO - Running setup.py (path:/tmp/pip-TZxe92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:13 INFO - Running setup.py (path:/tmp/pip-W8nkRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:13 INFO - Running setup.py (path:/tmp/pip-qdBPCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:13 INFO - Running setup.py (path:/tmp/pip-YqF5AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:13 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)) 09:07:13 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)) 09:07:13 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)) 09:07:13 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)) 09:07:13 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)) 09:07:13 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)) 09:07:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:07:13 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 09:07:13 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 09:07:13 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 09:07:13 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 09:07:13 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 09:07:13 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 09:07:15 INFO - Downloading blessings-1.6.tar.gz 09:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:07:15 INFO - Installing collected packages: blessings 09:07:15 INFO - Running setup.py install for blessings 09:07:15 INFO - Successfully installed blessings 09:07:15 INFO - Cleaning up... 09:07:15 INFO - Return code: 0 09:07:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:07:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:15 INFO - Reading from file tmpfile_stdout 09:07:15 INFO - Current package versions: 09:07:15 INFO - argparse == 1.2.1 09:07:15 INFO - blessings == 1.6 09:07:15 INFO - blobuploader == 1.2.4 09:07:15 INFO - docopt == 0.6.1 09:07:15 INFO - functools32 == 3.2.3-2 09:07:15 INFO - jsonschema == 2.5.1 09:07:15 INFO - manifestparser == 1.1 09:07:15 INFO - mozInstall == 1.12 09:07:15 INFO - mozcrash == 0.17 09:07:15 INFO - mozdebug == 0.1 09:07:15 INFO - mozdevice == 0.48 09:07:15 INFO - mozfile == 1.2 09:07:15 INFO - mozhttpd == 0.7 09:07:15 INFO - mozinfo == 0.9 09:07:15 INFO - mozleak == 0.1 09:07:15 INFO - mozlog == 3.3 09:07:15 INFO - moznetwork == 0.27 09:07:15 INFO - mozprocess == 0.23 09:07:15 INFO - mozprofile == 0.28 09:07:15 INFO - mozrunner == 6.12 09:07:15 INFO - mozscreenshot == 0.1 09:07:15 INFO - mozsystemmonitor == 0.3 09:07:15 INFO - moztest == 0.7 09:07:15 INFO - mozversion == 1.4 09:07:15 INFO - psutil == 3.1.1 09:07:15 INFO - requests == 1.2.3 09:07:15 INFO - wsgiref == 0.1.2 09:07:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:15 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')]} 09:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:15 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')]} 09:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:15 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e2570>, '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 0x17e3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', '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 09:07:15 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 09:07:15 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 09:07:15 INFO - Using env: {'DISPLAY': ':0', 09:07:15 INFO - 'HOME': '/home/cltbld', 09:07:15 INFO - 'LANG': 'en_US.UTF-8', 09:07:15 INFO - 'LANGUAGE': 'en_US:en', 09:07:15 INFO - 'LOGNAME': 'cltbld', 09:07:15 INFO - 'MAIL': '/var/mail/cltbld', 09:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:15 INFO - 'MOZ_NO_REMOTE': '1', 09:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:15 INFO - 'NO_EM_RESTART': '1', 09:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:15 INFO - 'PWD': '/builds/slave/test', 09:07:15 INFO - 'SHELL': '/bin/bash', 09:07:15 INFO - 'SHLVL': '1', 09:07:15 INFO - 'TERM': 'linux', 09:07:15 INFO - 'TMOUT': '86400', 09:07:15 INFO - 'USER': 'cltbld', 09:07:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', 09:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:15 INFO - '_': '/tools/buildbot/bin/python'} 09:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 INFO - Cleaning up... 09:07:16 INFO - Return code: 0 09:07:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:07:16 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')]} 09:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:16 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')]} 09:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:16 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 0x1524030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1753400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e2570>, '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 0x17e3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', '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 09:07:16 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 09:07:16 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 09:07:16 INFO - Using env: {'DISPLAY': ':0', 09:07:16 INFO - 'HOME': '/home/cltbld', 09:07:16 INFO - 'LANG': 'en_US.UTF-8', 09:07:16 INFO - 'LANGUAGE': 'en_US:en', 09:07:16 INFO - 'LOGNAME': 'cltbld', 09:07:16 INFO - 'MAIL': '/var/mail/cltbld', 09:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:16 INFO - 'MOZ_NO_REMOTE': '1', 09:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:16 INFO - 'NO_EM_RESTART': '1', 09:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:16 INFO - 'PWD': '/builds/slave/test', 09:07:16 INFO - 'SHELL': '/bin/bash', 09:07:16 INFO - 'SHLVL': '1', 09:07:16 INFO - 'TERM': 'linux', 09:07:16 INFO - 'TMOUT': '86400', 09:07:16 INFO - 'USER': 'cltbld', 09:07:16 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', 09:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:16 INFO - '_': '/tools/buildbot/bin/python'} 09:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:07:16 INFO - Cleaning up... 09:07:16 INFO - Return code: 0 09:07:16 INFO - Running post-action listener: _resource_record_post_action 09:07:16 INFO - Running post-action listener: _start_resource_monitoring 09:07:16 INFO - Starting resource monitoring. 09:07:16 INFO - [mozharness: 2016-08-06 16:07:16.441496Z] Finished create-virtualenv step (success) 09:07:16 INFO - [mozharness: 2016-08-06 16:07:16.441967Z] Running install step. 09:07:16 INFO - Running pre-action listener: _resource_record_pre_action 09:07:16 INFO - Running main action method: install 09:07:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:16 INFO - Reading from file tmpfile_stdout 09:07:16 INFO - Detecting whether we're running mozinstall >=1.0... 09:07:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:07:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:07:16 INFO - Reading from file tmpfile_stdout 09:07:16 INFO - Output received: 09:07:16 INFO - Usage: mozinstall [options] installer 09:07:16 INFO - Options: 09:07:16 INFO - -h, --help show this help message and exit 09:07:16 INFO - -d DEST, --destination=DEST 09:07:16 INFO - Directory to install application into. [default: 09:07:16 INFO - "/builds/slave/test"] 09:07:16 INFO - --app=APP Application being installed. [default: firefox] 09:07:16 INFO - mkdir: /builds/slave/test/build/application 09:07:16 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'] 09:07:16 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 09:07:33 INFO - Reading from file tmpfile_stdout 09:07:33 INFO - Output received: 09:07:33 INFO - /builds/slave/test/build/application/firefox/firefox 09:07:33 INFO - Running post-action listener: _resource_record_post_action 09:07:33 INFO - [mozharness: 2016-08-06 16:07:33.336629Z] Finished install step (success) 09:07:33 INFO - [mozharness: 2016-08-06 16:07:33.336904Z] Running run-tests step. 09:07:33 INFO - Running pre-action listener: _resource_record_pre_action 09:07:33 INFO - Running main action method: run_tests 09:07:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:07:33 INFO - Python 2.7.3 09:07:33 INFO - Return code: 0 09:07:33 INFO - grabbing minidump binary from tooltool 09:07:33 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')]} 09:07:33 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 0x17e2570>, '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 0x17e3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e3900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:07:33 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 09:07:33 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 09:07:33 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 09:07:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:07:33 INFO - Return code: 0 09:07:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:07:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:07:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:07:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:07:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:07:33 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/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 09:07:33 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/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 09:07:33 INFO - Using env: {'DISPLAY': ':0', 09:07:33 INFO - 'HOME': '/home/cltbld', 09:07:33 INFO - 'LANG': 'en_US.UTF-8', 09:07:33 INFO - 'LANGUAGE': 'en_US:en', 09:07:33 INFO - 'LOGNAME': 'cltbld', 09:07:33 INFO - 'MAIL': '/var/mail/cltbld', 09:07:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:07:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:33 INFO - 'MOZ_NO_REMOTE': '1', 09:07:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:33 INFO - 'NO_EM_RESTART': '1', 09:07:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:33 INFO - 'PWD': '/builds/slave/test', 09:07:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:07:33 INFO - 'SHELL': '/bin/bash', 09:07:33 INFO - 'SHLVL': '1', 09:07:33 INFO - 'TERM': 'linux', 09:07:33 INFO - 'TMOUT': '86400', 09:07:33 INFO - 'USER': 'cltbld', 09:07:33 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273', 09:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:33 INFO - '_': '/tools/buildbot/bin/python'} 09:07:33 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/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 09:07:33 INFO - mozversion application_buildid: 20160805072232 09:07:33 INFO - mozversion application_changeset: 307fe134b473938131cb0f28db52cf371883f663 09:07:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:07:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:07:33 INFO - mozversion application_name: Firefox 09:07:33 INFO - mozversion application_remotingname: firefox-dev 09:07:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:07:33 INFO - mozversion application_vendor: Mozilla 09:07:33 INFO - mozversion application_version: 50.0a2 09:07:33 INFO - mozversion platform_buildid: 20160805072232 09:07:33 INFO - mozversion platform_changeset: 307fe134b473938131cb0f28db52cf371883f663 09:07:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:07:33 INFO - mozversion platform_version: 50.0a2 09:07:33 INFO - using testdate: 1470499653 09:07:33 INFO - actual date: 1470499653 09:07:33 INFO - starting webserver on 'localhost:46803' 09:07:33 INFO - SUITE-START | Running 2 tests 09:07:33 INFO - TEST-START | dromaeo_css 09:07:33 INFO - operating with platform_type : linux_ 09:07:33 INFO - Initialising browser for dromaeo_css test... 09:07:33 INFO - TEST-INFO | started process 5806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR_vlVS/profile http://localhost:46803/getInfo.html) 09:07:37 INFO - PROCESS | 5806 | __metrics Screen width/height:1600/1200 09:07:37 INFO - PROCESS | 5806 | colorDepth:24 09:07:37 INFO - PROCESS | 5806 | Browser inner width/height: 1024/697 09:07:37 INFO - PROCESS | 5806 | __metrics 09:07:38 ERROR - PROCESS | 5806 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:07:39 INFO - TEST-INFO | 5806: exit 0 09:07:39 INFO - Browser initialized. 09:07:39 INFO - Running cycle 1/1 for dromaeo_css test... 09:07:39 INFO - TEST-INFO | started process 5936 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR_vlVS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:51 INFO - PROCESS | 5936 | RSS: Main: 152121344 09:07:51 INFO - PROCESS | 5936 | 09:08:40 INFO - PROCESS | 5936 | 1470499720783 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] 09:10:49 INFO - PROCESS | 5936 | Cycle 1(1): loaded http://localhost:46803/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46803/tests/dromaeo/cssquery-ext.html) 09:10:50 INFO - PROCESS | 5936 | RSS: Main: 157323264 09:10:50 INFO - PROCESS | 5936 | 09:13:52 INFO - PROCESS | 5936 | Cycle 1(1): loaded http://localhost:46803/tests/dromaeo/cssquery-ext.html (next: http://localhost:46803/tests/dromaeo/cssquery-jquery.html) 09:13:53 INFO - PROCESS | 5936 | RSS: Main: 153628672 09:13:53 INFO - PROCESS | 5936 | 09:16:55 INFO - PROCESS | 5936 | Cycle 1(1): loaded http://localhost:46803/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46803/tests/dromaeo/cssquery-mootools.html) 09:16:55 INFO - PROCESS | 5936 | RSS: Main: 154767360 09:16:55 INFO - PROCESS | 5936 | 09:19:57 INFO - PROCESS | 5936 | Cycle 1(1): loaded http://localhost:46803/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46803/tests/dromaeo/cssquery-prototype.html) 09:19:58 INFO - PROCESS | 5936 | RSS: Main: 152449024 09:19:58 INFO - PROCESS | 5936 | 09:23:00 INFO - PROCESS | 5936 | Cycle 1(1): loaded http://localhost:46803/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46803/tests/dromaeo/cssquery-yui.html) 09:23:01 INFO - PROCESS | 5936 | RSS: Main: 154980352 09:23:01 INFO - PROCESS | 5936 | 09:26:03 INFO - PROCESS | 5936 | Cycle 1(1): loaded http://localhost:46803/tests/dromaeo/cssquery-yui.html (next: http://localhost:46803/tests/dromaeo/cssquery-dojo.html) 09:26:03 INFO - PROCESS | 5936 | RSS: Main: 155250688 09:26:03 INFO - PROCESS | 5936 | 09:26:03 INFO - PROCESS | 5936 | __start_tp_report 09:26:03 INFO - PROCESS | 5936 | _x_x_mozilla_page_load 09:26:03 INFO - PROCESS | 5936 | _x_x_mozilla_page_load_details 09:26:03 INFO - PROCESS | 5936 | |i|pagename|runs| 09:26:03 INFO - PROCESS | 5936 | |0;dojo.html;3369.0735047861835;3393.5079413485046;3394.032700680307;3420.469827176785;3424.4863270509422;5855.648661080333;5927.496162826165;5949;5963.582549221551;5981.431763982415;5831.7958871439505;5870.794522191724;5914.2311499505;5927.585069045169;5939.970300148504;5326.627136100465;5371.462853714617;5405.621606487547;5425.565954723633;5450.373207081197;5303.151495760679;5308.283381743454;5310.309659744247;5343.305370301855;5397.7031263280505;5343.064963631368;5346.973265133669;5363.195520671911;5365.678059316434;5378.139497680372;5407.729613519308;5408.972955135199;5418.051840927822;5423.945760542383;5457.945420545783;5105.9489405106215;5202.297689811902;5228.163493840967;5319.335083114611;5321.840344789663;5819.505342045931;5820.505257053155;5827.388124246978;5879.470847623735;5918.082697181901;6222;6295.653739044351;6316.084167795644;6325.96837015812;6340.556161068727;6112.480439162677;6140.320203811457;6145.600535965148;6368.426841584233;6375.2987171411105;5773.278340207474;5790.94209057904;5817.447342502455;5822.1266809978415;5823.155642431823;6315.621062736159;6327.936720632827;6362.809115726535;6381.936180638227;6395.104685344056;6021.458068773743;6099.390060993954;6103.845024071831;6120.019327425489;6121.056693972082;6222.471089957405;6288.182536270256;6344.238691357066;6345.587536810092;6356.14192084072;6271.6550589718;6301.810945671546;6320.55756097078;6331.715072821734;6354.3645635437015;6081.604695694854;6175.258968923668;6297.527685423612;6354.904676429857;6378.298387177407;4731.952680473151;4765.475797662254;4794.400699912511;4824.300476430898;4841.515848415131;4230.830766769356;4257.70196086271;4264.424302719093;4271.209826182167;4302.419173411612;5919.437653422918;5937.376575459601;6030.849228769316;6060.303065147565;6088.665123418255;6232.688365581703;6297.4017468340435;6323.620582765049;6339.2392912850755;6339.904901426482;6037.396260373927;6047.9395206047375;6073.5748497604745;6077.270727512639;6084.482818960438;5267.578593712494;5300.787968481218;5446.046941785172;5456.836294911159;5490.780368785204;6314.810555683337;6434.871302573923;6444.903326450107;6450.548461607643;6452.419282264619;6193.225846769154;6223.471004964629;6231.158793562811;6246;6313.526485513513;6362.77730279438;6415.8716825662295;6419.775307864389;6463.870722585616;6496.0255961606135;6104.847378815388;6229.4393504584805;6236.251649802053;6240.625562466266;6259.593126446766;6325.810225693236;6326.746930122744;6343.238811342669;6351.1425957496995;6373.171487706569;6087.908681369871;6140.263168419819;6211;6212.006079027334;6232.501399888089;6115.480184184395;6169.259688837368;6182.165407669907;6185.381461853779;6218.129461875432;6105.877882442415;6106.389361063858;6155.1075094112;6164.907526387197;6173.290071641819;6134.78528251509;6184.969075154595;6229;6256.874862502816;6276.968615156895;6140.723667434887;6176.104464852481;6185.103160041679;6187.659678717534;6197.25632924052 09:26:03 INFO - PROCESS | 5936 | |1;ext.html;589.3958692340351;629.553017357676;643.1253495246464;653.8724948635016;676.8747781660396;42329.15341693168;46571.534284657144;46658.76670616646;46691.766541167286;46893;46658.30012549814;46830.765846170805;47168.0566388672;47332;47413;9071.047540008303;9213.769655758626;9223.584938677775;9226.031266716998;9226.446413215228;8922.50926199062;8935.508547029911;8976.41653292534;8978.955105224464;9005.189532942033;9020.909790902106;9034.593443295034;9042.728718138467;9048.683296084639;9069.229115525188;8958.776030599287;9008.504532250723;9019.188273055424;9048.14042665949;9084;9206;9227.26181905446;9284.303677224236;9284.814303713887;9292.814143717156;45318;45462.31806522905;45641.77179114083;45775.54224457746;45874.082518349445;3862.633049860259;3945.4673619061346;4094.303968325392;4150.128473020669;4197.727147735418;35574.46638300428;35667.643323566954;35692.286154277026;35865;36047.63952360469;4434.667399944985;4464.910701785946;4486.439195100613;4549.61328287096;4574.6340292776495;251090;311177;370694;373766;377132;68321.3167868325;68391.31608683949;68874.3112568868;68944.6552767233;69005;40437.393439098436;41248.58751412507;41286.1742765143;71894.64052679807;72065;19889.204431822855;20103.09536070851;20113.39659810208;20114.798852011292;20126.89936550337;15262.923685381502;15363.231838408035;15386.615334616725;15457.458988935334;15527.534173974798;21243.68134477984;21286.680699789515;21424.571508570054;21450.463738406666;21515.67726484104;7541.924580754232;7560.697572097055;7653.502522336031;7744.41916856238;7814.413918955987;1074.711899520906;1099.9505022274018;1229.624964385853;1256.7549327880974;1258.4840215511779;34477.31045379129;34743;34876.65123348734;35209.82395088059;35451.4682279766;1153.1466714631113;1168.3282112785182;1168.9590864319878;1247.5820600098887;1306.1640550047978;17954.5511362217;18122.728159077626;18192.636147277244;18195.727064094048;18570.44288671342;409395;609331;623772;946957;950668;69176.30823691799;69604;69653.30346696569;69909.30090699028;69960.65019674868;1473.7715654073636;1505.8494150584854;1524.5883611424854;1529.4723320454425;1539.2150003498296;35177.64822351744;35464;35640.643593563735;36034.45948310725;36551.45172822463;59560.404395955484;60155.09767353406;60278.69860650844;60428;60454.39545604488;400913;401783;406663;407291;407716;31417.21456963594;32283.677163229007;32619.18452038718;32643.836780815946;33898;54703.17945230904;55081;55292;56422.71788641195;57091.14363284471;45562.772186138856;46591.30113048375;47286;47361.289580655626;49064.75467622639;47813.760931195124;47935.28097078477;48985.51014489809;49230.50769492259;49964.25053624271;47473.52526474829;47561.76219118882;48324.27513587369;48532.27201591909;50342.748286258335;38602.80698596489;41106.588934110274;41187.38218926779;41343.58656413518;41827.58172418237;31201.53197701991;31582.526262105628;31797.682023179474;31895.681043190198;32031.6796832038 09:26:03 INFO - PROCESS | 5936 | |2;jquery.html;402.7221217360021;409.4370240918736;417.5407052242533;417.8725488725937;426.47543521468594;19011;20369;20897.582048359043;21363.57272854542;21638.3508494745;20658.89670551649;20669.586608267826;20947.581048379023;21003.684944725803;21138.68291975618;5781.219535362735;5950.642961422307;5957.970210148943;5982.581219314649;6000.339962604132;5763.769449222026;5938.1389698493695;5954.553408494358;5960.105984102376;5985.491233245158;5988.610740301889;5989.311229208632;6026.5178785697035;6036.39636036395;6049.304330002062;5969.253843269591;5978.790742324041;6018.909716354258;6024.578279520435;6048.939510604881;5835.766569337221;5849.2103566018895;5881.029630111027;5908.911366329508;5921.348651648315;15355.846441535554;22313.44216394587;22981.885090574608;23219.651705224434;24107.879460602584;2416.6375043743406;2660.308319836837;2989.17797605658;3000.3699223162944;3126.421612001787;16253.349866005346;16307.592310192222;16749.330026798914;16986.235619397157;17007.57481062971;2167.1331467413;2171.3160354488286;2194.2539536557647;2220.822334213259;2306.6194077977116;58427.41572584262;58494;59476.70261648708;79824.60087699583;92201.53899230529;18750.624987500174;18978;19122.22727704475;19170;19581;34687.479687804705;34870;34895.12762180915;34932.47601285983;35169;11119.888801112047;11461.255018423775;11477.827832582518;11492.080633549296;11681.415929203677;9590;9733.659321923698;9751.21990240779;9851;9891.406515609087;9250.12162068237;9704.27217958656;9742.61029558824;9770.609175633037;9822.361546499455;3574.3208790329754;3624.2751449710163;3697.4638677391627;3747.512823333004;3844.2695887781233;1000.9599616015423;1016.2428990402198;1028.5320179318542;1066.1311031509294;1105.9668209953713;20558.794412055988;20658.690119648218;20776.58446831055;20873;20983.265585704426;1030.5105075089273;1061.7717190804015;1068.3536460441476;1069.893010698924;1126.1722633864103;11214.775704486028;11355.772884542263;11452.828207576893;11477.36874471912;11568.942155289169;505036;508682;510691;518098;520658;84639;85994;87292;87689;89477.55261223653;1029.4955471818755;1048.156234231451;1071.2501249125487;1073.8550295710136;1074.978500429987;17644.1177941105;17935.73096403581;18044.729329059814;18241.270349185885;18408;40837.591624083376;41766.79116604398;42245.577544225394;43636;43685.344719828594;57499.42500574941;58539.12191317219;59130.70434647799;59701.40298596959;60019.699901500215;9079.95460022722;9185.908140918773;9234.769130771785;9316.254699624149;9335.813283734424;8500.574971251537;10102;13178.670533236746;13267.402966866708;13286.933565332112;11889.167758257185;12118.333491658044;12268.754624907631;12287.631371058882;12471.438785254504;11775.587854425054;11898.524059037542;11929.880701192877;12027.338496382434;12113.394330283627;12013.699657508632;12186.086043546593;12292;12344.567940122053;12411.131220814455;8285.25432711059;8425.283850872744;9144.771380715269;9210.263178945803;9378.953105234703;8890.911090889009;11472.770544588895;11821.231619944676;11865;12074.154809163274 09:26:03 INFO - PROCESS | 5936 | |3;mootools.html;1558.259826582373;1587.912664803436;1757.3673477548089;1839.1080326041877;1864.3847530314997;8843.425177363475;9427.528623568829;9651.855222171673;9712.17446517046;9743.512824358771;9716.854247186298;9776.951115244414;9864.802703945918;9870.506474676255;9875.061869122439;2448.987755061227;2483.7019557653107;2484.968737973748;2489.987550062247;2490.5890528062937;2451.9877400613063;2469.6912885889265;2478.578641630918;2481.9451733013398;2489.3029951613485;2464.8767561621935;2471.3574470637673;2516.773490385865;2519.143491212987;2532.4555220627562;2394.545036443079;2406.6750988616486;2412.203972689017;2436.780689737914;2440.3533063738123;2342.723215847367;2351.098742157181;2355.1286024170995;2366.2309749331366;2374.798142157919;9544.95227523865;9545.61817527298;9564.56959436827;9572.377795443273;9576.616935322649;5486.862828429281;5691.174779656968;5710.828675139711;5711.343195532525;5717.371089180187;3436.8765480883226;3541.327147841902;3566.9311799156426;3567.0369000370015;3592.0660628236587;1171.4611278811756;1192.6004788395899;1213.7572485502935;1214.878512148787;1244.6826059354808;13044.934775326063;13089.345532723326;13109.147905386215;13115.213087214797;13229.603111906657;4590.288505281686;4732.976335118303;4823.686460380064;4855.830045948445;4866.7566621668775;10385.273030887916;10388.065074143364;10403.115735162444;10410.583576656849;10430.061294483532;5553;5558.916616250759;5580.302462192226;5600.355959064678;5605.887882242332;4597.287420449836;5116;5180.4560521145495;5210.687358758487;5239.790408383698;4092.728160078087;4103.8974025649595;4116.115035267432;4138.689598280141;4138.751674899516;1195.6711904226233;1228.993855030719;1230.563150081726;1237.1216436330126;1240.1009268280425;974.5711886769799;1020.3214862116757;1028.321307936758;1032.4528000159928;1039.4594810698395;5820.941790582125;6043.8489037773525;6056.121862329937;6186.907196392058;6671.5997040177745;1036.6630844975414;1083.6423980086552;1094.43089593411;1120.5293776613842;1140.7946569617548;4415;4520.932186017212;4613.123506533748;4634.142683603477;4648.3259927310355;11322.32066076038;11724.472398741906;11828.349440780668;11848.229865058744;11852.466639001266;10874.510647020903;11326.207165498501;11764.117691173196;11764.411779411166;11841.289522628498;8697.08680588529;8864.024957254696;8925.285977121815;8943.776405589912;8946.821063578822;6389.36106389376;6540.051692504655;6575.671216439255;6615.735370585123;6769.255381907888;10263.897361026295;10546.683599492027;10758.300710453796;10910.509027093958;10976.780464390828;10745.301555398873;10826.51280692355;10862.891371086187;10919.672409827717;10935.617253396093;8109.959450202948;8277.130901255281;8341.541215233221;8416.873746893923;8567.74296771098;9107.817843643223;9159.129882661136;9192.218661413855;9212.216961558343;9219.723408297761;7920.485168464032;7975.162607926084;7991.84016319682;8050.235227653364;8167.918320816716;7742.612869356397;7790.844183116193;7797.454178207698;7850.803729906798;7912.881306780288;7222.674979625825;7501.699932002877;7554.508956917783;7557.433192510473;7592.240775922363;5340.679559226459;5430.647007944471;5456.181572764117;5498.945010549844;5511.173324001432;5649.435056494318;5669.291338582677;5823.155642431909;5874.618149820248;5893.941060589339 09:26:03 INFO - PROCESS | 5936 | |4;prototype.html;343.1952072390244;348.2964411887988;349.0784329370464;355.12461781708095;355.98042107684074;5857.56068294878;5915.556333275;5958.553108516857;5973.402659734024;5976.65525256817;5819.330776960651;5825.621334613247;5828.533717302616;5844.824655260349;5853.707314634273;3920.411938209263;4422.204003279408;4505.752183629899;4508.413906192207;4510.887227819298;4522.4346956630425;4545.545445455461;4554.385158003677;4577.771111444431;4582.541745825408;4480.775961201927;4529.932051019221;4540.500544940054;4552.726836389811;4564.612007979325;4293.613574778269;4380.6057454829215;4430.180416622935;4434.578715022068;4559.8404055858055;3932.488776459071;3935;3938.547067087293;3942.349512330462;3948.190620922704;5668.773249070032;5691.800786972478;5708.657480551139;5725.541956643458;5728.99742545053;4933;5140.1518749406305;5162.199859021857;5193.8961220775755;5224.294720212761;6109.327973922865;6111.694415279218;6139.508839292846;6160.4455598995855;6185.288691800455;4419.41464243418;4431.313146462304;4436.689431739779;4450.732956022649;4453.755043472608;6030.833812248561;6146.815595532141;6288.811335659938;6304.27500837405;6398.912184928527;4512.932306015412;4616.399868017136;4620.306953956933;4628.236341003697;4637.652176086807;4662.510436404196;4671.6262698984;4694.108119457293;4709.128811169944;4710.175719249186;5204.843854684365;5240.580753539708;5272.736363181825;5291.1798671206025;5296.3909150447425;6120.102768141801;6123.785667501616;6131.908021379683;6147.784827531015;6154.5076393888385;1606.8875178737376;1610.9677806443806;1617.9029258244543;1620.5219460259252;1626.1137679964447;1040.5317607076695;1053.3416614615865;1055.8205105132147;1056.9365838049587;1063.0220197418394;5278.973605132027;5284.392294886137;5335.706536140549;5348.171033489815;5363.973180134074;5597.824456864023;5602.187682785973;5607.36453866682;5664.575156863251;5668.809549994465;4979.377577802775;5318.73406329682;5319.361676598833;5330.3742358581;5336.184627991005;2941.82305094233;2988.656304524964;3017.89437369691;3051.6032915720816;3063.1270088024808;5721.681424773621;5733.283339582552;5767.981206577748;5862.530997520188;6133.233345831771;6329.430351268408;6363.58636688623;6408.231012278463;6433.967830160819;6460.903086453707;6498.870022599616;6547.34526547351;6615.63614001225;6629.1713535808985;6646.96676516624;6196.969015154896;6423.164988551458;6434.587029863801;6440.388163124496;6454.967205247326;6365.517448195115;6367.471806766435;6414.935850641434;6417.647029413427;6428.646424446701;6325.272593651789;6469.708863101266;6532.346765323429;6550.246721627074;6554;4491.618212451978;4519.41247637805;4530.61489773373;4535.705179163344;4543.909121817611;6223.595466294676;6307.306196318493;6386.744530218739;6435.967820160869;6452.128962590178;6153.753849845956;6182.218001899253;6186.443220110212;6212.596181248205;6234.539830394175;6003.907987386412;6223.37766223374;6227.564070515021;6251.437370636664;6321.462675672619;6111.236095488064;6120.663363515049;6128.785492507741;6143.631382117087;6152.523394385405;6248.4064013918605;6265.840819448416;6276.9372306276355;6292.056191571301;6352.682365881595;5830.53355731549;6082.300535438304;6086.817395478142;6095.262850087704;6105.572609917441 09:26:03 INFO - PROCESS | 5936 | |5;yui.html;795.9721409750656;833.1460253240432;842.5155535567051;889.5107690770075;899.9370044096912;16470.835291647094;17213.311467541298;17728.556786080353;17903.910480447597;18056.36802711902;16446.83553164471;16664.250108745106;16707.164641767922;16713.83286167138;16758.162091895418;750.6997201119541;873.6330741088726;882.2368651116769;883.5361435246483;898.3846065445191;891.2201823404521;894.8568229083348;894.9105089491031;895.1361935732017;897.0849733272058;930.9581068851918;931.0317270039151;931.3480563605469;931.7763736703176;933.4679232837285;918.669279059538;923.6213152607465;926.0693003531408;927.4435338796735;929.5584597316255;683.3815397065664;684.0935760117864;684.7261095561765;685.7085738561142;688.7004153193377;15791.21043947798;15833;15914.602134946603;15947.521574352788;15977.121258330788;14006.299685015709;14027.71944561103;14450.566483005527;14481.275936203148;14504.782428263585;12866.099373043891;12871.485140594365;12936.094473386867;12945.482180712761;13087.869121308855;4756.5243475652505;4770.427548694144;4797.088553174885;4817.349657796188;4825.565699087099;85596;86427.99999999937;86878.56560717156;87073.56463217706;89126.5543672284;11604.6518604442;11706.297622142529;11742.412879355998;11842.230255033395;12170.939145304217;22582.322530324116;22678;22688.319350419515;22702.205422810122;22720.431989200402;9088.227500662386;9199.95400023009;9203.769905752275;9228.446293222429;9263.490508021989;5126.846194614168;5162.896742065138;5226.869328266824;5239.26650268955;5399.190121481809;3712.8514859405864;3744.02655309616;3771.0949372150485;3778.112143646241;3787.981060094682;644.1979735229576;653.9574927629689;706.7632343165097;740.3336996702902;740.8592367450167;590.1266126133261;654.5614438326332;714.4248879651826;722.8048426924701;764.747633281016;9670.854937175947;10323.122534584494;10349.793004139876;10650.520726567323;11200;741.1032650492964;742.3170682971679;747.5850902749027;764.6903004283274;778.132382393627;4795.136875362468;5118.513741194581;5191.558717508979;5215.400228973641;5237.659552129099;96144.51927740456;125332;136801;137143.31428342796;137824.31087844496;115102.42448787703;116771;116844;117353.4132329333;118598.4070079644;95198;99461;101524.49237753617;101587;101695;9684.41893486393;9738.269629777653;9822.950885245815;9867.856358664169;9891.01089891034;58924;59680;60680.69659651673;60859;62520.687396562724;87991;90002.54998724964;91193.54403227942;91295;92985;11116.277441966246;11435.256708313933;11459.942700286445;11490.942545287555;11851.762964740828;14203.573892782819;14255.50105746294;14290.57128286153;14403.711925761636;14544.272786360429;12877.162984405984;13348.466061357436;13613;13660.863391366356;14195.219262940638;12757.617271481871;12814.487420503448;12928.418221179882;13134.211947283193;13330.733385332045;13721.382537785625;13961.301934903417;14379.496717614833;14981.850181498046;15215;12281.140320177501;12921.28932908699;13064.412101455267;13099;13163.60509184726;12326.260424374566;12878.291693956548;13050;13117.672058198621;13156.144850584682 09:26:03 INFO - PROCESS | 5936 | __end_tp_report 09:26:03 INFO - PROCESS | 5936 | __start_cc_report 09:26:03 INFO - PROCESS | 5936 | _x_x_mozilla_cycle_collect,340 09:26:03 INFO - PROCESS | 5936 | __end_cc_report 09:26:03 INFO - PROCESS | 5936 | __startTimestamp1470500763573__endTimestamp 09:26:03 INFO - PROCESS | 5936 | 09:26:03 INFO - PROCESS | 5936 | ------- Summary: start ------- 09:26:03 INFO - PROCESS | 5936 | Number of tests: 6 09:26:03 INFO - PROCESS | 5936 | 09:26:03 INFO - PROCESS | 5936 | [#0] dojo.html Cycles:165 Average:5844.39 Median:6106.39 stddev:664.39 (10.9%) stddev-sans-first:637.42 09:26:03 INFO - PROCESS | 5936 | Values: 3369.1 3393.5 3394.0 3420.5 3424.5 5855.6 5927.5 5949.0 5963.6 5981.4 5831.8 5870.8 5914.2 5927.6 5940.0 5326.6 5371.5 5405.6 5425.6 5450.4 5303.2 5308.3 5310.3 5343.3 5397.7 5343.1 5347.0 5363.2 5365.7 5378.1 5407.7 5409.0 5418.1 5423.9 5457.9 5105.9 5202.3 5228.2 5319.3 5321.8 5819.5 5820.5 5827.4 5879.5 5918.1 6222.0 6295.7 6316.1 6326.0 6340.6 6112.5 6140.3 6145.6 6368.4 6375.3 5773.3 5790.9 5817.4 5822.1 5823.2 6315.6 6327.9 6362.8 6381.9 6395.1 6021.5 6099.4 6103.8 6120.0 6121.1 6222.5 6288.2 6344.2 6345.6 6356.1 6271.7 6301.8 6320.6 6331.7 6354.4 6081.6 6175.3 6297.5 6354.9 6378.3 4732.0 4765.5 4794.4 4824.3 4841.5 4230.8 4257.7 4264.4 4271.2 4302.4 5919.4 5937.4 6030.8 6060.3 6088.7 6232.7 6297.4 6323.6 6339.2 6339.9 6037.4 6047.9 6073.6 6077.3 6084.5 5267.6 5300.8 5446.0 5456.8 5490.8 6314.8 6434.9 6444.9 6450.5 6452.4 6193.2 6223.5 6231.2 6246.0 6313.5 6362.8 6415.9 6419.8 6463.9 6496.0 6104.8 6229.4 6236.3 6240.6 6259.6 6325.8 6326.7 6343.2 6351.1 6373.2 6087.9 6140.3 6211.0 6212.0 6232.5 6115.5 6169.3 6182.2 6185.4 6218.1 6105.9 6106.4 6155.1 6164.9 6173.3 6134.8 6185.0 6229.0 6256.9 6277.0 6140.7 6176.1 6185.1 6187.7 6197.3 09:26:03 INFO - PROCESS | 5936 | 09:26:03 INFO - PROCESS | 5936 | [#1] ext.html Cycles:180 Average:66475.91 Median:25056.19 stddev:140686.67 (561.5%) stddev-sans-first:140994.36 09:26:03 INFO - PROCESS | 5936 | Values: 589.4 629.6 643.1 653.9 676.9 42329.2 46571.5 46658.8 46691.8 46893.0 46658.3 46830.8 47168.1 47332.0 47413.0 9071.0 9213.8 9223.6 9226.0 9226.4 8922.5 8935.5 8976.4 8979.0 9005.2 9020.9 9034.6 9042.7 9048.7 9069.2 8958.8 9008.5 9019.2 9048.1 9084.0 9206.0 9227.3 9284.3 9284.8 9292.8 45318.0 45462.3 45641.8 45775.5 45874.1 3862.6 3945.5 4094.3 4150.1 4197.7 35574.5 35667.6 35692.3 35865.0 36047.6 4434.7 4464.9 4486.4 4549.6 4574.6 251090.0 311177.0 370694.0 373766.0 377132.0 68321.3 68391.3 68874.3 68944.7 69005.0 40437.4 41248.6 41286.2 71894.6 72065.0 19889.2 20103.1 20113.4 20114.8 20126.9 15262.9 15363.2 15386.6 15457.5 15527.5 21243.7 21286.7 21424.6 21450.5 21515.7 7541.9 7560.7 7653.5 7744.4 7814.4 1074.7 1100.0 1229.6 1256.8 1258.5 34477.3 34743.0 34876.7 35209.8 35451.5 1153.1 1168.3 1169.0 1247.6 1306.2 17954.6 18122.7 18192.6 18195.7 18570.4 409395.0 609331.0 623772.0 946957.0 950668.0 69176.3 69604.0 69653.3 69909.3 69960.7 1473.8 1505.8 1524.6 1529.5 1539.2 35177.6 35464.0 35640.6 36034.5 36551.5 59560.4 60155.1 60278.7 60428.0 60454.4 400913.0 401783.0 406663.0 407291.0 407716.0 31417.2 32283.7 32619.2 32643.8 33898.0 54703.2 55081.0 55292.0 56422.7 57091.1 45562.8 46591.3 47286.0 47361.3 49064.8 47813.8 47935.3 48985.5 49230.5 49964.3 47473.5 47561.8 48324.3 48532.3 50342.7 38602.8 41106.6 41187.4 41343.6 41827.6 31201.5 31582.5 31797.7 31895.7 32031.7 09:26:03 INFO - PROCESS | 5936 | 09:26:03 INFO - PROCESS | 5936 | [#2] jquery.html Cycles:180 Average:30699.92 Median:2994.77 stddev:83948.22 (2803.2%) stddev-sans-first:84152.90 09:26:03 INFO - PROCESS | 5936 | Values: 402.7 409.4 417.5 417.9 426.5 19011.0 20369.0 20897.6 21363.6 21638.4 20658.9 20669.6 20947.6 21003.7 21138.7 5781.2 5950.6 5958.0 5982.6 6000.3 5763.8 5938.1 5954.6 5960.1 5985.5 5988.6 5989.3 6026.5 6036.4 6049.3 5969.3 5978.8 6018.9 6024.6 6048.9 5835.8 5849.2 5881.0 5908.9 5921.3 15355.8 22313.4 22981.9 23219.7 24107.9 2416.6 2660.3 2989.2 3000.4 3126.4 16253.3 16307.6 16749.3 16986.2 17007.6 2167.1 2171.3 2194.3 2220.8 2306.6 58427.4 58494.0 59476.7 79824.6 92201.5 18750.6 18978.0 19122.2 19170.0 19581.0 34687.5 34870.0 34895.1 34932.5 35169.0 11119.9 11461.3 11477.8 11492.1 11681.4 9590.0 9733.7 9751.2 9851.0 9891.4 9250.1 9704.3 9742.6 9770.6 9822.4 3574.3 3624.3 3697.5 3747.5 3844.3 1001.0 1016.2 1028.5 1066.1 1106.0 20558.8 20658.7 20776.6 20873.0 20983.3 1030.5 1061.8 1068.4 1069.9 1126.2 11214.8 11355.8 11452.8 11477.4 11568.9 505036.0 508682.0 510691.0 518098.0 520658.0 84639.0 85994.0 87292.0 87689.0 89477.6 1029.5 1048.2 1071.3 1073.9 1075.0 17644.1 17935.7 18044.7 18241.3 18408.0 40837.6 41766.8 42245.6 43636.0 43685.3 57499.4 58539.1 59130.7 59701.4 60019.7 9080.0 9185.9 9234.8 9316.3 9335.8 8500.6 10102.0 13178.7 13267.4 13286.9 11889.2 12118.3 12268.8 12287.6 12471.4 11775.6 11898.5 11929.9 12027.3 12113.4 12013.7 12186.1 12292.0 12344.6 12411.1 8285.3 8425.3 9144.8 9210.3 9379.0 8890.9 11472.8 11821.2 11865.0 12074.2 09:26:03 INFO - PROCESS | 5936 | 09:26:03 INFO - PROCESS | 5936 | [#3] mootools.html Cycles:180 Average:6184.84 Median:4555.61 stddev:3514.01 (77.1%) stddev-sans-first:3506.66 09:26:03 INFO - PROCESS | 5936 | Values: 1558.3 1587.9 1757.4 1839.1 1864.4 8843.4 9427.5 9651.9 9712.2 9743.5 9716.9 9777.0 9864.8 9870.5 9875.1 2449.0 2483.7 2485.0 2490.0 2490.6 2452.0 2469.7 2478.6 2481.9 2489.3 2464.9 2471.4 2516.8 2519.1 2532.5 2394.5 2406.7 2412.2 2436.8 2440.4 2342.7 2351.1 2355.1 2366.2 2374.8 9545.0 9545.6 9564.6 9572.4 9576.6 5486.9 5691.2 5710.8 5711.3 5717.4 3436.9 3541.3 3566.9 3567.0 3592.1 1171.5 1192.6 1213.8 1214.9 1244.7 13044.9 13089.3 13109.1 13115.2 13229.6 4590.3 4733.0 4823.7 4855.8 4866.8 10385.3 10388.1 10403.1 10410.6 10430.1 5553.0 5558.9 5580.3 5600.4 5605.9 4597.3 5116.0 5180.5 5210.7 5239.8 4092.7 4103.9 4116.1 4138.7 4138.8 1195.7 1229.0 1230.6 1237.1 1240.1 974.6 1020.3 1028.3 1032.5 1039.5 5820.9 6043.8 6056.1 6186.9 6671.6 1036.7 1083.6 1094.4 1120.5 1140.8 4415.0 4520.9 4613.1 4634.1 4648.3 11322.3 11724.5 11828.3 11848.2 11852.5 10874.5 11326.2 11764.1 11764.4 11841.3 8697.1 8864.0 8925.3 8943.8 8946.8 6389.4 6540.1 6575.7 6615.7 6769.3 10263.9 10546.7 10758.3 10910.5 10976.8 10745.3 10826.5 10862.9 10919.7 10935.6 8110.0 8277.1 8341.5 8416.9 8567.7 9107.8 9159.1 9192.2 9212.2 9219.7 7920.5 7975.2 7991.8 8050.2 8167.9 7742.6 7790.8 7797.5 7850.8 7912.9 7222.7 7501.7 7554.5 7557.4 7592.2 5340.7 5430.6 5456.2 5498.9 5511.2 5649.4 5669.3 5823.2 5874.6 5893.9 09:26:03 INFO - PROCESS | 5936 | 09:26:03 INFO - PROCESS | 5936 | [#4] prototype.html Cycles:180 Average:5111.72 Median:5680.31 stddev:1515.97 (26.7%) stddev-sans-first:1477.37 09:26:03 INFO - PROCESS | 5936 | Values: 343.2 348.3 349.1 355.1 356.0 5857.6 5915.6 5958.6 5973.4 5976.7 5819.3 5825.6 5828.5 5844.8 5853.7 3920.4 4422.2 4505.8 4508.4 4510.9 4522.4 4545.5 4554.4 4577.8 4582.5 4480.8 4529.9 4540.5 4552.7 4564.6 4293.6 4380.6 4430.2 4434.6 4559.8 3932.5 3935.0 3938.5 3942.3 3948.2 5668.8 5691.8 5708.7 5725.5 5729.0 4933.0 5140.2 5162.2 5193.9 5224.3 6109.3 6111.7 6139.5 6160.4 6185.3 4419.4 4431.3 4436.7 4450.7 4453.8 6030.8 6146.8 6288.8 6304.3 6398.9 4512.9 4616.4 4620.3 4628.2 4637.7 4662.5 4671.6 4694.1 4709.1 4710.2 5204.8 5240.6 5272.7 5291.2 5296.4 6120.1 6123.8 6131.9 6147.8 6154.5 1606.9 1611.0 1617.9 1620.5 1626.1 1040.5 1053.3 1055.8 1056.9 1063.0 5279.0 5284.4 5335.7 5348.2 5364.0 5597.8 5602.2 5607.4 5664.6 5668.8 4979.4 5318.7 5319.4 5330.4 5336.2 2941.8 2988.7 3017.9 3051.6 3063.1 5721.7 5733.3 5768.0 5862.5 6133.2 6329.4 6363.6 6408.2 6434.0 6460.9 6498.9 6547.3 6615.6 6629.2 6647.0 6197.0 6423.2 6434.6 6440.4 6455.0 6365.5 6367.5 6414.9 6417.6 6428.6 6325.3 6469.7 6532.3 6550.2 6554.0 4491.6 4519.4 4530.6 4535.7 4543.9 6223.6 6307.3 6386.7 6436.0 6452.1 6153.8 6182.2 6186.4 6212.6 6234.5 6003.9 6223.4 6227.6 6251.4 6321.5 6111.2 6120.7 6128.8 6143.6 6152.5 6248.4 6265.8 6276.9 6292.1 6352.7 5830.5 6082.3 6086.8 6095.3 6105.6 09:26:03 INFO - PROCESS | 5936 | 09:26:03 INFO - PROCESS | 5936 | [#5] yui.html Cycles:180 Average:23380.46 Median:4272.25 stddev:34746.52 (813.3%) stddev-sans-first:34802.61 09:26:03 INFO - PROCESS | 5936 | Values: 796.0 833.1 842.5 889.5 899.9 16470.8 17213.3 17728.6 17903.9 18056.4 16446.8 16664.3 16707.2 16713.8 16758.2 750.7 873.6 882.2 883.5 898.4 891.2 894.9 894.9 895.1 897.1 931.0 931.0 931.3 931.8 933.5 918.7 923.6 926.1 927.4 929.6 683.4 684.1 684.7 685.7 688.7 15791.2 15833.0 15914.6 15947.5 15977.1 14006.3 14027.7 14450.6 14481.3 14504.8 12866.1 12871.5 12936.1 12945.5 13087.9 4756.5 4770.4 4797.1 4817.3 4825.6 85596.0 86428.0 86878.6 87073.6 89126.6 11604.7 11706.3 11742.4 11842.2 12170.9 22582.3 22678.0 22688.3 22702.2 22720.4 9088.2 9200.0 9203.8 9228.4 9263.5 5126.8 5162.9 5226.9 5239.3 5399.2 3712.9 3744.0 3771.1 3778.1 3788.0 644.2 654.0 706.8 740.3 740.9 590.1 654.6 714.4 722.8 764.7 9670.9 10323.1 10349.8 10650.5 11200.0 741.1 742.3 747.6 764.7 778.1 4795.1 5118.5 5191.6 5215.4 5237.7 96144.5 125332.0 136801.0 137143.3 137824.3 115102.4 116771.0 116844.0 117353.4 118598.4 95198.0 99461.0 101524.5 101587.0 101695.0 9684.4 9738.3 9823.0 9867.9 9891.0 58924.0 59680.0 60680.7 60859.0 62520.7 87991.0 90002.5 91193.5 91295.0 92985.0 11116.3 11435.3 11459.9 11490.9 11851.8 14203.6 14255.5 14290.6 14403.7 14544.3 12877.2 13348.5 13613.0 13660.9 14195.2 12757.6 12814.5 12928.4 13134.2 13330.7 13721.4 13961.3 14379.5 14981.9 15215.0 12281.1 12921.3 13064.4 13099.0 13163.6 12326.3 12878.3 13050.0 13117.7 13156.1 09:26:03 INFO - PROCESS | 5936 | -------- Summary: end -------- 09:26:03 INFO - PROCESS | 5936 | 09:26:04 INFO - TEST-INFO | 5936: exit 0 09:26:04 INFO - TEST-OK | dromaeo_css | took 1110676ms 09:26:04 INFO - TEST-START | kraken 09:26:04 INFO - operating with platform_type : linux_ 09:26:04 INFO - Initialising browser for kraken test... 09:26:04 INFO - TEST-INFO | started process 6206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7DZQQF/profile http://localhost:46803/getInfo.html) 09:26:08 INFO - PROCESS | 6206 | __metrics Screen width/height:1600/1200 09:26:08 INFO - PROCESS | 6206 | colorDepth:24 09:26:08 INFO - PROCESS | 6206 | Browser inner width/height: 1024/697 09:26:08 INFO - PROCESS | 6206 | __metrics 09:26:09 ERROR - PROCESS | 6206 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:26:09 INFO - TEST-INFO | 6206: exit 0 09:26:09 INFO - Browser initialized. 09:26:09 INFO - Running cycle 1/1 for kraken test... 09:26:09 INFO - TEST-INFO | started process 6331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7DZQQF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:26:21 INFO - PROCESS | 6331 | RSS: Main: 152805376 09:26:21 INFO - PROCESS | 6331 | 09:26:24 INFO - PROCESS | 6331 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46803/tests/kraken/driver.html?testName=audio-beat-detection) 09:26:25 INFO - PROCESS | 6331 | RSS: Main: 157933568 09:26:25 INFO - PROCESS | 6331 | 09:26:27 INFO - PROCESS | 6331 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46803/tests/kraken/driver.html?testName=audio-dft) 09:26:28 INFO - PROCESS | 6331 | RSS: Main: 157556736 09:26:28 INFO - PROCESS | 6331 | 09:26:31 INFO - PROCESS | 6331 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46803/tests/kraken/driver.html?testName=audio-fft) 09:26:31 INFO - PROCESS | 6331 | RSS: Main: 158228480 09:26:31 INFO - PROCESS | 6331 | 09:26:33 INFO - PROCESS | 6331 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46803/tests/kraken/driver.html?testName=audio-oscillator) 09:26:34 INFO - PROCESS | 6331 | RSS: Main: 157577216 09:26:34 INFO - PROCESS | 6331 | 09:26:36 INFO - PROCESS | 6331 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46803/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:26:37 INFO - PROCESS | 6331 | RSS: Main: 157319168 09:26:37 INFO - PROCESS | 6331 | 09:26:40 INFO - PROCESS | 6331 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46803/tests/kraken/driver.html?testName=imaging-darkroom) 09:26:40 INFO - PROCESS | 6331 | RSS: Main: 156995584 09:26:40 INFO - PROCESS | 6331 | 09:26:44 INFO - PROCESS | 6331 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46803/tests/kraken/driver.html?testName=imaging-desaturate) 09:26:44 INFO - PROCESS | 6331 | RSS: Main: 157122560 09:26:44 INFO - PROCESS | 6331 | 09:26:47 INFO - PROCESS | 6331 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46803/tests/kraken/driver.html?testName=json-parse-financial) 09:26:48 INFO - PROCESS | 6331 | RSS: Main: 158171136 09:26:48 INFO - PROCESS | 6331 | 09:26:49 INFO - PROCESS | 6331 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46803/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:26:50 INFO - PROCESS | 6331 | RSS: Main: 157347840 09:26:50 INFO - PROCESS | 6331 | 09:26:52 INFO - PROCESS | 6331 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46803/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:26:52 INFO - PROCESS | 6331 | RSS: Main: 157519872 09:26:52 INFO - PROCESS | 6331 | 09:26:54 INFO - PROCESS | 6331 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46803/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:26:55 INFO - PROCESS | 6331 | RSS: Main: 157622272 09:26:55 INFO - PROCESS | 6331 | 09:26:58 INFO - PROCESS | 6331 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:26:58 INFO - PROCESS | 6331 | RSS: Main: 157646848 09:26:58 INFO - PROCESS | 6331 | 09:27:01 INFO - PROCESS | 6331 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:27:02 INFO - PROCESS | 6331 | RSS: Main: 158232576 09:27:02 INFO - PROCESS | 6331 | 09:27:03 INFO - PROCESS | 6331 | Cycle 1(1): loaded http://localhost:46803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46803/tests/kraken/driver.html?testName=ai-astar) 09:27:04 INFO - PROCESS | 6331 | RSS: Main: 159043584 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - PROCESS | 6331 | __start_tp_report 09:27:04 INFO - PROCESS | 6331 | _x_x_mozilla_page_load 09:27:04 INFO - PROCESS | 6331 | _x_x_mozilla_page_load_details 09:27:04 INFO - PROCESS | 6331 | |i|pagename|runs| 09:27:04 INFO - PROCESS | 6331 | |0;ai-astar;101;114;106;110;111;111;109;110;113;110 09:27:04 INFO - PROCESS | 6331 | |1;audio-beat-detection;144;120;149;166;121;149;149;118;178;122 09:27:04 INFO - PROCESS | 6331 | |2;audio-dft;163;165;162;164;160;161;166;161;163;163 09:27:04 INFO - PROCESS | 6331 | |3;audio-fft;74;75;76;179;76;76;75;75;165;76 09:27:04 INFO - PROCESS | 6331 | |4;audio-oscillator;85;85;147;84;84;84;146;84;83;150 09:27:04 INFO - PROCESS | 6331 | |5;imaging-gaussian-blur;118;117;117;118;117;117;117;117;117;117 09:27:04 INFO - PROCESS | 6331 | |6;imaging-darkroom;146;147;147;147;146;147;149;148;147;148 09:27:04 INFO - PROCESS | 6331 | |7;imaging-desaturate;95;97;95;95;95;96;95;96;95;97 09:27:04 INFO - PROCESS | 6331 | |8;json-parse-financial;52;52;55;51;52;52;50;51;50;50 09:27:04 INFO - PROCESS | 6331 | |9;json-stringify-tinderbox;62;61;61;62;65;61;61;61;62;62 09:27:04 INFO - PROCESS | 6331 | |10;stanford-crypto-aes;71;72;72;73;73;72;71;72;81;80 09:27:04 INFO - PROCESS | 6331 | |11;stanford-crypto-ccm;134;120;128;118;123;120;118;120;158;125 09:27:04 INFO - PROCESS | 6331 | |12;stanford-crypto-pbkdf2;159;154;157;153;157;154;154;154;154;152 09:27:04 INFO - PROCESS | 6331 | |13;stanford-crypto-sha256-iterative;63;67;67;63;65;64;62;61;64;63 09:27:04 INFO - PROCESS | 6331 | __end_tp_report 09:27:04 INFO - PROCESS | 6331 | __start_cc_report 09:27:04 INFO - PROCESS | 6331 | _x_x_mozilla_cycle_collect,901 09:27:04 INFO - PROCESS | 6331 | __end_cc_report 09:27:04 INFO - PROCESS | 6331 | __startTimestamp1470500824021__endTimestamp 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - PROCESS | 6331 | ------- Summary: start ------- 09:27:04 INFO - PROCESS | 6331 | Number of tests: 14 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - PROCESS | 6331 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:3.69 (3.3%) stddev-sans-first:2.30 09:27:04 INFO - PROCESS | 6331 | Values: 101.0 114.0 106.0 110.0 111.0 111.0 109.0 110.0 113.0 110.0 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - PROCESS | 6331 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:149.00 stddev:20.88 (14.0%) stddev-sans-first:22.12 09:27:04 INFO - PROCESS | 6331 | Values: 144.0 120.0 149.0 166.0 121.0 149.0 149.0 118.0 178.0 122.0 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - PROCESS | 6331 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.87 (1.1%) stddev-sans-first:1.99 09:27:04 INFO - PROCESS | 6331 | Values: 163.0 165.0 162.0 164.0 160.0 161.0 166.0 161.0 163.0 163.0 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - PROCESS | 6331 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.50 stddev:40.88 (54.1%) stddev-sans-first:42.67 09:27:04 INFO - PROCESS | 6331 | Values: 74.0 75.0 76.0 179.0 76.0 76.0 75.0 75.0 165.0 76.0 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - PROCESS | 6331 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:84.00 stddev:30.71 (36.6%) stddev-sans-first:31.85 09:27:04 INFO - PROCESS | 6331 | Values: 85.0 85.0 147.0 84.0 84.0 84.0 146.0 84.0 83.0 150.0 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - PROCESS | 6331 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 09:27:04 INFO - PROCESS | 6331 | Values: 118.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - PROCESS | 6331 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 09:27:04 INFO - PROCESS | 6331 | Values: 146.0 147.0 147.0 147.0 146.0 147.0 149.0 148.0 147.0 148.0 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - PROCESS | 6331 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 09:27:04 INFO - PROCESS | 6331 | Values: 95.0 97.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 97.0 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - PROCESS | 6331 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:1.51 (2.9%) stddev-sans-first:1.59 09:27:04 INFO - PROCESS | 6331 | Values: 52.0 52.0 55.0 51.0 52.0 52.0 50.0 51.0 50.0 50.0 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - PROCESS | 6331 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:1.23 (2.0%) stddev-sans-first:1.30 09:27:04 INFO - PROCESS | 6331 | Values: 62.0 61.0 61.0 62.0 65.0 61.0 61.0 61.0 62.0 62.0 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - PROCESS | 6331 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:72.50 stddev:3.65 (5.0%) stddev-sans-first:3.74 09:27:04 INFO - PROCESS | 6331 | Values: 71.0 72.0 72.0 73.0 73.0 72.0 71.0 72.0 81.0 80.0 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - PROCESS | 6331 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:124.00 stddev:12.19 (9.8%) stddev-sans-first:12.61 09:27:04 INFO - PROCESS | 6331 | Values: 134.0 120.0 128.0 118.0 123.0 120.0 118.0 120.0 158.0 125.0 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - PROCESS | 6331 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:154.00 stddev:2.15 (1.4%) stddev-sans-first:1.66 09:27:04 INFO - PROCESS | 6331 | Values: 159.0 154.0 157.0 153.0 157.0 154.0 154.0 154.0 154.0 152.0 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - PROCESS | 6331 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.97 (3.1%) stddev-sans-first:2.06 09:27:04 INFO - PROCESS | 6331 | Values: 63.0 67.0 67.0 63.0 65.0 64.0 62.0 61.0 64.0 63.0 09:27:04 INFO - PROCESS | 6331 | -------- Summary: end -------- 09:27:04 INFO - PROCESS | 6331 | 09:27:04 INFO - TEST-INFO | 6331: exit 0 09:27:04 INFO - TEST-OK | kraken | took 60657ms 09:27:04 INFO - SUITE-END | took 1171s 09:27:05 INFO - Completed test suite (00:19:31) 09:27:05 INFO - javascript benchmark 09:27:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7949.461495982887, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3369.0735047861835, 3393.5079413485046, 3394.032700680307, 3420.469827176785, 3424.4863270509422, 5855.648661080333, 5927.496162826165, 5949.0, 5963.582549221551, 5981.431763982415, 5831.7958871439505, 5870.794522191724, 5914.2311499505, 5927.585069045169, 5939.970300148504, 5326.627136100465, 5371.462853714617, 5405.621606487547, 5425.565954723633, 5450.373207081197, 5303.151495760679, 5308.283381743454, 5310.309659744247, 5343.305370301855, 5397.7031263280505, 5343.064963631368, 5346.973265133669, 5363.195520671911, 5365.678059316434, 5378.139497680372, 5407.729613519308, 5408.972955135199, 5418.051840927822, 5423.945760542383, 5457.945420545783, 5105.9489405106215, 5202.297689811902, 5228.163493840967, 5319.335083114611, 5321.840344789663, 5819.505342045931, 5820.505257053155, 5827.388124246978, 5879.470847623735, 5918.082697181901, 6222.0, 6295.653739044351, 6316.084167795644, 6325.96837015812, 6340.556161068727, 6112.480439162677, 6140.320203811457, 6145.600535965148, 6368.426841584233, 6375.2987171411105, 5773.278340207474, 5790.94209057904, 5817.447342502455, 5822.1266809978415, 5823.155642431823, 6315.621062736159, 6327.936720632827, 6362.809115726535, 6381.936180638227, 6395.104685344056, 6021.458068773743, 6099.390060993954, 6103.845024071831, 6120.019327425489, 6121.056693972082, 6222.471089957405, 6288.182536270256, 6344.238691357066, 6345.587536810092, 6356.14192084072, 6271.6550589718, 6301.810945671546, 6320.55756097078, 6331.715072821734, 6354.3645635437015, 6081.604695694854, 6175.258968923668, 6297.527685423612, 6354.904676429857, 6378.298387177407, 4731.952680473151, 4765.475797662254, 4794.400699912511, 4824.300476430898, 4841.515848415131, 4230.830766769356, 4257.70196086271, 4264.424302719093, 4271.209826182167, 4302.419173411612, 5919.437653422918, 5937.376575459601, 6030.849228769316, 6060.303065147565, 6088.665123418255, 6232.688365581703, 6297.4017468340435, 6323.620582765049, 6339.2392912850755, 6339.904901426482, 6037.396260373927, 6047.9395206047375, 6073.5748497604745, 6077.270727512639, 6084.482818960438, 5267.578593712494, 5300.787968481218, 5446.046941785172, 5456.836294911159, 5490.780368785204, 6314.810555683337, 6434.871302573923, 6444.903326450107, 6450.548461607643, 6452.419282264619, 6193.225846769154, 6223.471004964629, 6231.158793562811, 6246.0, 6313.526485513513, 6362.77730279438, 6415.8716825662295, 6419.775307864389, 6463.870722585616, 6496.0255961606135, 6104.847378815388, 6229.4393504584805, 6236.251649802053, 6240.625562466266, 6259.593126446766, 6325.810225693236, 6326.746930122744, 6343.238811342669, 6351.1425957496995, 6373.171487706569, 6087.908681369871, 6140.263168419819, 6211.0, 6212.006079027334, 6232.501399888089, 6115.480184184395, 6169.259688837368, 6182.165407669907, 6185.381461853779, 6218.129461875432, 6105.877882442415, 6106.389361063858, 6155.1075094112, 6164.907526387197, 6173.290071641819, 6134.78528251509, 6184.969075154595, 6229.0, 6256.874862502816, 6276.968615156895, 6140.723667434887, 6176.104464852481, 6185.103160041679, 6187.659678717534, 6197.25632924052], "value": 5799.20994747136, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.3958692340351, 629.553017357676, 643.1253495246464, 653.8724948635016, 676.8747781660396, 42329.15341693168, 46571.534284657144, 46658.76670616646, 46691.766541167286, 46893.0, 46658.30012549814, 46830.765846170805, 47168.0566388672, 47332.0, 47413.0, 9071.047540008303, 9213.769655758626, 9223.584938677775, 9226.031266716998, 9226.446413215228, 8922.50926199062, 8935.508547029911, 8976.41653292534, 8978.955105224464, 9005.189532942033, 9020.909790902106, 9034.593443295034, 9042.728718138467, 9048.683296084639, 9069.229115525188, 8958.776030599287, 9008.504532250723, 9019.188273055424, 9048.14042665949, 9084.0, 9206.0, 9227.26181905446, 9284.303677224236, 9284.814303713887, 9292.814143717156, 45318.0, 45462.31806522905, 45641.77179114083, 45775.54224457746, 45874.082518349445, 3862.633049860259, 3945.4673619061346, 4094.303968325392, 4150.128473020669, 4197.727147735418, 35574.46638300428, 35667.643323566954, 35692.286154277026, 35865.0, 36047.63952360469, 4434.667399944985, 4464.910701785946, 4486.439195100613, 4549.61328287096, 4574.6340292776495, 251090.0, 311177.0, 370694.0, 373766.0, 377132.0, 68321.3167868325, 68391.31608683949, 68874.3112568868, 68944.6552767233, 69005.0, 40437.393439098436, 41248.58751412507, 41286.1742765143, 71894.64052679807, 72065.0, 19889.204431822855, 20103.09536070851, 20113.39659810208, 20114.798852011292, 20126.89936550337, 15262.923685381502, 15363.231838408035, 15386.615334616725, 15457.458988935334, 15527.534173974798, 21243.68134477984, 21286.680699789515, 21424.571508570054, 21450.463738406666, 21515.67726484104, 7541.924580754232, 7560.697572097055, 7653.502522336031, 7744.41916856238, 7814.413918955987, 1074.711899520906, 1099.9505022274018, 1229.624964385853, 1256.7549327880974, 1258.4840215511779, 34477.31045379129, 34743.0, 34876.65123348734, 35209.82395088059, 35451.4682279766, 1153.1466714631113, 1168.3282112785182, 1168.9590864319878, 1247.5820600098887, 1306.1640550047978, 17954.5511362217, 18122.728159077626, 18192.636147277244, 18195.727064094048, 18570.44288671342, 409395.0, 609331.0, 623772.0, 946957.0, 950668.0, 69176.30823691799, 69604.0, 69653.30346696569, 69909.30090699028, 69960.65019674868, 1473.7715654073636, 1505.8494150584854, 1524.5883611424854, 1529.4723320454425, 1539.2150003498296, 35177.64822351744, 35464.0, 35640.643593563735, 36034.45948310725, 36551.45172822463, 59560.404395955484, 60155.09767353406, 60278.69860650844, 60428.0, 60454.39545604488, 400913.0, 401783.0, 406663.0, 407291.0, 407716.0, 31417.21456963594, 32283.677163229007, 32619.18452038718, 32643.836780815946, 33898.0, 54703.17945230904, 55081.0, 55292.0, 56422.71788641195, 57091.14363284471, 45562.772186138856, 46591.30113048375, 47286.0, 47361.289580655626, 49064.75467622639, 47813.760931195124, 47935.28097078477, 48985.51014489809, 49230.50769492259, 49964.25053624271, 47473.52526474829, 47561.76219118882, 48324.27513587369, 48532.27201591909, 50342.748286258335, 38602.80698596489, 41106.588934110274, 41187.38218926779, 41343.58656413518, 41827.58172418237, 31201.53197701991, 31582.526262105628, 31797.682023179474, 31895.681043190198, 32031.6796832038], "value": 22096.8805764343, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.7221217360021, 409.4370240918736, 417.5407052242533, 417.8725488725937, 426.47543521468594, 19011.0, 20369.0, 20897.582048359043, 21363.57272854542, 21638.3508494745, 20658.89670551649, 20669.586608267826, 20947.581048379023, 21003.684944725803, 21138.68291975618, 5781.219535362735, 5950.642961422307, 5957.970210148943, 5982.581219314649, 6000.339962604132, 5763.769449222026, 5938.1389698493695, 5954.553408494358, 5960.105984102376, 5985.491233245158, 5988.610740301889, 5989.311229208632, 6026.5178785697035, 6036.39636036395, 6049.304330002062, 5969.253843269591, 5978.790742324041, 6018.909716354258, 6024.578279520435, 6048.939510604881, 5835.766569337221, 5849.2103566018895, 5881.029630111027, 5908.911366329508, 5921.348651648315, 15355.846441535554, 22313.44216394587, 22981.885090574608, 23219.651705224434, 24107.879460602584, 2416.6375043743406, 2660.308319836837, 2989.17797605658, 3000.3699223162944, 3126.421612001787, 16253.349866005346, 16307.592310192222, 16749.330026798914, 16986.235619397157, 17007.57481062971, 2167.1331467413, 2171.3160354488286, 2194.2539536557647, 2220.822334213259, 2306.6194077977116, 58427.41572584262, 58494.0, 59476.70261648708, 79824.60087699583, 92201.53899230529, 18750.624987500174, 18978.0, 19122.22727704475, 19170.0, 19581.0, 34687.479687804705, 34870.0, 34895.12762180915, 34932.47601285983, 35169.0, 11119.888801112047, 11461.255018423775, 11477.827832582518, 11492.080633549296, 11681.415929203677, 9590.0, 9733.659321923698, 9751.21990240779, 9851.0, 9891.406515609087, 9250.12162068237, 9704.27217958656, 9742.61029558824, 9770.609175633037, 9822.361546499455, 3574.3208790329754, 3624.2751449710163, 3697.4638677391627, 3747.512823333004, 3844.2695887781233, 1000.9599616015423, 1016.2428990402198, 1028.5320179318542, 1066.1311031509294, 1105.9668209953713, 20558.794412055988, 20658.690119648218, 20776.58446831055, 20873.0, 20983.265585704426, 1030.5105075089273, 1061.7717190804015, 1068.3536460441476, 1069.893010698924, 1126.1722633864103, 11214.775704486028, 11355.772884542263, 11452.828207576893, 11477.36874471912, 11568.942155289169, 505036.0, 508682.0, 510691.0, 518098.0, 520658.0, 84639.0, 85994.0, 87292.0, 87689.0, 89477.55261223653, 1029.4955471818755, 1048.156234231451, 1071.2501249125487, 1073.8550295710136, 1074.978500429987, 17644.1177941105, 17935.73096403581, 18044.729329059814, 18241.270349185885, 18408.0, 40837.591624083376, 41766.79116604398, 42245.577544225394, 43636.0, 43685.344719828594, 57499.42500574941, 58539.12191317219, 59130.70434647799, 59701.40298596959, 60019.699901500215, 9079.95460022722, 9185.908140918773, 9234.769130771785, 9316.254699624149, 9335.813283734424, 8500.574971251537, 10102.0, 13178.670533236746, 13267.402966866708, 13286.933565332112, 11889.167758257185, 12118.333491658044, 12268.754624907631, 12287.631371058882, 12471.438785254504, 11775.587854425054, 11898.524059037542, 11929.880701192877, 12027.338496382434, 12113.394330283627, 12013.699657508632, 12186.086043546593, 12292.0, 12344.567940122053, 12411.131220814455, 8285.25432711059, 8425.283850872744, 9144.771380715269, 9210.263178945803, 9378.953105234703, 8890.911090889009, 11472.770544588895, 11821.231619944676, 11865.0, 12074.154809163274], "value": 10516.243176185655, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1558.259826582373, 1587.912664803436, 1757.3673477548089, 1839.1080326041877, 1864.3847530314997, 8843.425177363475, 9427.528623568829, 9651.855222171673, 9712.17446517046, 9743.512824358771, 9716.854247186298, 9776.951115244414, 9864.802703945918, 9870.506474676255, 9875.061869122439, 2448.987755061227, 2483.7019557653107, 2484.968737973748, 2489.987550062247, 2490.5890528062937, 2451.9877400613063, 2469.6912885889265, 2478.578641630918, 2481.9451733013398, 2489.3029951613485, 2464.8767561621935, 2471.3574470637673, 2516.773490385865, 2519.143491212987, 2532.4555220627562, 2394.545036443079, 2406.6750988616486, 2412.203972689017, 2436.780689737914, 2440.3533063738123, 2342.723215847367, 2351.098742157181, 2355.1286024170995, 2366.2309749331366, 2374.798142157919, 9544.95227523865, 9545.61817527298, 9564.56959436827, 9572.377795443273, 9576.616935322649, 5486.862828429281, 5691.174779656968, 5710.828675139711, 5711.343195532525, 5717.371089180187, 3436.8765480883226, 3541.327147841902, 3566.9311799156426, 3567.0369000370015, 3592.0660628236587, 1171.4611278811756, 1192.6004788395899, 1213.7572485502935, 1214.878512148787, 1244.6826059354808, 13044.934775326063, 13089.345532723326, 13109.147905386215, 13115.213087214797, 13229.603111906657, 4590.288505281686, 4732.976335118303, 4823.686460380064, 4855.830045948445, 4866.7566621668775, 10385.273030887916, 10388.065074143364, 10403.115735162444, 10410.583576656849, 10430.061294483532, 5553.0, 5558.916616250759, 5580.302462192226, 5600.355959064678, 5605.887882242332, 4597.287420449836, 5116.0, 5180.4560521145495, 5210.687358758487, 5239.790408383698, 4092.728160078087, 4103.8974025649595, 4116.115035267432, 4138.689598280141, 4138.751674899516, 1195.6711904226233, 1228.993855030719, 1230.563150081726, 1237.1216436330126, 1240.1009268280425, 974.5711886769799, 1020.3214862116757, 1028.321307936758, 1032.4528000159928, 1039.4594810698395, 5820.941790582125, 6043.8489037773525, 6056.121862329937, 6186.907196392058, 6671.5997040177745, 1036.6630844975414, 1083.6423980086552, 1094.43089593411, 1120.5293776613842, 1140.7946569617548, 4415.0, 4520.932186017212, 4613.123506533748, 4634.142683603477, 4648.3259927310355, 11322.32066076038, 11724.472398741906, 11828.349440780668, 11848.229865058744, 11852.466639001266, 10874.510647020903, 11326.207165498501, 11764.117691173196, 11764.411779411166, 11841.289522628498, 8697.08680588529, 8864.024957254696, 8925.285977121815, 8943.776405589912, 8946.821063578822, 6389.36106389376, 6540.051692504655, 6575.671216439255, 6615.735370585123, 6769.255381907888, 10263.897361026295, 10546.683599492027, 10758.300710453796, 10910.509027093958, 10976.780464390828, 10745.301555398873, 10826.51280692355, 10862.891371086187, 10919.672409827717, 10935.617253396093, 8109.959450202948, 8277.130901255281, 8341.541215233221, 8416.873746893923, 8567.74296771098, 9107.817843643223, 9159.129882661136, 9192.218661413855, 9212.216961558343, 9219.723408297761, 7920.485168464032, 7975.162607926084, 7991.84016319682, 8050.235227653364, 8167.918320816716, 7742.612869356397, 7790.844183116193, 7797.454178207698, 7850.803729906798, 7912.881306780288, 7222.674979625825, 7501.699932002877, 7554.508956917783, 7557.433192510473, 7592.240775922363, 5340.679559226459, 5430.647007944471, 5456.181572764117, 5498.945010549844, 5511.173324001432, 5649.435056494318, 5669.291338582677, 5823.155642431909, 5874.618149820248, 5893.941060589339], "value": 4945.837355793117, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.1952072390244, 348.2964411887988, 349.0784329370464, 355.12461781708095, 355.98042107684074, 5857.56068294878, 5915.556333275, 5958.553108516857, 5973.402659734024, 5976.65525256817, 5819.330776960651, 5825.621334613247, 5828.533717302616, 5844.824655260349, 5853.707314634273, 3920.411938209263, 4422.204003279408, 4505.752183629899, 4508.413906192207, 4510.887227819298, 4522.4346956630425, 4545.545445455461, 4554.385158003677, 4577.771111444431, 4582.541745825408, 4480.775961201927, 4529.932051019221, 4540.500544940054, 4552.726836389811, 4564.612007979325, 4293.613574778269, 4380.6057454829215, 4430.180416622935, 4434.578715022068, 4559.8404055858055, 3932.488776459071, 3935.0, 3938.547067087293, 3942.349512330462, 3948.190620922704, 5668.773249070032, 5691.800786972478, 5708.657480551139, 5725.541956643458, 5728.99742545053, 4933.0, 5140.1518749406305, 5162.199859021857, 5193.8961220775755, 5224.294720212761, 6109.327973922865, 6111.694415279218, 6139.508839292846, 6160.4455598995855, 6185.288691800455, 4419.41464243418, 4431.313146462304, 4436.689431739779, 4450.732956022649, 4453.755043472608, 6030.833812248561, 6146.815595532141, 6288.811335659938, 6304.27500837405, 6398.912184928527, 4512.932306015412, 4616.399868017136, 4620.306953956933, 4628.236341003697, 4637.652176086807, 4662.510436404196, 4671.6262698984, 4694.108119457293, 4709.128811169944, 4710.175719249186, 5204.843854684365, 5240.580753539708, 5272.736363181825, 5291.1798671206025, 5296.3909150447425, 6120.102768141801, 6123.785667501616, 6131.908021379683, 6147.784827531015, 6154.5076393888385, 1606.8875178737376, 1610.9677806443806, 1617.9029258244543, 1620.5219460259252, 1626.1137679964447, 1040.5317607076695, 1053.3416614615865, 1055.8205105132147, 1056.9365838049587, 1063.0220197418394, 5278.973605132027, 5284.392294886137, 5335.706536140549, 5348.171033489815, 5363.973180134074, 5597.824456864023, 5602.187682785973, 5607.36453866682, 5664.575156863251, 5668.809549994465, 4979.377577802775, 5318.73406329682, 5319.361676598833, 5330.3742358581, 5336.184627991005, 2941.82305094233, 2988.656304524964, 3017.89437369691, 3051.6032915720816, 3063.1270088024808, 5721.681424773621, 5733.283339582552, 5767.981206577748, 5862.530997520188, 6133.233345831771, 6329.430351268408, 6363.58636688623, 6408.231012278463, 6433.967830160819, 6460.903086453707, 6498.870022599616, 6547.34526547351, 6615.63614001225, 6629.1713535808985, 6646.96676516624, 6196.969015154896, 6423.164988551458, 6434.587029863801, 6440.388163124496, 6454.967205247326, 6365.517448195115, 6367.471806766435, 6414.935850641434, 6417.647029413427, 6428.646424446701, 6325.272593651789, 6469.708863101266, 6532.346765323429, 6550.246721627074, 6554.0, 4491.618212451978, 4519.41247637805, 4530.61489773373, 4535.705179163344, 4543.909121817611, 6223.595466294676, 6307.306196318493, 6386.744530218739, 6435.967820160869, 6452.128962590178, 6153.753849845956, 6182.218001899253, 6186.443220110212, 6212.596181248205, 6234.539830394175, 6003.907987386412, 6223.37766223374, 6227.564070515021, 6251.437370636664, 6321.462675672619, 6111.236095488064, 6120.663363515049, 6128.785492507741, 6143.631382117087, 6152.523394385405, 6248.4064013918605, 6265.840819448416, 6276.9372306276355, 6292.056191571301, 6352.682365881595, 5830.53355731549, 6082.300535438304, 6086.817395478142, 6095.262850087704, 6105.572609917441], "value": 4628.335657239346, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.9721409750656, 833.1460253240432, 842.5155535567051, 889.5107690770075, 899.9370044096912, 16470.835291647094, 17213.311467541298, 17728.556786080353, 17903.910480447597, 18056.36802711902, 16446.83553164471, 16664.250108745106, 16707.164641767922, 16713.83286167138, 16758.162091895418, 750.6997201119541, 873.6330741088726, 882.2368651116769, 883.5361435246483, 898.3846065445191, 891.2201823404521, 894.8568229083348, 894.9105089491031, 895.1361935732017, 897.0849733272058, 930.9581068851918, 931.0317270039151, 931.3480563605469, 931.7763736703176, 933.4679232837285, 918.669279059538, 923.6213152607465, 926.0693003531408, 927.4435338796735, 929.5584597316255, 683.3815397065664, 684.0935760117864, 684.7261095561765, 685.7085738561142, 688.7004153193377, 15791.21043947798, 15833.0, 15914.602134946603, 15947.521574352788, 15977.121258330788, 14006.299685015709, 14027.71944561103, 14450.566483005527, 14481.275936203148, 14504.782428263585, 12866.099373043891, 12871.485140594365, 12936.094473386867, 12945.482180712761, 13087.869121308855, 4756.5243475652505, 4770.427548694144, 4797.088553174885, 4817.349657796188, 4825.565699087099, 85596.0, 86427.99999999937, 86878.56560717156, 87073.56463217706, 89126.5543672284, 11604.6518604442, 11706.297622142529, 11742.412879355998, 11842.230255033395, 12170.939145304217, 22582.322530324116, 22678.0, 22688.319350419515, 22702.205422810122, 22720.431989200402, 9088.227500662386, 9199.95400023009, 9203.769905752275, 9228.446293222429, 9263.490508021989, 5126.846194614168, 5162.896742065138, 5226.869328266824, 5239.26650268955, 5399.190121481809, 3712.8514859405864, 3744.02655309616, 3771.0949372150485, 3778.112143646241, 3787.981060094682, 644.1979735229576, 653.9574927629689, 706.7632343165097, 740.3336996702902, 740.8592367450167, 590.1266126133261, 654.5614438326332, 714.4248879651826, 722.8048426924701, 764.747633281016, 9670.854937175947, 10323.122534584494, 10349.793004139876, 10650.520726567323, 11200.0, 741.1032650492964, 742.3170682971679, 747.5850902749027, 764.6903004283274, 778.132382393627, 4795.136875362468, 5118.513741194581, 5191.558717508979, 5215.400228973641, 5237.659552129099, 96144.51927740456, 125332.0, 136801.0, 137143.31428342796, 137824.31087844496, 115102.42448787703, 116771.0, 116844.0, 117353.4132329333, 118598.4070079644, 95198.0, 99461.0, 101524.49237753617, 101587.0, 101695.0, 9684.41893486393, 9738.269629777653, 9822.950885245815, 9867.856358664169, 9891.01089891034, 58924.0, 59680.0, 60680.69659651673, 60859.0, 62520.687396562724, 87991.0, 90002.54998724964, 91193.54403227942, 91295.0, 92985.0, 11116.277441966246, 11435.256708313933, 11459.942700286445, 11490.942545287555, 11851.762964740828, 14203.573892782819, 14255.50105746294, 14290.57128286153, 14403.711925761636, 14544.272786360429, 12877.162984405984, 13348.466061357436, 13613.0, 13660.863391366356, 14195.219262940638, 12757.617271481871, 12814.487420503448, 12928.418221179882, 13134.211947283193, 13330.733385332045, 13721.382537785625, 13961.301934903417, 14379.496717614833, 14981.850181498046, 15215.0, 12281.140320177501, 12921.28932908699, 13064.412101455267, 13099.0, 13163.60509184726, 12326.260424374566, 12878.291693956548, 13050.0, 13117.672058198621, 13156.144850584682], "value": 8180.095783609745, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1503.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 114.0, 106.0, 110.0, 111.0, 111.0, 109.0, 110.0, 113.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 120.0, 149.0, 166.0, 121.0, 149.0, 149.0, 118.0, 178.0, 122.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 162.0, 164.0, 160.0, 161.0, 166.0, 161.0, 163.0, 163.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 179.0, 76.0, 76.0, 75.0, 75.0, 165.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 147.0, 84.0, 84.0, 84.0, 146.0, 84.0, 83.0, 150.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 149.0, 148.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 97.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 55.0, 51.0, 52.0, 52.0, 50.0, 51.0, 50.0, 50.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 62.0, 65.0, 61.0, 61.0, 61.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 72.0, 73.0, 73.0, 72.0, 71.0, 72.0, 81.0, 80.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 120.0, 128.0, 118.0, 123.0, 120.0, 118.0, 120.0, 158.0, 125.0], "value": 126.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 154.0, 157.0, 153.0, 157.0, 154.0, 154.0, 154.0, 154.0, 152.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 67.0, 63.0, 65.0, 64.0, 62.0, 61.0, 64.0, 63.0], "value": 63.9, "unit": "score"}]}]} 09:27:05 INFO - Return code: 0 09:27:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:27:05 ERROR - # TBPL SUCCESS # 09:27:05 INFO - Running post-action listener: _resource_record_post_action 09:27:05 INFO - [mozharness: 2016-08-06 16:27:05.316713Z] Finished run-tests step (success) 09:27:05 INFO - Running post-run listener: _resource_record_post_run 09:27:05 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 328749056; Read time: 8; Write time: 265488 09:27:05 INFO - TinderboxPrint: CPU usage
13.3% 09:27:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:27:05 INFO - TinderboxPrint: I/O write bytes / time
328,749,056 / 265,488 09:27:05 INFO - TinderboxPrint: CPU idle
8,222.2 (86.7%) 09:27:05 INFO - TinderboxPrint: CPU user
1,201.3 (12.7%) 09:27:05 INFO - TinderboxPrint: Swap in / out
0 / 0 09:27:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78290944; Read time: 0; Write time: 83936 09:27:05 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249565184; Read time: 8; Write time: 181528 09:27:05 INFO - Running post-run listener: _upload_blobber_files 09:27:05 INFO - Blob upload gear active. 09:27:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:27:05 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 09:27:05 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'] 09:27:05 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 09:27:06 INFO - (blobuploader) - INFO - Open directory for files ... 09:27:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:27:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:27:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:07 INFO - (blobuploader) - INFO - Done attempting. 09:27:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:27:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:27:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:11 INFO - (blobuploader) - INFO - Done attempting. 09:27:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:27:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:27:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:11 INFO - (blobuploader) - INFO - Done attempting. 09:27:11 INFO - (blobuploader) - INFO - Iteration through files over. 09:27:11 INFO - Return code: 0 09:27:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:27:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:27:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68724fb1f13d921a5fa886af92cd9a485ce6835a8475535da20a52926ed7bb4546942292152b87cb688924690224885708b6017f6d2b3da8b68cc15ec2c1946c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f93020540536b341af0fb84a9b0207fcbae3f084149a5ef88c0d01c357f89e6b82d06782bd26ddcb168b13718585063edbd231c01417a551e9e485ed89be9a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/162c3ee58ed790e886cefc400166adc6d1d0544e51f91fb982ccfbb1974b76a54c08d90196b8e78ab6586438c3319f6f588fb830c234f9050693d63e36db6a85"} 09:27:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:27:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:27:11 INFO - Contents: 09:27:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68724fb1f13d921a5fa886af92cd9a485ce6835a8475535da20a52926ed7bb4546942292152b87cb688924690224885708b6017f6d2b3da8b68cc15ec2c1946c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f93020540536b341af0fb84a9b0207fcbae3f084149a5ef88c0d01c357f89e6b82d06782bd26ddcb168b13718585063edbd231c01417a551e9e485ed89be9a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/162c3ee58ed790e886cefc400166adc6d1d0544e51f91fb982ccfbb1974b76a54c08d90196b8e78ab6586438c3319f6f588fb830c234f9050693d63e36db6a85"} 09:27:11 INFO - Running post-run listener: copy_logs_to_upload_dir 09:27:11 INFO - Copying logs to upload dir... 09:27:11 INFO - mkdir: /builds/slave/test/build/upload/logs 09:27:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.200055 ========= master_lag: 0.35 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-08-06 09:27:11.646905) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 09:27:11.652672) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273 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/68724fb1f13d921a5fa886af92cd9a485ce6835a8475535da20a52926ed7bb4546942292152b87cb688924690224885708b6017f6d2b3da8b68cc15ec2c1946c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f93020540536b341af0fb84a9b0207fcbae3f084149a5ef88c0d01c357f89e6b82d06782bd26ddcb168b13718585063edbd231c01417a551e9e485ed89be9a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/162c3ee58ed790e886cefc400166adc6d1d0544e51f91fb982ccfbb1974b76a54c08d90196b8e78ab6586438c3319f6f588fb830c234f9050693d63e36db6a85"} build_url:https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011219 build_url: 'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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/68724fb1f13d921a5fa886af92cd9a485ce6835a8475535da20a52926ed7bb4546942292152b87cb688924690224885708b6017f6d2b3da8b68cc15ec2c1946c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f93020540536b341af0fb84a9b0207fcbae3f084149a5ef88c0d01c357f89e6b82d06782bd26ddcb168b13718585063edbd231c01417a551e9e485ed89be9a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/162c3ee58ed790e886cefc400166adc6d1d0544e51f91fb982ccfbb1974b76a54c08d90196b8e78ab6586438c3319f6f588fb830c234f9050693d63e36db6a85"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 09:27:11.678253) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 09:27:11.678595) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1470497518.212209-436236273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 09:27:11.728107) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 09:27:11.728459) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 09:27:11.728846) ========= ========= Total master_lag: 0.47 =========