builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1470860497.11 results: success (0) buildid: 20160810103821 builduid: 08a2541c282a49d7a818d473b26f8ad8 revision: f5a9d33557dd860e74994a3a650e743569883cbb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 13:21:37.106110) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 13:21:37.106482) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 13:21:37.106744) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 13:21:37.127477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 13:21:37.127833) ========= 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=33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-10 13:21:37-- 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% 88.7M=0s 2016-08-10 13:21:37 (88.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117914 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 13:21:37.288944) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 13:21:37.289226) ========= 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=33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014599 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 13:21:37.345913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 13:21:37.346221) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f5a9d33557dd860e74994a3a650e743569883cbb --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 f5a9d33557dd860e74994a3a650e743569883cbb --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=33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-10 13:21:37,732 truncating revision to first 12 chars 2016-08-10 13:21:37,733 Setting DEBUG logging. 2016-08-10 13:21:37,733 attempt 1/10 2016-08-10 13:21:37,733 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f5a9d33557dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 13:21:38,670 unpacking tar archive at: mozilla-aurora-f5a9d33557dd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.295801 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 13:21:38.655921) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 13:21:38.656239) ========= script_repo_revision: f5a9d33557dd860e74994a3a650e743569883cbb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 13:21:38.656632) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 13:21:38.656945) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 13:21:38.667347) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 13 secs) (at 2016-08-10 13:21:38.667669) ========= /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=33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:21:39 INFO - MultiFileLogger online at 20160810 13:21:39 in /builds/slave/test 13:21:39 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 13:21:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:21:39 INFO - {'append_to_log': False, 13:21:39 INFO - 'base_work_dir': '/builds/slave/test', 13:21:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:21:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:21:39 INFO - 'branch': 'Mozilla-Aurora', 13:21:39 INFO - 'buildbot_json_path': 'buildprops.json', 13:21:39 INFO - 'config_files': ('talos/linux_config.py',), 13:21:39 INFO - 'default_actions': ('clobber', 13:21:39 INFO - 'read-buildbot-config', 13:21:39 INFO - 'download-and-extract', 13:21:39 INFO - 'populate-webroot', 13:21:39 INFO - 'create-virtualenv', 13:21:39 INFO - 'install', 13:21:39 INFO - 'run-tests'), 13:21:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:21:39 INFO - 'download_minidump_stackwalk': True, 13:21:39 INFO - 'download_symbols': 'ondemand', 13:21:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:21:39 INFO - 'tooltool.py': '/tools/tooltool.py', 13:21:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:21:39 INFO - '/tools/misc-python/virtualenv.py')}, 13:21:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:21:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:21:39 INFO - 'installer_path': 'installer.exe', 13:21:39 INFO - 'log_level': 'info', 13:21:39 INFO - 'log_name': 'talos', 13:21:39 INFO - 'log_to_console': True, 13:21:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:21:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:21:39 INFO - 'opt_config_files': (), 13:21:39 INFO - 'pip_index': False, 13:21:39 INFO - 'sps_profile': False, 13:21:39 INFO - 'sps_profile_interval': 0, 13:21:39 INFO - 'suite': 'dromaeojs-e10s', 13:21:39 INFO - 'system_bits': '32', 13:21:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:21:39 INFO - 'title': 'talos-linux64-ix-063', 13:21:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:21:39 INFO - 'use_talos_json': True, 13:21:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:21:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:21:39 INFO - 'work_dir': 'build'} 13:21:39 INFO - [mozharness: 2016-08-10 20:21:39.148825Z] Running clobber step. 13:21:39 INFO - Running pre-action listener: _resource_record_pre_action 13:21:39 INFO - Running main action method: clobber 13:21:39 INFO - rmtree: /builds/slave/test/build 13:21:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:21:39 INFO - Running post-action listener: _resource_record_post_action 13:21:39 INFO - [mozharness: 2016-08-10 20:21:39.608601Z] Finished clobber step (success) 13:21:39 INFO - [mozharness: 2016-08-10 20:21:39.608701Z] Running read-buildbot-config step. 13:21:39 INFO - Running pre-action listener: _resource_record_pre_action 13:21:39 INFO - Running main action method: read_buildbot_config 13:21:39 INFO - Using buildbot properties: 13:21:39 INFO - { 13:21:39 INFO - "project": "", 13:21:39 INFO - "product": "firefox", 13:21:39 INFO - "script_repo_revision": "production", 13:21:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 13:21:39 INFO - "repository": "", 13:21:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 13:21:39 INFO - "buildid": "20160810103821", 13:21:39 INFO - "pgo_build": "True", 13:21:39 INFO - "basedir": "/builds/slave/test", 13:21:39 INFO - "buildnumber": 451, 13:21:39 INFO - "slavename": "talos-linux64-ix-063", 13:21:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:21:39 INFO - "platform": "ubuntu64_hw", 13:21:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:21:39 INFO - "branch": "mozilla-aurora", 13:21:39 INFO - "repo_path": "releases/mozilla-aurora", 13:21:39 INFO - "revision": "f5a9d33557dd860e74994a3a650e743569883cbb", 13:21:39 INFO - "stage_platform": "linux64-pgo", 13:21:39 INFO - "builduid": "08a2541c282a49d7a818d473b26f8ad8", 13:21:39 INFO - "slavebuilddir": "test" 13:21:39 INFO - } 13:21:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 13:21:39 INFO - Running post-action listener: _resource_record_post_action 13:21:39 INFO - [mozharness: 2016-08-10 20:21:39.611122Z] Finished read-buildbot-config step (success) 13:21:39 INFO - [mozharness: 2016-08-10 20:21:39.611211Z] Running download-and-extract step. 13:21:39 INFO - Running pre-action listener: _resource_record_pre_action 13:21:39 INFO - Running main action method: download_and_extract 13:21:39 INFO - mkdir: /builds/slave/test/build/tests 13:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:39 INFO - https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:21:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:21:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:21:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:21:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:21:39 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:21:39 INFO - retry: Failed, sleeping 30 seconds before retrying 13:22:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:22:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:22:09 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:22:09 INFO - retry: Failed, sleeping 60 seconds before retrying 13:23:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:23:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:23:09 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:23:09 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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! 13:23:09 INFO - Caught exception: HTTP Error 404: Not Found 13:23:09 INFO - Caught exception: HTTP Error 404: Not Found 13:23:09 INFO - Caught exception: HTTP Error 404: Not Found 13:23:09 INFO - trying https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:23:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/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 13:23:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/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 13:23:10 INFO - Downloaded 1361 bytes. 13:23:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 13:23:10 INFO - Using the following test package requirements: 13:23:10 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 13:23:10 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:23:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:23:10 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:23:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:23:10 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:23:10 INFO - u'jsshell-linux-x86_64.zip'], 13:23:10 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:23:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:23:10 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 13:23:10 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:23:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:23:10 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:23:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:23:10 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:23:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:23:10 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 13:23:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:23:10 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:23:10 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')]} 13:23:10 INFO - https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:23:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:23:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:23:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:23:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:23:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:23:10 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:23:10 INFO - retry: Failed, sleeping 30 seconds before retrying 13:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:23:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:23:40 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:23:40 INFO - retry: Failed, sleeping 60 seconds before retrying 13:24:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:24:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:24:40 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:24:40 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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! 13:24:40 INFO - Caught exception: HTTP Error 404: Not Found 13:24:40 INFO - Caught exception: HTTP Error 404: Not Found 13:24:40 INFO - Caught exception: HTTP Error 404: Not Found 13:24:40 INFO - trying https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:24:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/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 13:24:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/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 13:24:42 INFO - Downloaded 21766251 bytes. 13:24:42 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'] 13:24:42 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 13:24:43 INFO - Return code: 0 13:24:43 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 13:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:24:43 INFO - https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:24:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:24:43 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:24:43 INFO - retry: Failed, sleeping 30 seconds before retrying 13:25:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:25:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:25:13 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:25:13 INFO - retry: Failed, sleeping 60 seconds before retrying 13:26:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:26:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:26:13 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:26:13 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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! 13:26:13 INFO - Caught exception: HTTP Error 404: Not Found 13:26:13 INFO - Caught exception: HTTP Error 404: Not Found 13:26:13 INFO - Caught exception: HTTP Error 404: Not Found 13:26:13 INFO - trying https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 13:26:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/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 13:26:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/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 13:26:14 INFO - Downloaded 21766251 bytes. 13:26:14 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'] 13:26:14 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 13:26:16 INFO - Return code: 0 13:26: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')]} 13:26:16 INFO - https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:26:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:26:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:26:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:26:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:26:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:26:16 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:26:16 INFO - retry: Failed, sleeping 30 seconds before retrying 13:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:26:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:26:46 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:26:46 INFO - retry: Failed, sleeping 60 seconds before retrying 13:27:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:27:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:27:46 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:27:46 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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! 13:27:46 INFO - Caught exception: HTTP Error 404: Not Found 13:27:46 INFO - Caught exception: HTTP Error 404: Not Found 13:27:46 INFO - Caught exception: HTTP Error 404: Not Found 13:27:46 INFO - trying https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 13:27:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/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 13:27:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/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 13:27:47 INFO - Downloaded 14413723 bytes. 13:27:47 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'] 13:27:47 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 13:27:48 INFO - Return code: 0 13:27:48 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')]} 13:27:48 INFO - https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:27:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:27:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:27:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:27:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:27:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:27:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:27:48 INFO - retry: Failed, sleeping 30 seconds before retrying 13:28:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:28:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:28:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:28:18 INFO - retry: Failed, sleeping 60 seconds before retrying 13:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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 13:29:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:29:18 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:29:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Py85bT1pTG6mykdB315W-g/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! 13:29:18 INFO - Caught exception: HTTP Error 404: Not Found 13:29:18 INFO - Caught exception: HTTP Error 404: Not Found 13:29:18 INFO - Caught exception: HTTP Error 404: Not Found 13:29:18 INFO - trying https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:29:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/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 13:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/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 13:29:20 INFO - Downloaded 63762404 bytes. 13:29:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:29:20 INFO - mkdir: /builds/slave/test/properties 13:29:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:29:20 INFO - Writing to file /builds/slave/test/properties/build_url 13:29:20 INFO - Contents: 13:29:20 INFO - build_url:https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 13:29:20 INFO - Running post-action listener: _resource_record_post_action 13:29:20 INFO - Running post-action listener: set_extra_try_arguments 13:29:20 INFO - [mozharness: 2016-08-10 20:29:20.798491Z] Finished download-and-extract step (success) 13:29:20 INFO - [mozharness: 2016-08-10 20:29:20.798722Z] Running populate-webroot step. 13:29:20 INFO - Running pre-action listener: _resource_record_pre_action 13:29:20 INFO - Running main action method: populate_webroot 13:29:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:29:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:29:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:29:20 INFO - '--tppagecycles', 13:29:20 INFO - '7'], 13:29:20 INFO - 'tests': ['tsvgm']}}, 13:29:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:29:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:29:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:29:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:29:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:29:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:29:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:20 INFO - 'talos_options': ['--disable-e10s'], 13:29:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:29:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:29:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:20 INFO - 'talos_options': ['--disable-e10s'], 13:29:20 INFO - 'tests': ['damp', 'tps']}, 13:29:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:20 INFO - 'tests': ['damp', 'tps']}, 13:29:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:29:20 INFO - 'tests': ['dromaeo_dom']}, 13:29:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:29:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:29:20 INFO - 'tests': ['basic_compositor_video']}, 13:29:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:29:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:29:20 INFO - 'tests': ['a11yr', 13:29:20 INFO - 'ts_paint', 13:29:20 INFO - 'tpaint', 13:29:20 INFO - 'sessionrestore', 13:29:20 INFO - 'sessionrestore_no_auto_restore', 13:29:20 INFO - 'tabpaint']}, 13:29:20 INFO - 'other-e10s': {'tests': ['a11yr', 13:29:20 INFO - 'ts_paint', 13:29:20 INFO - 'tpaint', 13:29:20 INFO - 'sessionrestore', 13:29:20 INFO - 'sessionrestore_no_auto_restore', 13:29:20 INFO - 'tabpaint']}, 13:29:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:29:20 INFO - 'ts_paint', 13:29:20 INFO - 'tpaint', 13:29:20 INFO - 'sessionrestore', 13:29:20 INFO - 'sessionrestore_no_auto_restore', 13:29:20 INFO - 'tabpaint']}, 13:29:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:29:20 INFO - 'ts_paint', 13:29:20 INFO - 'tpaint', 13:29:20 INFO - 'sessionrestore', 13:29:20 INFO - 'sessionrestore_no_auto_restore', 13:29:20 INFO - 'tabpaint']}, 13:29:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:29:20 INFO - 'tests': ['a11yr', 13:29:20 INFO - 'ts_paint', 13:29:20 INFO - 'tpaint', 13:29:20 INFO - 'sessionrestore', 13:29:20 INFO - 'sessionrestore_no_auto_restore', 13:29:20 INFO - 'tabpaint']}, 13:29:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:29:20 INFO - 'tests': ['a11yr', 13:29:20 INFO - 'ts_paint', 13:29:20 INFO - 'tpaint', 13:29:20 INFO - 'sessionrestore', 13:29:20 INFO - 'sessionrestore_no_auto_restore', 13:29:20 INFO - 'tabpaint']}, 13:29:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:29:20 INFO - 'tests': ['tsvgx', 13:29:20 INFO - 'tsvgr_opacity', 13:29:20 INFO - 'tart', 13:29:20 INFO - 'tscrollx', 13:29:20 INFO - 'cart']}, 13:29:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:29:20 INFO - 'tsvgr_opacity', 13:29:20 INFO - 'tart', 13:29:20 INFO - 'tscrollx', 13:29:20 INFO - 'cart']}, 13:29:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:20 INFO - 'talos_options': ['--disable-e10s'], 13:29:20 INFO - 'tests': ['tp5o']}, 13:29:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:20 INFO - 'tests': ['tp5o']}, 13:29:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:20 INFO - 'talos_options': ['--disable-e10s', 13:29:20 INFO - '--xperf_path', 13:29:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:29:20 INFO - 'tests': ['tp5n']}, 13:29:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:20 INFO - 'talos_options': ['--xperf_path', 13:29:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:29:20 INFO - 'tests': ['tp5n']}}, 13:29:20 INFO - 'talos.zip': {'path': '', 13:29:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:29:20 INFO - Running post-action listener: _resource_record_post_action 13:29:20 INFO - [mozharness: 2016-08-10 20:29:20.820251Z] Finished populate-webroot step (success) 13:29:20 INFO - [mozharness: 2016-08-10 20:29:20.820339Z] Running create-virtualenv step. 13:29:20 INFO - Running pre-action listener: _resource_record_pre_action 13:29:20 INFO - Running main action method: create_virtualenv 13:29:20 INFO - Creating virtualenv /builds/slave/test/build/venv 13:29:20 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 13:29:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:29:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:29:20 INFO - Using real prefix '/usr' 13:29:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:29:21 INFO - Installing distribute.............................................................................................................................................................................................done. 13:29:23 INFO - Installing pip.................done. 13:29:23 INFO - Return code: 0 13:29:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:29:23 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')]} 13:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:23 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')]} 13:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:23 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 0x17ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c570>, '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 0x1a8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d900>, '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': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', '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 13:29:23 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 13:29:23 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 13:29:23 INFO - Using env: {'DISPLAY': ':0', 13:29:23 INFO - 'HOME': '/home/cltbld', 13:29:23 INFO - 'LANG': 'en_US.UTF-8', 13:29:23 INFO - 'LANGUAGE': 'en_US:en', 13:29:23 INFO - 'LOGNAME': 'cltbld', 13:29:23 INFO - 'MAIL': '/var/mail/cltbld', 13:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:23 INFO - 'MOZ_NO_REMOTE': '1', 13:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:23 INFO - 'NO_EM_RESTART': '1', 13:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:23 INFO - 'PWD': '/builds/slave/test', 13:29:23 INFO - 'SHELL': '/bin/bash', 13:29:23 INFO - 'SHLVL': '1', 13:29:23 INFO - 'TERM': 'linux', 13:29:23 INFO - 'TMOUT': '86400', 13:29:23 INFO - 'USER': 'cltbld', 13:29:23 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', 13:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:23 INFO - '_': '/tools/buildbot/bin/python'} 13:29:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:23 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 13:29:23 INFO - Cleaning up... 13:29:23 INFO - Return code: 0 13:29:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:29:23 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')]} 13:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:23 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')]} 13:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:23 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 0x17ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c570>, '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 0x1a8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d900>, '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': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', '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 13:29:23 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 13:29:23 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 13:29:23 INFO - Using env: {'DISPLAY': ':0', 13:29:23 INFO - 'HOME': '/home/cltbld', 13:29:23 INFO - 'LANG': 'en_US.UTF-8', 13:29:23 INFO - 'LANGUAGE': 'en_US:en', 13:29:23 INFO - 'LOGNAME': 'cltbld', 13:29:23 INFO - 'MAIL': '/var/mail/cltbld', 13:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:23 INFO - 'MOZ_NO_REMOTE': '1', 13:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:23 INFO - 'NO_EM_RESTART': '1', 13:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:23 INFO - 'PWD': '/builds/slave/test', 13:29:23 INFO - 'SHELL': '/bin/bash', 13:29:23 INFO - 'SHLVL': '1', 13:29:23 INFO - 'TERM': 'linux', 13:29:23 INFO - 'TMOUT': '86400', 13:29:23 INFO - 'USER': 'cltbld', 13:29:23 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', 13:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:23 INFO - '_': '/tools/buildbot/bin/python'} 13:29:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:23 INFO - Downloading/unpacking psutil>=3.1.1 13:29:23 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 13:29:23 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 13:29:23 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 13:29:23 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 13:29:23 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 13:29:23 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 13:29:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:29:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:29:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:29:25 INFO - Installing collected packages: psutil 13:29:25 INFO - Running setup.py install for psutil 13:29:25 INFO - building 'psutil._psutil_linux' extension 13:29:25 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 13:29:26 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 13:29:26 INFO - building 'psutil._psutil_posix' extension 13:29:26 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 13:29:26 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 13:29:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:29:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:29:26 INFO - Successfully installed psutil 13:29:26 INFO - Cleaning up... 13:29:26 INFO - Return code: 0 13:29:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:29:26 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')]} 13:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:26 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')]} 13:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:26 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 0x17ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c570>, '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 0x1a8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d900>, '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': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', '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 13:29:26 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 13:29:26 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 13:29:26 INFO - Using env: {'DISPLAY': ':0', 13:29:26 INFO - 'HOME': '/home/cltbld', 13:29:26 INFO - 'LANG': 'en_US.UTF-8', 13:29:26 INFO - 'LANGUAGE': 'en_US:en', 13:29:26 INFO - 'LOGNAME': 'cltbld', 13:29:26 INFO - 'MAIL': '/var/mail/cltbld', 13:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:26 INFO - 'MOZ_NO_REMOTE': '1', 13:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:26 INFO - 'NO_EM_RESTART': '1', 13:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:26 INFO - 'PWD': '/builds/slave/test', 13:29:26 INFO - 'SHELL': '/bin/bash', 13:29:26 INFO - 'SHLVL': '1', 13:29:26 INFO - 'TERM': 'linux', 13:29:26 INFO - 'TMOUT': '86400', 13:29:26 INFO - 'USER': 'cltbld', 13:29:26 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', 13:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:26 INFO - '_': '/tools/buildbot/bin/python'} 13:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:29:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:29:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:29:28 INFO - Installing collected packages: mozsystemmonitor 13:29:28 INFO - Running setup.py install for mozsystemmonitor 13:29:28 INFO - Successfully installed mozsystemmonitor 13:29:28 INFO - Cleaning up... 13:29:28 INFO - Return code: 0 13:29:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:29:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:28 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 0x17ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c570>, '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 0x1a8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d900>, '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': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', '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 13:29:28 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 13:29:28 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 13:29:28 INFO - Using env: {'DISPLAY': ':0', 13:29:28 INFO - 'HOME': '/home/cltbld', 13:29:28 INFO - 'LANG': 'en_US.UTF-8', 13:29:28 INFO - 'LANGUAGE': 'en_US:en', 13:29:28 INFO - 'LOGNAME': 'cltbld', 13:29:28 INFO - 'MAIL': '/var/mail/cltbld', 13:29:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:28 INFO - 'MOZ_NO_REMOTE': '1', 13:29:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:28 INFO - 'NO_EM_RESTART': '1', 13:29:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:28 INFO - 'PWD': '/builds/slave/test', 13:29:28 INFO - 'SHELL': '/bin/bash', 13:29:28 INFO - 'SHLVL': '1', 13:29:28 INFO - 'TERM': 'linux', 13:29:28 INFO - 'TMOUT': '86400', 13:29:28 INFO - 'USER': 'cltbld', 13:29:28 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', 13:29:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:28 INFO - '_': '/tools/buildbot/bin/python'} 13:29:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:28 INFO - Downloading/unpacking jsonschema==2.5.1 13:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:29:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:29:30 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 13:29:30 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 13:29:30 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 13:29:30 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 13:29:30 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 13:29:30 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 13:29:30 INFO - Downloading functools32-3.2.3-2.tar.gz 13:29:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:29:31 INFO - warning: no files found matching '*.txt' 13:29:31 INFO - no previously-included directories found matching 'build' 13:29:31 INFO - no previously-included directories found matching 'dist' 13:29:31 INFO - no previously-included directories found matching '.git*' 13:29:31 INFO - Installing collected packages: jsonschema, functools32 13:29:31 INFO - Running setup.py install for functools32 13:29:31 INFO - warning: no files found matching '*.txt' 13:29:31 INFO - no previously-included directories found matching 'build' 13:29:31 INFO - no previously-included directories found matching 'dist' 13:29:31 INFO - no previously-included directories found matching '.git*' 13:29:31 INFO - Successfully installed jsonschema functools32 13:29:31 INFO - Cleaning up... 13:29:31 INFO - Return code: 0 13:29:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:29:31 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')]} 13:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:31 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')]} 13:29:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:31 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 0x17ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c570>, '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 0x1a8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d900>, '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': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', '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 13:29:31 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 13:29:31 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 13:29:31 INFO - Using env: {'DISPLAY': ':0', 13:29:31 INFO - 'HOME': '/home/cltbld', 13:29:31 INFO - 'LANG': 'en_US.UTF-8', 13:29:31 INFO - 'LANGUAGE': 'en_US:en', 13:29:31 INFO - 'LOGNAME': 'cltbld', 13:29:31 INFO - 'MAIL': '/var/mail/cltbld', 13:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:31 INFO - 'MOZ_NO_REMOTE': '1', 13:29:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:31 INFO - 'NO_EM_RESTART': '1', 13:29:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:31 INFO - 'PWD': '/builds/slave/test', 13:29:31 INFO - 'SHELL': '/bin/bash', 13:29:31 INFO - 'SHLVL': '1', 13:29:31 INFO - 'TERM': 'linux', 13:29:31 INFO - 'TMOUT': '86400', 13:29:31 INFO - 'USER': 'cltbld', 13:29:31 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', 13:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:31 INFO - '_': '/tools/buildbot/bin/python'} 13:29:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:29:31 INFO - Cleaning up... 13:29:31 INFO - Return code: 0 13:29:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:29:31 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')]} 13:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:31 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')]} 13:29:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:31 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 0x17ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c570>, '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 0x1a8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d900>, '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': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', '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 13:29:31 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 13:29:31 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 13:29:31 INFO - Using env: {'DISPLAY': ':0', 13:29:31 INFO - 'HOME': '/home/cltbld', 13:29:31 INFO - 'LANG': 'en_US.UTF-8', 13:29:31 INFO - 'LANGUAGE': 'en_US:en', 13:29:31 INFO - 'LOGNAME': 'cltbld', 13:29:31 INFO - 'MAIL': '/var/mail/cltbld', 13:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:31 INFO - 'MOZ_NO_REMOTE': '1', 13:29:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:31 INFO - 'NO_EM_RESTART': '1', 13:29:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:31 INFO - 'PWD': '/builds/slave/test', 13:29:31 INFO - 'SHELL': '/bin/bash', 13:29:31 INFO - 'SHLVL': '1', 13:29:31 INFO - 'TERM': 'linux', 13:29:31 INFO - 'TMOUT': '86400', 13:29:31 INFO - 'USER': 'cltbld', 13:29:31 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', 13:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:31 INFO - '_': '/tools/buildbot/bin/python'} 13:29:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:31 INFO - Downloading/unpacking blobuploader==1.2.4 13:29:31 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 13:29:31 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 13:29:31 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 13:29:31 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 13:29:31 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 13:29:31 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 13:29:33 INFO - Downloading blobuploader-1.2.4.tar.gz 13:29:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:29:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:29:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:34 INFO - Downloading docopt-0.6.1.tar.gz 13:29:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:29:34 INFO - Installing collected packages: blobuploader, requests, docopt 13:29:34 INFO - Running setup.py install for blobuploader 13:29:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:29:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:29:34 INFO - Running setup.py install for requests 13:29:34 INFO - Running setup.py install for docopt 13:29:34 INFO - Successfully installed blobuploader requests docopt 13:29:34 INFO - Cleaning up... 13:29:34 INFO - Return code: 0 13:29:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:34 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 0x17ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c570>, '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 0x1a8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d900>, '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': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', '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 13:29:34 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 13:29:34 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 13:29:34 INFO - Using env: {'DISPLAY': ':0', 13:29:34 INFO - 'HOME': '/home/cltbld', 13:29:34 INFO - 'LANG': 'en_US.UTF-8', 13:29:34 INFO - 'LANGUAGE': 'en_US:en', 13:29:34 INFO - 'LOGNAME': 'cltbld', 13:29:34 INFO - 'MAIL': '/var/mail/cltbld', 13:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:34 INFO - 'MOZ_NO_REMOTE': '1', 13:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:34 INFO - 'NO_EM_RESTART': '1', 13:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:34 INFO - 'PWD': '/builds/slave/test', 13:29:34 INFO - 'SHELL': '/bin/bash', 13:29:34 INFO - 'SHLVL': '1', 13:29:34 INFO - 'TERM': 'linux', 13:29:34 INFO - 'TMOUT': '86400', 13:29:34 INFO - 'USER': 'cltbld', 13:29:34 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', 13:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:34 INFO - '_': '/tools/buildbot/bin/python'} 13:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:29:35 INFO - Running setup.py (path:/tmp/pip-aSC_Xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:29:35 INFO - Running setup.py (path:/tmp/pip-2_R6Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:29:35 INFO - Running setup.py (path:/tmp/pip-DSjX43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:29:35 INFO - Running setup.py (path:/tmp/pip-EBtwAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:29:35 INFO - Running setup.py (path:/tmp/pip-HStA4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:29:35 INFO - Running setup.py (path:/tmp/pip-6R0fTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:29:35 INFO - Running setup.py (path:/tmp/pip-7aSJr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:29:35 INFO - Running setup.py (path:/tmp/pip-4ptf7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:29:35 INFO - Running setup.py (path:/tmp/pip-oX4ZzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:29:35 INFO - Running setup.py (path:/tmp/pip-OEJgI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:29:35 INFO - Running setup.py (path:/tmp/pip-69quFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:29:35 INFO - Running setup.py (path:/tmp/pip-6M3Dda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:29:35 INFO - Running setup.py (path:/tmp/pip-fxlkMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:29:36 INFO - Running setup.py (path:/tmp/pip-tIEuug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:29:36 INFO - Running setup.py (path:/tmp/pip-8VRoOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:29:36 INFO - Running setup.py (path:/tmp/pip-jX6VR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:29:36 INFO - Running setup.py (path:/tmp/pip-HLjqUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:29:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:29:36 INFO - Running setup.py install for manifestparser 13:29:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:29:36 INFO - Running setup.py install for mozcrash 13:29:36 INFO - Running setup.py install for mozdebug 13:29:36 INFO - Running setup.py install for mozdevice 13:29:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:29:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:29:36 INFO - Running setup.py install for mozfile 13:29:36 INFO - Running setup.py install for mozhttpd 13:29:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:29:36 INFO - Running setup.py install for mozinfo 13:29:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:29:37 INFO - Running setup.py install for mozInstall 13:29:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:29:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:29:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:29:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:29:37 INFO - Running setup.py install for mozleak 13:29:37 INFO - Running setup.py install for mozlog 13:29:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:29:37 INFO - Running setup.py install for moznetwork 13:29:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:29:37 INFO - Running setup.py install for mozprocess 13:29:37 INFO - Running setup.py install for mozprofile 13:29:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:29:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:29:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:29:37 INFO - Running setup.py install for mozrunner 13:29:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:29:37 INFO - Running setup.py install for mozscreenshot 13:29:37 INFO - Running setup.py install for moztest 13:29:38 INFO - Running setup.py install for mozversion 13:29:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:29:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:29:38 INFO - Cleaning up... 13:29:38 INFO - Return code: 0 13:29:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:29:38 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')]} 13:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:38 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')]} 13:29:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:38 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 0x17ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c570>, '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 0x1a8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d900>, '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': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', '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 13:29:38 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 13:29:38 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 13:29:38 INFO - Using env: {'DISPLAY': ':0', 13:29:38 INFO - 'HOME': '/home/cltbld', 13:29:38 INFO - 'LANG': 'en_US.UTF-8', 13:29:38 INFO - 'LANGUAGE': 'en_US:en', 13:29:38 INFO - 'LOGNAME': 'cltbld', 13:29:38 INFO - 'MAIL': '/var/mail/cltbld', 13:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:38 INFO - 'MOZ_NO_REMOTE': '1', 13:29:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:38 INFO - 'NO_EM_RESTART': '1', 13:29:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:38 INFO - 'PWD': '/builds/slave/test', 13:29:38 INFO - 'SHELL': '/bin/bash', 13:29:38 INFO - 'SHLVL': '1', 13:29:38 INFO - 'TERM': 'linux', 13:29:38 INFO - 'TMOUT': '86400', 13:29:38 INFO - 'USER': 'cltbld', 13:29:38 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', 13:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:38 INFO - '_': '/tools/buildbot/bin/python'} 13:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:29:38 INFO - Running setup.py (path:/tmp/pip-IaRC4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:29:38 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)) 13:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:29:38 INFO - Running setup.py (path:/tmp/pip-nP8Rsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:29:38 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)) 13:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:29:38 INFO - Running setup.py (path:/tmp/pip-Vtou5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:29:38 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)) 13:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:29:38 INFO - Running setup.py (path:/tmp/pip-bx9wgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:29:38 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)) 13:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:29:38 INFO - Running setup.py (path:/tmp/pip-vQpOWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:29:38 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)) 13:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:29:38 INFO - Running setup.py (path:/tmp/pip-kdGwBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:29:38 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)) 13:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:29:38 INFO - Running setup.py (path:/tmp/pip-oRxuQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:29:38 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)) 13:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:29:38 INFO - Running setup.py (path:/tmp/pip-frjhMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:29:38 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)) 13:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:29:38 INFO - Running setup.py (path:/tmp/pip-eiXUrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:29:39 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)) 13:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:29:39 INFO - Running setup.py (path:/tmp/pip-amnp2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:29:39 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)) 13:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:29:39 INFO - Running setup.py (path:/tmp/pip-hRRJI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:29:39 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)) 13:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:29:39 INFO - Running setup.py (path:/tmp/pip-vzKiXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:29:39 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)) 13:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:29:39 INFO - Running setup.py (path:/tmp/pip-DSDPef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:29:39 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)) 13:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:29:39 INFO - Running setup.py (path:/tmp/pip-pbtoXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:29:39 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)) 13:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:29:39 INFO - Running setup.py (path:/tmp/pip-fTTUJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:29:39 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)) 13:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:29:39 INFO - Running setup.py (path:/tmp/pip-NsO5fY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:29:39 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)) 13:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:29:39 INFO - Running setup.py (path:/tmp/pip-e36EyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:29:39 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)) 13:29:39 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)) 13:29:39 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)) 13:29:39 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)) 13:29:39 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)) 13:29:39 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)) 13:29:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:29:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:29:41 INFO - Downloading blessings-1.6.tar.gz 13:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:29:41 INFO - Installing collected packages: blessings 13:29:41 INFO - Running setup.py install for blessings 13:29:41 INFO - Successfully installed blessings 13:29:41 INFO - Cleaning up... 13:29:41 INFO - Return code: 0 13:29:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:29:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:29:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:29:41 INFO - Reading from file tmpfile_stdout 13:29:41 INFO - Current package versions: 13:29:41 INFO - argparse == 1.2.1 13:29:41 INFO - blessings == 1.6 13:29:41 INFO - blobuploader == 1.2.4 13:29:41 INFO - docopt == 0.6.1 13:29:41 INFO - functools32 == 3.2.3-2 13:29:41 INFO - jsonschema == 2.5.1 13:29:41 INFO - manifestparser == 1.1 13:29:41 INFO - mozInstall == 1.12 13:29:41 INFO - mozcrash == 0.17 13:29:41 INFO - mozdebug == 0.1 13:29:41 INFO - mozdevice == 0.48 13:29:41 INFO - mozfile == 1.2 13:29:41 INFO - mozhttpd == 0.7 13:29:41 INFO - mozinfo == 0.9 13:29:41 INFO - mozleak == 0.1 13:29:41 INFO - mozlog == 3.3 13:29:41 INFO - moznetwork == 0.27 13:29:41 INFO - mozprocess == 0.23 13:29:41 INFO - mozprofile == 0.28 13:29:41 INFO - mozrunner == 6.12 13:29:41 INFO - mozscreenshot == 0.1 13:29:41 INFO - mozsystemmonitor == 0.3 13:29:41 INFO - moztest == 0.7 13:29:41 INFO - mozversion == 1.4 13:29:41 INFO - psutil == 3.1.1 13:29:41 INFO - requests == 1.2.3 13:29:41 INFO - wsgiref == 0.1.2 13:29:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:29:41 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')]} 13:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:41 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')]} 13:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:41 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 0x17ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c570>, '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 0x1a8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d900>, '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': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', '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 13:29:41 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 13:29:41 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 13:29:41 INFO - Using env: {'DISPLAY': ':0', 13:29:41 INFO - 'HOME': '/home/cltbld', 13:29:41 INFO - 'LANG': 'en_US.UTF-8', 13:29:41 INFO - 'LANGUAGE': 'en_US:en', 13:29:41 INFO - 'LOGNAME': 'cltbld', 13:29:41 INFO - 'MAIL': '/var/mail/cltbld', 13:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:41 INFO - 'MOZ_NO_REMOTE': '1', 13:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:41 INFO - 'NO_EM_RESTART': '1', 13:29:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:41 INFO - 'PWD': '/builds/slave/test', 13:29:41 INFO - 'SHELL': '/bin/bash', 13:29:41 INFO - 'SHLVL': '1', 13:29:41 INFO - 'TERM': 'linux', 13:29:41 INFO - 'TMOUT': '86400', 13:29:41 INFO - 'USER': 'cltbld', 13:29:41 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', 13:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:41 INFO - '_': '/tools/buildbot/bin/python'} 13:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:42 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)) 13:29:42 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)) 13:29:42 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)) 13:29:42 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)) 13:29:42 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)) 13:29:42 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)) 13:29:42 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)) 13:29:42 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)) 13:29:42 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)) 13:29:42 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)) 13:29:42 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)) 13:29:42 INFO - Cleaning up... 13:29:42 INFO - Return code: 0 13:29:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:29:42 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')]} 13:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:42 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')]} 13:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x17ce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c570>, '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 0x1a8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d900>, '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': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', '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 13:29:42 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 13:29:42 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 13:29:42 INFO - Using env: {'DISPLAY': ':0', 13:29:42 INFO - 'HOME': '/home/cltbld', 13:29:42 INFO - 'LANG': 'en_US.UTF-8', 13:29:42 INFO - 'LANGUAGE': 'en_US:en', 13:29:42 INFO - 'LOGNAME': 'cltbld', 13:29:42 INFO - 'MAIL': '/var/mail/cltbld', 13:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:42 INFO - 'MOZ_NO_REMOTE': '1', 13:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:42 INFO - 'NO_EM_RESTART': '1', 13:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:42 INFO - 'PWD': '/builds/slave/test', 13:29:42 INFO - 'SHELL': '/bin/bash', 13:29:42 INFO - 'SHLVL': '1', 13:29:42 INFO - 'TERM': 'linux', 13:29:42 INFO - 'TMOUT': '86400', 13:29:42 INFO - 'USER': 'cltbld', 13:29:42 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', 13:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:42 INFO - '_': '/tools/buildbot/bin/python'} 13:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:29:42 INFO - Cleaning up... 13:29:42 INFO - Return code: 0 13:29:42 INFO - Running post-action listener: _resource_record_post_action 13:29:42 INFO - Running post-action listener: _start_resource_monitoring 13:29:42 INFO - Starting resource monitoring. 13:29:42 INFO - [mozharness: 2016-08-10 20:29:42.401426Z] Finished create-virtualenv step (success) 13:29:42 INFO - [mozharness: 2016-08-10 20:29:42.401892Z] Running install step. 13:29:42 INFO - Running pre-action listener: _resource_record_pre_action 13:29:42 INFO - Running main action method: install 13:29:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:29:42 INFO - Reading from file tmpfile_stdout 13:29:42 INFO - Detecting whether we're running mozinstall >=1.0... 13:29:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:29:42 INFO - Reading from file tmpfile_stdout 13:29:42 INFO - Output received: 13:29:42 INFO - Usage: mozinstall [options] installer 13:29:42 INFO - Options: 13:29:42 INFO - -h, --help show this help message and exit 13:29:42 INFO - -d DEST, --destination=DEST 13:29:42 INFO - Directory to install application into. [default: 13:29:42 INFO - "/builds/slave/test"] 13:29:42 INFO - --app=APP Application being installed. [default: firefox] 13:29:42 INFO - mkdir: /builds/slave/test/build/application 13:29:42 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'] 13:29:42 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 13:30:03 INFO - Reading from file tmpfile_stdout 13:30:03 INFO - Output received: 13:30:03 INFO - /builds/slave/test/build/application/firefox/firefox 13:30:03 INFO - Running post-action listener: _resource_record_post_action 13:30:03 INFO - [mozharness: 2016-08-10 20:30:03.778077Z] Finished install step (success) 13:30:03 INFO - [mozharness: 2016-08-10 20:30:03.778350Z] Running run-tests step. 13:30:03 INFO - Running pre-action listener: _resource_record_pre_action 13:30:03 INFO - Running main action method: run_tests 13:30:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:30:03 INFO - Python 2.7.3 13:30:03 INFO - Return code: 0 13:30:03 INFO - grabbing minidump binary from tooltool 13:30:03 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')]} 13:30:03 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 0x1a8c570>, '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 0x1a8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8d900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:30:03 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 13:30:03 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 13:30:03 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 13:30:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:30:03 INFO - Return code: 0 13:30:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:30:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:30:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:30:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:30:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:30:03 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/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 13:30:03 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/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 13:30:03 INFO - Using env: {'DISPLAY': ':0', 13:30:03 INFO - 'HOME': '/home/cltbld', 13:30:03 INFO - 'LANG': 'en_US.UTF-8', 13:30:03 INFO - 'LANGUAGE': 'en_US:en', 13:30:03 INFO - 'LOGNAME': 'cltbld', 13:30:03 INFO - 'MAIL': '/var/mail/cltbld', 13:30:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:30:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:03 INFO - 'MOZ_NO_REMOTE': '1', 13:30:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:03 INFO - 'NO_EM_RESTART': '1', 13:30:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:03 INFO - 'PWD': '/builds/slave/test', 13:30:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:30:03 INFO - 'SHELL': '/bin/bash', 13:30:03 INFO - 'SHLVL': '1', 13:30:03 INFO - 'TERM': 'linux', 13:30:03 INFO - 'TMOUT': '86400', 13:30:03 INFO - 'USER': 'cltbld', 13:30:03 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169', 13:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:03 INFO - '_': '/tools/buildbot/bin/python'} 13:30:03 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/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 13:30:04 INFO - mozversion application_buildid: 20160810103821 13:30:04 INFO - mozversion application_changeset: f5a9d33557dd860e74994a3a650e743569883cbb 13:30:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:30:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:30:04 INFO - mozversion application_name: Firefox 13:30:04 INFO - mozversion application_remotingname: firefox-dev 13:30:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:30:04 INFO - mozversion application_vendor: Mozilla 13:30:04 INFO - mozversion application_version: 50.0a2 13:30:04 INFO - mozversion platform_buildid: 20160810103821 13:30:04 INFO - mozversion platform_changeset: f5a9d33557dd860e74994a3a650e743569883cbb 13:30:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:30:04 INFO - mozversion platform_version: 50.0a2 13:30:04 INFO - using testdate: 1470861004 13:30:04 INFO - actual date: 1470861004 13:30:04 INFO - starting webserver on 'localhost:39264' 13:30:04 INFO - SUITE-START | Running 2 tests 13:30:04 INFO - TEST-START | dromaeo_css 13:30:04 INFO - operating with platform_type : linux_ 13:30:04 INFO - Initialising browser for dromaeo_css test... 13:30:04 INFO - TEST-INFO | started process 24972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsvdzEB/profile http://localhost:39264/getInfo.html) 13:30:11 INFO - PROCESS | 24972 | __metrics Screen width/height:1600/1200 13:30:11 INFO - PROCESS | 24972 | colorDepth:24 13:30:11 INFO - PROCESS | 24972 | Browser inner width/height: 1024/697 13:30:11 INFO - PROCESS | 24972 | __metrics 13:30:13 ERROR - PROCESS | 24972 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 13:30:14 INFO - TEST-INFO | 24972: exit 0 13:30:14 INFO - Browser initialized. 13:30:14 INFO - Running cycle 1/1 for dromaeo_css test... 13:30:14 INFO - TEST-INFO | started process 25105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsvdzEB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:30:25 INFO - PROCESS | 25105 | RSS: Main: 152612864 13:30:25 INFO - PROCESS | 25105 | 13:31:15 INFO - PROCESS | 25105 | 1470861075504 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] 13:33:23 INFO - PROCESS | 25105 | Cycle 1(1): loaded http://localhost:39264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39264/tests/dromaeo/cssquery-ext.html) 13:33:24 INFO - PROCESS | 25105 | RSS: Main: 158121984 13:33:24 INFO - PROCESS | 25105 | 13:36:26 INFO - PROCESS | 25105 | Cycle 1(1): loaded http://localhost:39264/tests/dromaeo/cssquery-ext.html (next: http://localhost:39264/tests/dromaeo/cssquery-jquery.html) 13:36:27 INFO - PROCESS | 25105 | RSS: Main: 153198592 13:36:27 INFO - PROCESS | 25105 | 13:39:29 INFO - PROCESS | 25105 | Cycle 1(1): loaded http://localhost:39264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39264/tests/dromaeo/cssquery-mootools.html) 13:39:29 INFO - PROCESS | 25105 | RSS: Main: 153456640 13:39:29 INFO - PROCESS | 25105 | 13:42:31 INFO - PROCESS | 25105 | Cycle 1(1): loaded http://localhost:39264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39264/tests/dromaeo/cssquery-prototype.html) 13:42:32 INFO - PROCESS | 25105 | RSS: Main: 153247744 13:42:32 INFO - PROCESS | 25105 | 13:45:34 INFO - PROCESS | 25105 | Cycle 1(1): loaded http://localhost:39264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39264/tests/dromaeo/cssquery-yui.html) 13:45:35 INFO - PROCESS | 25105 | RSS: Main: 154505216 13:45:35 INFO - PROCESS | 25105 | 13:48:37 INFO - PROCESS | 25105 | Cycle 1(1): loaded http://localhost:39264/tests/dromaeo/cssquery-yui.html (next: http://localhost:39264/tests/dromaeo/cssquery-dojo.html) 13:48:37 INFO - PROCESS | 25105 | RSS: Main: 156033024 13:48:37 INFO - PROCESS | 25105 | 13:48:37 INFO - PROCESS | 25105 | __start_tp_report 13:48:37 INFO - PROCESS | 25105 | _x_x_mozilla_page_load 13:48:37 INFO - PROCESS | 25105 | _x_x_mozilla_page_load_details 13:48:37 INFO - PROCESS | 25105 | |i|pagename|runs| 13:48:37 INFO - PROCESS | 25105 | |0;dojo.html;3269.231730543322;3319.0706602151404;3321.9169520761993;3330.7501937354705;3340.482225255085;5757.395473475282;5773.711314434272;5834.708264586775;5838.591298609093;5843.853903652411;5766.625169363989;5805.535557155428;5817.447342502455;5821.27234095738;5837.620554663944;5257.973710131444;5290.656107353029;5312.60155488338;5332.253484512172;5343.251944727741;5154.768035438415;5155.175171972485;5163.199704045879;5206.271122042917;5250.553702935236;5242.947570524284;5274.841754747345;5300.655457395257;5306.575473962073;5339.119045357531;5318.893622127536;5333.839984800462;5337.4662533746705;5343.599230057742;5357.383900851393;5082.263071854561;5203.609729270282;5238.842834714965;5266.710330931797;5282.920756188661;5606.467385598362;5676.801311954062;5682.573806964494;5767.567432442542;5809.302883653946;6155.599886007395;6194.225721784777;6197.349278325756;6210.50315974721;6216.254049514042;6077.635341879457;6214.4407003369915;6245.812625621239;6247.406496382836;6249.2813326467585;5717.485426311652;5766.106253530709;5797.536197104221;5841.06542953134;5880.617759845596;6305.211848518935;6319.052142178618;6393.104965304861;6396.712147953353;6403;5959.195508606283;6088.1476593276975;6148.4773794227995;6151.2618485781995;6156.199694039746;6009.579329446984;6060.727267272983;6062.727177277033;6137.376985335611;6138.265785110792;6107.090308983151;6119.186697939807;6119.877602447926;6148.692565371803;6162.291336496361;6028.577999540078;6139.185504090456;6139.74593465464;6152.200213972155;6167.198264225622;4666.789994450258;4668.649851261169;4698.835540756126;4707.741074240881;4761;4136.772477513706;4166.812493437803;4178.707490475637;4216.746995180238;4247.277962746279;5654.604177707521;5779.913301300484;5830.82507524775;5841.4450627190345;5857.736401861926;6051.122587224828;6102.786402475892;6118.694065296718;6125.693326622233;6153.446189842846;5747.511461525817;5770.5095066919785;5784.797532086357;5790.507806836466;5793.797217097465;5077.060743762342;5080.060188865072;5122.385313762373;5122.92315615266;5128.205128205134;6220.129181914535;6408.1349017881985;6417.03744438338;6517.51118666102;6517.869642607121;6253.030780229072;6269.373062693694;6271.247450305992;6273.874522509615;6294.213223347082;6226.283977342664;6264.937350626436;6481.287058423664;6483.935160648522;6497.837554061186;6036.486898613667;6131.376666650161;6157.32269450369;6169.722362493789;6186.876262474815;6165.167702360303;6169.105479705508;6170.3212646607935;6216.2540495140875;6287.30839607652;5905.4685078343155;5941.22764040672;6100.786472473442;6110.358412366815;6119.051547010221;5968.791092311748;6044.727987240497;6054.091886217103;6064;6064.120702498201;5934.258217722785;5970.134330522137;5983.9401605983385;5984.251968503937;5985.6408615483215;5917.230760001173;5951.732172052181;6004.939950600613;6082.90875636857;6085.1785009023215;5919.467247947706;5950.642961422329;5993.011153159854;6016.8796624068145;6024.909626355696 13:48:37 INFO - PROCESS | 25105 | |1;ext.html;580.5268706004606;601.4722604584356;622.5424313129851;628.9465395441388;649.3538928765877;41461.17077658449;47127;47157.52842471574;47234;47252.29121563179;46674;46774.76612616941;46847;46911;47309.52690473094;9133.634654613808;9252.352335336529;9259.305552083588;9261;9267.304952128618;9160.816783664355;9184.678536251233;9228.307876909259;9261.120193581599;9261.72214833556;9254.953725231364;9298.512238041914;9300.674476393327;9303.395279306857;9309.674161404353;9210.309226807984;9246.260299176083;9271.119243671874;9276.814463710689;9307.720768376892;9159.267258619295;9185.402948808307;9261.490618016007;9288.071192880725;9290;44498.110037799066;44698.106037879385;44769.77615111903;44821.10357792859;44864.3270350945;3221.871125154991;3720.274546463441;3769.4722738816586;3854.9807250963568;4344.565543445662;33860.32279354399;34041.319173616386;34045.659543404494;34381.48427773586;34456.48315275273;4429.490608580022;4515.729056256602;4541.205289074399;4584.770761461914;4646.767661616939;327246;330155;331254;333070;333862;38243.61756382456;38429.80785096057;38438.23123537513;38443.23113537714;38463.230735385696;39082.2183556333;39395.40906886399;39425.60574394277;40145.59854401477;40208;19042.42872713821;19118.522036949187;19121.904390478237;19303.131359088875;19352.903235483733;14078.436862525385;14152.71694566103;14204.360803763855;14219.289035548181;14248.287585620885;20659.380218593466;20679.79320206809;20838.58322833535;20844.895775521327;21009.369718908456;7645.694172233159;7657.923420765721;7705.345045671069;7733.3426658733515;7803.492772969739;1046.3669479964665;1111.149970272742;1165.5279611757082;1177.952881884732;1179.2688533109356;33546.66453335436;34260.14349641279;34278.31443371119;34442.483362749575;34523.482147767805;1138.2544433396138;1165.4755360087825;1185.9703507412385;1234.1731040203085;1251.8122281657825;18044.729329060076;18125.456236312933;18128.274869005356;18142.909285453487;18149.546261343574;663351;667974;670939;671602;673031;63334;64038.67980660067;64338;64393.67803160954;64420.677896610214;1433.333499922541;1455.039673815298;1456.1845366594741;1466.9046511976687;1487.4050379847931;31863.840680797373;33331.333373332884;33403.33193336168;33628.831855840566;34155.316893662486;55448.72275638596;55840.44159558352;55950;56050.15924761214;56248;396374;398669;399111;399674;400758;31162.37675246437;31305.37389252248;31337.37325253528;31701.20746981344;31710;46836.29745553751;47169.76415117903;51180.74409628077;52411;53480.46519534755;44320.335194971456;45085.32372014488;45445;45782.77108614569;46797;43758.781206093765;45248;45671.543284568055;45969;46986;44416.55583444124;44735.55264447314;45097.323540146266;45771;48157.27764083612;39687.60312396839;39986.40020399638;40188.397174043;40550.79724601358;41220.79389603033;29764.55353169661;30697.53953690741;31227.219319517193;31346.21634459157;31472.370552589276 13:48:37 INFO - PROCESS | 25105 | |2;jquery.html;402.36426446214983;405.0824881643079;425.1284866024649;432.0667358505627;432.3709003400052;19225;20751.584968300624;20787.673972164455;20797.68803467947;21612.459688507795;19947.501312467197;20086.096125674343;20540.38378848633;20644.69032964503;20710.378688639328;5713.571482138836;5950.285965684124;5951.345352011275;5960.135780311853;5961.105834124873;5459.590530710193;5727.026405511052;5753.223314852504;5838.124281357809;5933.34733179352;5780.9710951445395;5819.359870414251;5827.213326200972;5839.036558967765;6452.548321617489;6400.423961843433;6403.455706264973;6409.679516024226;6445.9355406446275;6555.541112122153;4930.901381972376;5069.822556210552;5085.110105731519;5099;5105.974470127626;13859.4456221751;14097.083689560146;19013.61972760551;23916.40208994789;24094.638580421306;2542.9491410171877;2564.6024866145776;2619.7642212200994;2771.431856469419;2978.4489869374233;10498.475076246234;10503;10860;10878.292910960841;11078.723031924186;1941.5437372217518;2034.471037530238;2049.3749406431034;2054.732884724991;2075.7716651168357;59834.401655983755;78388;84101.57949210276;84455;84494.57752711259;11296.43517824122;11324.490397931948;11639.185257031926;11677.065834733201;11801.763964720658;16327.59181020484;16368.017918924903;16382.75425868613;16397.91801041011;16434.589135271715;8686.261667758312;8698.086700896441;8708.956455217683;8720.520371379635;8815.206631403076;8468.110848360957;8605.31157507398;8717;8846.248068914085;9100.590473428712;4809.543093406191;4896.730679812573;4906.656534042654;5069.974650126799;5073.315102461121;2021.6057868715754;2024.7367842180422;2034.5829105033433;2119.9682004769943;2180.4003898927604;1025.487256371814;1058.2010582010687;1063.0857462582328;1117.2235296468875;1129.6385156749761;20497.48756281075;20546.486337841674;20851.58296834055;20891.37325880226;20915;1056.4717641179411;1083.1334932054326;1087.244365166202;1091.5688303120223;1111.1333160135107;10553.26127171106;11468;11556.537738490535;11567.248128871597;11581.42092895352;418563;568670;570138;570165;572572;94002.52998734963;94404;94565;96822.51588742012;104058.47970760097;1063.5373612478443;1095.9890401095886;1140.43548443521;1147.0995268714018;1149.454009345571;18335.266589336276;18406.35577754772;18984;18989.430317090508;19135.8086419134;41001.38497922474;43438.131237374444;44337.77831110824;45136.322955156356;46669.299960501296;62332.68833655803;63013.68493157505;63115;64149.3585064162;64261;8564.357673174662;8565.785855353666;8588.484690918565;8777.341699372444;8794.868076978979;12154.696132596755;14000.229987350385;14164.433422662978;14186.148831069757;14207.715845683235;12064.517419303129;12082.637520874388;12236.327002014974;12349.32078735678;12454.128211025141;6306.779262725782;11940.76118477643;11956.461959211681;12005.879941200476;12174.634760957186;11041.33751974884;11555.942220289182;11758.823617645914;11801.52793888235;12035.939820301193;8667.17661822126;8797.692080777142;8870.423422477776;8915.821683566423;8987.325950553604;8567.186117318844;10808.351498910091;12090;12181;12316.876831231573 13:48:37 INFO - PROCESS | 25105 | |3;mootools.html;1537.9615509612258;1568.6156891561566;1778.1020584604773;1843.3363988963963;1891.8959457229846;8256.215659512352;8850.734477965663;8957.596908139132;9538.427694338336;9570.090841370067;9315.20820730237;9331.58007889645;9343.532823358839;9442.339036267447;9442.433453992766;2400.8079353651665;2443.5601591713485;2462.4705688277018;2465.506898620274;2465.630155476675;2439.658447817307;2480.913168039119;2492.5638013347684;2496.7378425265356;2513.736057713932;2435.6833611630464;2447.412620970972;2485.0805202075258;2493.6010238361864;2497.463045445229;2409.771071748181;2415.6738840256603;2424.321190066775;2453.9509209815706;2465.1988103866315;2309.5265470578493;2344.6365813298967;2350.4241460842204;2365.31405892291;2375.3467796355967;9332.300077494147;9423.717288481288;9439.339246252764;9450.102240287162;9463.621455141785;5300.469953004668;5497.120460726264;5522.22688823565;5522.66863988162;5532.114861622162;3478.9826050869838;3520.1551627609188;3575.94636080459;3597.622249663774;3610.4223324268255;1151.8214676725122;1193.0455635491658;1193.176708071428;1200.5317926008777;1206.221986818506;13122.671933201746;13324.733505329936;13336.933315333457;13395.263260520667;13420.396082176325;4484.304932735431;4533.455985281721;4692.95307046932;4701.600363969101;4816;11194.160437967184;11208.103351731841;11210.719732006602;11226.045786108272;11236.269642473213;5429.864253393696;5439.510444059974;5444.047291723932;5457.69982650958;5464.972675136599;4469.128519938581;4956.256561515729;5016.072026675077;5027.547520723152;5065.214891691794;3997.8400863965117;4005.759654420744;4126.051008268055;4151.14901445209;4153.68847336451;1179.4102948525738;1202.3567391445536;1233.3709807997986;1243.25404757145;1249.731307768834;1048.99475502622;1073.983890241647;1077.5474300793685;1085.3270971997413;1090.8363745438248;6254.593451425642;6314.873702525923;6327.17746692927;6387.297397286387;6395.776147834804;454.1666042811412;459.9931001034987;467.04489319342025;471.96403893454226;472.65732344050974;4336.479622445327;4439.933400998988;4516.81932722694;4589.242774942164;4624.28323609841;11064.502097405637;11763.823542646867;11790;11814.704632384088;11816.409179540988;10908.50911708975;11400.885991139983;11472.426378681033;11620.825687614693;11689.941550292195;8588.48469091844;8702.521361325187;8775.780605484786;8810.295176385875;8823.205911467998;6585.539012269287;6613.107230523818;6616.669166541557;6618.834529136618;6684.83287917806;10457;10777.892221078002;10898;10993.120550355792;11067.501962411872;10911.563537458731;10924.672259832218;11062.502187401748;11090.16823738239;11104.722381940515;7985.480943738638;8298.128696486781;8344.499330040217;8363.540005299767;8561.700340488052;9192.17270445663;9205.355625106178;9269.073092690676;9286.767830804283;9289.767755806159;8240.464369815943;8267.545285009382;8275.668973241003;8357.832843343222;8380.20388063133;7969.681212751425;8020.839583208186;8066.717664881701;8311.25198732117;8353.37349698763;7578.848423031619;7594.924050759421;7598.544087354777;7630;7636.350910172698;5818.33089194748;5828.242328497268;5917.881642367214;6029.065494848305;6034.849128771816;5771.047777116896;5819.912701309399;5862.355140934579;5871.089981052944;5974.641521508724 13:48:37 INFO - PROCESS | 25105 | |4;prototype.html;324.1119333027505;325.87290956526954;327.7050654411031;331.6915268800015;334.4281279012887;5857.619254748443;5920.9407905920925;5932.792352267671;5943;5960.0331890476145;5741.770329186827;5766.855828604276;5815.592908496396;5818.389069147742;5887.705614719258;4302.612764851163;4382;4476.462824461069;4516.54834516549;4519;4515.841945531907;4523.5024147343765;4530.478994915594;4539.409876716022;4548.567886050836;4481.910361792762;4508.594226519613;4509.391232183662;4518.97740511297;4533.478649955265;4249.426327445802;4398.97800510997;4443.688941774077;4443.733375997418;4451.532589078165;3835.137094153793;3881.437191607201;3882.844686212548;3899.78551179685;3929.7838618876235;5697.0599851024535;5705.172749951275;5713.8001869280215;5729.8772169167905;5753.395893431171;4947.579455746266;5022.974885125551;5070.974645126787;5077;5104.081265372269;5932.19915311436;6055.545834062419;6069.696515174223;6091;6114.755409783604;4188.643965262956;4237.131388065439;4252.808623611945;4295.8496452624;4303.289957157065;6289.905651415233;6290.213723284635;6321.399467050669;6334.904976425358;6364.777232796876;4287.4855017397485;4345.478542574911;4348.108637729258;4354.804033818486;4369.584889435499;4256.638185754246;4401.801918913657;4422.624076953495;4424.823007079745;4425.827155803715;5037;5038.168702164176;5063.3417655704525;5075.467075957045;5109.514596113363;6063.727132279058;6103.38966103395;6136.509079273647;6139.815805525842;6140.815775526652;1442.9134251944918;1513.735096358133;1519.1568679382829;1538.8384219656775;1543.772700702944;938.2869019545195;946.4605175050156;961.6538046303325;1011.676263595657;1040.8750949886062;5809.431453507614;5833.620814647034;5840.5035571976005;5878.764849406061;5899.882002359929;6122.938770612237;6218.875622487525;6276.780312689034;6336.968315158487;6342.809715708536;5762.740676669476;5789.421057894261;5793.217915581343;5814.767409303665;5826.863761566454;3327.5507806446303;3353.3796247694254;3361.46216605342;3396.456566949326;3404.14896275931;6266.436020758154;6288.723514722953;6352.174217351807;6437.742490300336;6536.379043990813;6313.779017734358;6354.062011086663;6354.586951848115;6357.078223657636;6415.390537898986;6233.475442445817;6443.613383197023;6470.741170353133;6481.935180648227;6543.672816359163;6135.877282454415;6191.876162476815;6232.314445411092;6247.68761561911;6260.308067531006;6190.566660333913;6206.224221972254;6217.658028808278;6224.62652240867;6235.251769787655;6348.682565871595;6582.473402127914;6584.967075164594;6604.735810567524;6627.719278956947;4456.398386217819;4469.128519938581;4482.238019536751;4482.663800214932;4483.461984561874;6223.782167624111;6361.681915904093;6398.616083035033;6409.9488163789;6440.323766004502;6158.476529495043;6176.66028368426;6182.165407669907;6197.194364732556;6235.189425374853;6011.819645410645;6205.503559715122;6209.223847019122;6245.96877015612;6252.062190671436;5841.8539536510225;5961.433663802105;6122.877542449215;6141.447269745744;6156.506614821004;6230.408111229426;6240.812775616557;6253.374662533893;6261.55984123645;6275.305667469666;5938.138969849434;5984.371640977809;6001.169643258848;6011.182898859169;6031.4270144336215 13:48:37 INFO - PROCESS | 25105 | |5;yui.html;806.4435539477756;824.3034635732805;858.0861382627501;902.2150728865888;957.3394357893055;17273.913630431845;18114.27542898286;18192.181351839165;18429.98635075072;18672.906635466803;16895.15524223787;16915.83084169161;16923;17156.656866862657;17212.13939303036;880.1814312689196;885.437747030637;900.7612982559627;901.5221932375819;906.0984320601011;906.2161230535572;915.8809354783868;917.0371110334156;918.2699753695828;919.4942781470198;949.924006079512;952.9761755956088;953.3279038277998;955.106974978394;959.0744931141447;945.7399215215802;949.7530642033087;951.9857202141974;954.203240294355;956.2111258212003;700.5621486570893;700.7862601906417;701.6456689371886;702.3924305475778;702.7751119641716;15936.760948585781;15943.123128227942;16053.678926421406;16060;16065.116418596972;15164.545063648107;16654.0840253786;16726.24731887056;16852.073135977516;17040.233189506504;14114.294285285798;14989.550313490503;14991.475298364505;15054.397824087024;15333.846661533353;4875.390576177978;4888.535589119064;4898.338724272213;4979.6265280104135;5069.290299358093;94414;94664;95472;96856.51571742167;98217.5089124557;12616;12632.489940463467;12722.491100355883;12905;12992.870071299356;23031.193908213132;23152.884235578713;23185.420364491023;23210.53578928446;23303.650445243336;8884.466931983972;9143.817123657489;9193.172614464731;9300;9324.487153206639;5219.295395121686;5251.081060814418;5289;5302.602304827154;5426.430224826416;3833.9424908626393;3969.285528604821;3971.1660551283976;3982.8406863725127;3987.3819557968563;666.3669513961755;675.490005046187;693.3898169610811;695.02696225285;700.9264027277062;729.9233877965954;732.8204589875407;753.3709352690455;756.0305404421513;758.3743411685382;9728.951355243178;9859.704208873745;10037.247206459544;10661.253712240225;10673;669.581511555278;706.4877963476439;721.913370395556;728.9271072892668;765.3991616580957;4505.752183629932;4624.97687511567;4781.737004464719;4797.040591881638;4802.807887684454;97859.51070244603;135557.3222133883;136350;137097.31451342878;138519;116479;116821;117189.41405292919;117429;117447;102282;104258.4787076075;106172;106271;108236;9073.410228335137;9262.305327100628;9317;9375.24998000172;9406.341556091282;56972.71513642405;59687;60117.39882601118;60382.698086511045;60700;76683.61658191674;79670;89260.5536972311;91700;92805.53597232241;11752.177347585586;11794.292342459137;11924.523019079139;12047.216930899463;12225.266484010632;13478.326083695973;13506.59480215595;13757;13781.655458613213;13856.237906914814;12423.937880310541;12614.873851261369;13082.084254102501;13310.40103195378;13398.464061437824;13241.536546220836;13301.733965320833;13423.185411783448;14383.928080359532;14461.566153015427;12842.101052926206;13031.674208144872;13037.227829524905;13081.803772943224;13232.801507977196;10243.334183278062;10376.377417354983;10404.427756473468;10504.842427363748;10628.574857005633;10808.621698240524;11232.831507527557;11262.324260544394;11445.885541144815;11504.94247528757 13:48:37 INFO - PROCESS | 25105 | __end_tp_report 13:48:37 INFO - PROCESS | 25105 | __start_cc_report 13:48:37 INFO - PROCESS | 25105 | _x_x_mozilla_cycle_collect,329 13:48:37 INFO - PROCESS | 25105 | __end_cc_report 13:48:37 INFO - PROCESS | 25105 | __startTimestamp1470862117834__endTimestamp 13:48:37 INFO - PROCESS | 25105 | 13:48:37 INFO - PROCESS | 25105 | ------- Summary: start ------- 13:48:37 INFO - PROCESS | 25105 | Number of tests: 6 13:48:37 INFO - PROCESS | 25105 | 13:48:37 INFO - PROCESS | 25105 | [#0] dojo.html Cycles:165 Average:5730.85 Median:5959.20 stddev:662.53 (11.1%) stddev-sans-first:635.79 13:48:37 INFO - PROCESS | 25105 | Values: 3269.2 3319.1 3321.9 3330.8 3340.5 5757.4 5773.7 5834.7 5838.6 5843.9 5766.6 5805.5 5817.4 5821.3 5837.6 5258.0 5290.7 5312.6 5332.3 5343.3 5154.8 5155.2 5163.2 5206.3 5250.6 5242.9 5274.8 5300.7 5306.6 5339.1 5318.9 5333.8 5337.5 5343.6 5357.4 5082.3 5203.6 5238.8 5266.7 5282.9 5606.5 5676.8 5682.6 5767.6 5809.3 6155.6 6194.2 6197.3 6210.5 6216.3 6077.6 6214.4 6245.8 6247.4 6249.3 5717.5 5766.1 5797.5 5841.1 5880.6 6305.2 6319.1 6393.1 6396.7 6403.0 5959.2 6088.1 6148.5 6151.3 6156.2 6009.6 6060.7 6062.7 6137.4 6138.3 6107.1 6119.2 6119.9 6148.7 6162.3 6028.6 6139.2 6139.7 6152.2 6167.2 4666.8 4668.6 4698.8 4707.7 4761.0 4136.8 4166.8 4178.7 4216.7 4247.3 5654.6 5779.9 5830.8 5841.4 5857.7 6051.1 6102.8 6118.7 6125.7 6153.4 5747.5 5770.5 5784.8 5790.5 5793.8 5077.1 5080.1 5122.4 5122.9 5128.2 6220.1 6408.1 6417.0 6517.5 6517.9 6253.0 6269.4 6271.2 6273.9 6294.2 6226.3 6264.9 6481.3 6483.9 6497.8 6036.5 6131.4 6157.3 6169.7 6186.9 6165.2 6169.1 6170.3 6216.3 6287.3 5905.5 5941.2 6100.8 6110.4 6119.1 5968.8 6044.7 6054.1 6064.0 6064.1 5934.3 5970.1 5983.9 5984.3 5985.6 5917.2 5951.7 6004.9 6082.9 6085.2 5919.5 5950.6 5993.0 6016.9 6024.9 13:48:37 INFO - PROCESS | 25105 | 13:48:37 INFO - PROCESS | 25105 | [#1] ext.html Cycles:180 Average:62925.64 Median:24051.67 stddev:130379.16 (542.1%) stddev-sans-first:130660.88 13:48:37 INFO - PROCESS | 25105 | Values: 580.5 601.5 622.5 628.9 649.4 41461.2 47127.0 47157.5 47234.0 47252.3 46674.0 46774.8 46847.0 46911.0 47309.5 9133.6 9252.4 9259.3 9261.0 9267.3 9160.8 9184.7 9228.3 9261.1 9261.7 9255.0 9298.5 9300.7 9303.4 9309.7 9210.3 9246.3 9271.1 9276.8 9307.7 9159.3 9185.4 9261.5 9288.1 9290.0 44498.1 44698.1 44769.8 44821.1 44864.3 3221.9 3720.3 3769.5 3855.0 4344.6 33860.3 34041.3 34045.7 34381.5 34456.5 4429.5 4515.7 4541.2 4584.8 4646.8 327246.0 330155.0 331254.0 333070.0 333862.0 38243.6 38429.8 38438.2 38443.2 38463.2 39082.2 39395.4 39425.6 40145.6 40208.0 19042.4 19118.5 19121.9 19303.1 19352.9 14078.4 14152.7 14204.4 14219.3 14248.3 20659.4 20679.8 20838.6 20844.9 21009.4 7645.7 7657.9 7705.3 7733.3 7803.5 1046.4 1111.1 1165.5 1178.0 1179.3 33546.7 34260.1 34278.3 34442.5 34523.5 1138.3 1165.5 1186.0 1234.2 1251.8 18044.7 18125.5 18128.3 18142.9 18149.5 663351.0 667974.0 670939.0 671602.0 673031.0 63334.0 64038.7 64338.0 64393.7 64420.7 1433.3 1455.0 1456.2 1466.9 1487.4 31863.8 33331.3 33403.3 33628.8 34155.3 55448.7 55840.4 55950.0 56050.2 56248.0 396374.0 398669.0 399111.0 399674.0 400758.0 31162.4 31305.4 31337.4 31701.2 31710.0 46836.3 47169.8 51180.7 52411.0 53480.5 44320.3 45085.3 45445.0 45782.8 46797.0 43758.8 45248.0 45671.5 45969.0 46986.0 44416.6 44735.6 45097.3 45771.0 48157.3 39687.6 39986.4 40188.4 40550.8 41220.8 29764.6 30697.5 31227.2 31346.2 31472.4 13:48:37 INFO - PROCESS | 25105 | 13:48:37 INFO - PROCESS | 25105 | [#2] jquery.html Cycles:180 Average:30870.10 Median:11896.43 stddev:89452.71 (751.9%) stddev-sans-first:89674.40 13:48:37 INFO - PROCESS | 25105 | Values: 402.4 405.1 425.1 432.1 432.4 19225.0 20751.6 20787.7 20797.7 21612.5 19947.5 20086.1 20540.4 20644.7 20710.4 5713.6 5950.3 5951.3 5960.1 5961.1 5459.6 5727.0 5753.2 5838.1 5933.3 5781.0 5819.4 5827.2 5839.0 6452.5 6400.4 6403.5 6409.7 6445.9 6555.5 4930.9 5069.8 5085.1 5099.0 5106.0 13859.4 14097.1 19013.6 23916.4 24094.6 2542.9 2564.6 2619.8 2771.4 2978.4 10498.5 10503.0 10860.0 10878.3 11078.7 1941.5 2034.5 2049.4 2054.7 2075.8 59834.4 78388.0 84101.6 84455.0 84494.6 11296.4 11324.5 11639.2 11677.1 11801.8 16327.6 16368.0 16382.8 16397.9 16434.6 8686.3 8698.1 8709.0 8720.5 8815.2 8468.1 8605.3 8717.0 8846.2 9100.6 4809.5 4896.7 4906.7 5070.0 5073.3 2021.6 2024.7 2034.6 2120.0 2180.4 1025.5 1058.2 1063.1 1117.2 1129.6 20497.5 20546.5 20851.6 20891.4 20915.0 1056.5 1083.1 1087.2 1091.6 1111.1 10553.3 11468.0 11556.5 11567.2 11581.4 418563.0 568670.0 570138.0 570165.0 572572.0 94002.5 94404.0 94565.0 96822.5 104058.5 1063.5 1096.0 1140.4 1147.1 1149.5 18335.3 18406.4 18984.0 18989.4 19135.8 41001.4 43438.1 44337.8 45136.3 46669.3 62332.7 63013.7 63115.0 64149.4 64261.0 8564.4 8565.8 8588.5 8777.3 8794.9 12154.7 14000.2 14164.4 14186.1 14207.7 12064.5 12082.6 12236.3 12349.3 12454.1 6306.8 11940.8 11956.5 12005.9 12174.6 11041.3 11555.9 11758.8 11801.5 12035.9 8667.2 8797.7 8870.4 8915.8 8987.3 8567.2 10808.4 12090.0 12181.0 12316.9 13:48:37 INFO - PROCESS | 25105 | 13:48:37 INFO - PROCESS | 25105 | [#3] mootools.html Cycles:180 Average:6190.97 Median:2493.81 stddev:3572.31 (143.2%) stddev-sans-first:3565.22 13:48:37 INFO - PROCESS | 25105 | Values: 1538.0 1568.6 1778.1 1843.3 1891.9 8256.2 8850.7 8957.6 9538.4 9570.1 9315.2 9331.6 9343.5 9442.3 9442.4 2400.8 2443.6 2462.5 2465.5 2465.6 2439.7 2480.9 2492.6 2496.7 2513.7 2435.7 2447.4 2485.1 2493.6 2497.5 2409.8 2415.7 2424.3 2454.0 2465.2 2309.5 2344.6 2350.4 2365.3 2375.3 9332.3 9423.7 9439.3 9450.1 9463.6 5300.5 5497.1 5522.2 5522.7 5532.1 3479.0 3520.2 3575.9 3597.6 3610.4 1151.8 1193.0 1193.2 1200.5 1206.2 13122.7 13324.7 13336.9 13395.3 13420.4 4484.3 4533.5 4693.0 4701.6 4816.0 11194.2 11208.1 11210.7 11226.0 11236.3 5429.9 5439.5 5444.0 5457.7 5465.0 4469.1 4956.3 5016.1 5027.5 5065.2 3997.8 4005.8 4126.1 4151.1 4153.7 1179.4 1202.4 1233.4 1243.3 1249.7 1049.0 1074.0 1077.5 1085.3 1090.8 6254.6 6314.9 6327.2 6387.3 6395.8 454.2 460.0 467.0 472.0 472.7 4336.5 4439.9 4516.8 4589.2 4624.3 11064.5 11763.8 11790.0 11814.7 11816.4 10908.5 11400.9 11472.4 11620.8 11689.9 8588.5 8702.5 8775.8 8810.3 8823.2 6585.5 6613.1 6616.7 6618.8 6684.8 10457.0 10777.9 10898.0 10993.1 11067.5 10911.6 10924.7 11062.5 11090.2 11104.7 7985.5 8298.1 8344.5 8363.5 8561.7 9192.2 9205.4 9269.1 9286.8 9289.8 8240.5 8267.5 8275.7 8357.8 8380.2 7969.7 8020.8 8066.7 8311.3 8353.4 7578.8 7594.9 7598.5 7630.0 7636.4 5818.3 5828.2 5917.9 6029.1 6034.8 5771.0 5819.9 5862.4 5871.1 5974.6 13:48:37 INFO - PROCESS | 25105 | 13:48:37 INFO - PROCESS | 25105 | [#4] prototype.html Cycles:180 Average:5126.35 Median:5868.19 stddev:1540.21 (26.2%) stddev-sans-first:1501.77 13:48:37 INFO - PROCESS | 25105 | Values: 324.1 325.9 327.7 331.7 334.4 5857.6 5920.9 5932.8 5943.0 5960.0 5741.8 5766.9 5815.6 5818.4 5887.7 4302.6 4382.0 4476.5 4516.5 4519.0 4515.8 4523.5 4530.5 4539.4 4548.6 4481.9 4508.6 4509.4 4519.0 4533.5 4249.4 4399.0 4443.7 4443.7 4451.5 3835.1 3881.4 3882.8 3899.8 3929.8 5697.1 5705.2 5713.8 5729.9 5753.4 4947.6 5023.0 5071.0 5077.0 5104.1 5932.2 6055.5 6069.7 6091.0 6114.8 4188.6 4237.1 4252.8 4295.8 4303.3 6289.9 6290.2 6321.4 6334.9 6364.8 4287.5 4345.5 4348.1 4354.8 4369.6 4256.6 4401.8 4422.6 4424.8 4425.8 5037.0 5038.2 5063.3 5075.5 5109.5 6063.7 6103.4 6136.5 6139.8 6140.8 1442.9 1513.7 1519.2 1538.8 1543.8 938.3 946.5 961.7 1011.7 1040.9 5809.4 5833.6 5840.5 5878.8 5899.9 6122.9 6218.9 6276.8 6337.0 6342.8 5762.7 5789.4 5793.2 5814.8 5826.9 3327.6 3353.4 3361.5 3396.5 3404.1 6266.4 6288.7 6352.2 6437.7 6536.4 6313.8 6354.1 6354.6 6357.1 6415.4 6233.5 6443.6 6470.7 6481.9 6543.7 6135.9 6191.9 6232.3 6247.7 6260.3 6190.6 6206.2 6217.7 6224.6 6235.3 6348.7 6582.5 6585.0 6604.7 6627.7 4456.4 4469.1 4482.2 4482.7 4483.5 6223.8 6361.7 6398.6 6409.9 6440.3 6158.5 6176.7 6182.2 6197.2 6235.2 6011.8 6205.5 6209.2 6246.0 6252.1 5841.9 5961.4 6122.9 6141.4 6156.5 6230.4 6240.8 6253.4 6261.6 6275.3 5938.1 5984.4 6001.2 6011.2 6031.4 13:48:37 INFO - PROCESS | 25105 | 13:48:37 INFO - PROCESS | 25105 | [#5] yui.html Cycles:180 Average:23713.22 Median:3985.11 stddev:35541.56 (891.9%) stddev-sans-first:35599.65 13:48:37 INFO - PROCESS | 25105 | Values: 806.4 824.3 858.1 902.2 957.3 17273.9 18114.3 18192.2 18430.0 18672.9 16895.2 16915.8 16923.0 17156.7 17212.1 880.2 885.4 900.8 901.5 906.1 906.2 915.9 917.0 918.3 919.5 949.9 953.0 953.3 955.1 959.1 945.7 949.8 952.0 954.2 956.2 700.6 700.8 701.6 702.4 702.8 15936.8 15943.1 16053.7 16060.0 16065.1 15164.5 16654.1 16726.2 16852.1 17040.2 14114.3 14989.6 14991.5 15054.4 15333.8 4875.4 4888.5 4898.3 4979.6 5069.3 94414.0 94664.0 95472.0 96856.5 98217.5 12616.0 12632.5 12722.5 12905.0 12992.9 23031.2 23152.9 23185.4 23210.5 23303.7 8884.5 9143.8 9193.2 9300.0 9324.5 5219.3 5251.1 5289.0 5302.6 5426.4 3833.9 3969.3 3971.2 3982.8 3987.4 666.4 675.5 693.4 695.0 700.9 729.9 732.8 753.4 756.0 758.4 9729.0 9859.7 10037.2 10661.3 10673.0 669.6 706.5 721.9 728.9 765.4 4505.8 4625.0 4781.7 4797.0 4802.8 97859.5 135557.3 136350.0 137097.3 138519.0 116479.0 116821.0 117189.4 117429.0 117447.0 102282.0 104258.5 106172.0 106271.0 108236.0 9073.4 9262.3 9317.0 9375.2 9406.3 56972.7 59687.0 60117.4 60382.7 60700.0 76683.6 79670.0 89260.6 91700.0 92805.5 11752.2 11794.3 11924.5 12047.2 12225.3 13478.3 13506.6 13757.0 13781.7 13856.2 12423.9 12614.9 13082.1 13310.4 13398.5 13241.5 13301.7 13423.2 14383.9 14461.6 12842.1 13031.7 13037.2 13081.8 13232.8 10243.3 10376.4 10404.4 10504.8 10628.6 10808.6 11232.8 11262.3 11445.9 11504.9 13:48:37 INFO - PROCESS | 25105 | -------- Summary: end -------- 13:48:37 INFO - PROCESS | 25105 | 13:48:38 INFO - TEST-INFO | 25105: exit 0 13:48:38 INFO - TEST-OK | dromaeo_css | took 1114648ms 13:48:38 INFO - TEST-START | kraken 13:48:38 INFO - operating with platform_type : linux_ 13:48:38 INFO - Initialising browser for kraken test... 13:48:38 INFO - TEST-INFO | started process 25373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplre2gM/profile http://localhost:39264/getInfo.html) 13:48:45 INFO - PROCESS | 25373 | __metrics Screen width/height:1600/1200 13:48:45 INFO - PROCESS | 25373 | colorDepth:24 13:48:45 INFO - PROCESS | 25373 | Browser inner width/height: 1024/697 13:48:45 INFO - PROCESS | 25373 | __metrics 13:48:47 ERROR - PROCESS | 25373 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 13:48:48 INFO - TEST-INFO | 25373: exit 0 13:48:48 INFO - Browser initialized. 13:48:48 INFO - Running cycle 1/1 for kraken test... 13:48:48 INFO - TEST-INFO | started process 25499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplre2gM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:49:00 INFO - PROCESS | 25499 | RSS: Main: 152576000 13:49:00 INFO - PROCESS | 25499 | 13:49:02 INFO - PROCESS | 25499 | Cycle 1(1): loaded http://localhost:39264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39264/tests/kraken/driver.html?testName=audio-beat-detection) 13:49:03 INFO - PROCESS | 25499 | RSS: Main: 157917184 13:49:03 INFO - PROCESS | 25499 | 13:49:06 INFO - PROCESS | 25499 | Cycle 1(1): loaded http://localhost:39264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39264/tests/kraken/driver.html?testName=audio-dft) 13:49:06 INFO - PROCESS | 25499 | RSS: Main: 156590080 13:49:06 INFO - PROCESS | 25499 | 13:49:09 INFO - PROCESS | 25499 | Cycle 1(1): loaded http://localhost:39264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39264/tests/kraken/driver.html?testName=audio-fft) 13:49:10 INFO - PROCESS | 25499 | RSS: Main: 157507584 13:49:10 INFO - PROCESS | 25499 | 13:49:12 INFO - PROCESS | 25499 | Cycle 1(1): loaded http://localhost:39264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39264/tests/kraken/driver.html?testName=audio-oscillator) 13:49:12 INFO - PROCESS | 25499 | RSS: Main: 157151232 13:49:12 INFO - PROCESS | 25499 | 13:49:15 INFO - PROCESS | 25499 | Cycle 1(1): loaded http://localhost:39264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:49:15 INFO - PROCESS | 25499 | RSS: Main: 157097984 13:49:15 INFO - PROCESS | 25499 | 13:49:18 INFO - PROCESS | 25499 | Cycle 1(1): loaded http://localhost:39264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39264/tests/kraken/driver.html?testName=imaging-darkroom) 13:49:19 INFO - PROCESS | 25499 | RSS: Main: 156172288 13:49:19 INFO - PROCESS | 25499 | 13:49:22 INFO - PROCESS | 25499 | Cycle 1(1): loaded http://localhost:39264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39264/tests/kraken/driver.html?testName=imaging-desaturate) 13:49:23 INFO - PROCESS | 25499 | RSS: Main: 156323840 13:49:23 INFO - PROCESS | 25499 | 13:49:26 INFO - PROCESS | 25499 | Cycle 1(1): loaded http://localhost:39264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39264/tests/kraken/driver.html?testName=json-parse-financial) 13:49:26 INFO - PROCESS | 25499 | RSS: Main: 157503488 13:49:26 INFO - PROCESS | 25499 | 13:49:28 INFO - PROCESS | 25499 | Cycle 1(1): loaded http://localhost:39264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:49:29 INFO - PROCESS | 25499 | RSS: Main: 157089792 13:49:29 INFO - PROCESS | 25499 | 13:49:30 INFO - PROCESS | 25499 | Cycle 1(1): loaded http://localhost:39264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39264/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:49:31 INFO - PROCESS | 25499 | RSS: Main: 157261824 13:49:31 INFO - PROCESS | 25499 | 13:49:33 INFO - PROCESS | 25499 | Cycle 1(1): loaded http://localhost:39264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:49:34 INFO - PROCESS | 25499 | RSS: Main: 157065216 13:49:34 INFO - PROCESS | 25499 | 13:49:36 INFO - PROCESS | 25499 | Cycle 1(1): loaded http://localhost:39264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:49:37 INFO - PROCESS | 25499 | RSS: Main: 157421568 13:49:37 INFO - PROCESS | 25499 | 13:49:39 INFO - PROCESS | 25499 | Cycle 1(1): loaded http://localhost:39264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:49:40 INFO - PROCESS | 25499 | RSS: Main: 158101504 13:49:40 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | Cycle 1(1): loaded http://localhost:39264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39264/tests/kraken/driver.html?testName=ai-astar) 13:49:42 INFO - PROCESS | 25499 | RSS: Main: 158261248 13:49:42 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | __start_tp_report 13:49:42 INFO - PROCESS | 25499 | _x_x_mozilla_page_load 13:49:42 INFO - PROCESS | 25499 | _x_x_mozilla_page_load_details 13:49:42 INFO - PROCESS | 25499 | |i|pagename|runs| 13:49:42 INFO - PROCESS | 25499 | |0;ai-astar;100;111;105;108;111;113;110;109;112;111 13:49:42 INFO - PROCESS | 25499 | |1;audio-beat-detection;156;115;136;173;120;143;147;121;172;116 13:49:42 INFO - PROCESS | 25499 | |2;audio-dft;163;162;162;162;164;164;164;162;161;163 13:49:42 INFO - PROCESS | 25499 | |3;audio-fft;78;76;75;173;75;76;77;76;162;75 13:49:42 INFO - PROCESS | 25499 | |4;audio-oscillator;83;85;148;85;83;83;142;84;83;153 13:49:42 INFO - PROCESS | 25499 | |5;imaging-gaussian-blur;117;118;118;118;120;117;118;117;117;118 13:49:42 INFO - PROCESS | 25499 | |6;imaging-darkroom;147;147;148;147;146;146;146;147;147;146 13:49:42 INFO - PROCESS | 25499 | |7;imaging-desaturate;95;95;95;95;96;96;95;96;95;95 13:49:42 INFO - PROCESS | 25499 | |8;json-parse-financial;60;52;52;53;55;53;52;52;53;53 13:49:42 INFO - PROCESS | 25499 | |9;json-stringify-tinderbox;63;60;61;61;61;61;61;60;61;60 13:49:42 INFO - PROCESS | 25499 | |10;stanford-crypto-aes;75;73;73;73;78;74;74;74;74;72 13:49:42 INFO - PROCESS | 25499 | |11;stanford-crypto-ccm;122;117;133;125;117;117;134;121;149;124 13:49:42 INFO - PROCESS | 25499 | |12;stanford-crypto-pbkdf2;153;152;153;148;150;148;151;150;148;148 13:49:42 INFO - PROCESS | 25499 | |13;stanford-crypto-sha256-iterative;63;64;63;61;62;62;61;60;60;61 13:49:42 INFO - PROCESS | 25499 | __end_tp_report 13:49:42 INFO - PROCESS | 25499 | __start_cc_report 13:49:42 INFO - PROCESS | 25499 | _x_x_mozilla_cycle_collect,849 13:49:42 INFO - PROCESS | 25499 | __end_cc_report 13:49:42 INFO - PROCESS | 25499 | __startTimestamp1470862182401__endTimestamp 13:49:42 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | ------- Summary: start ------- 13:49:42 INFO - PROCESS | 25499 | Number of tests: 14 13:49:42 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:3.89 (3.5%) stddev-sans-first:2.40 13:49:42 INFO - PROCESS | 25499 | Values: 100.0 111.0 105.0 108.0 111.0 113.0 110.0 109.0 112.0 111.0 13:49:42 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:145.00 stddev:22.12 (15.3%) stddev-sans-first:22.69 13:49:42 INFO - PROCESS | 25499 | Values: 156.0 115.0 136.0 173.0 120.0 143.0 147.0 121.0 172.0 116.0 13:49:42 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:1.12 13:49:42 INFO - PROCESS | 25499 | Values: 163.0 162.0 162.0 162.0 164.0 164.0 164.0 162.0 161.0 163.0 13:49:42 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.00 stddev:38.68 (50.9%) stddev-sans-first:40.57 13:49:42 INFO - PROCESS | 25499 | Values: 78.0 76.0 75.0 173.0 75.0 76.0 77.0 76.0 162.0 75.0 13:49:42 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:83.00 stddev:31.01 (37.4%) stddev-sans-first:32.04 13:49:42 INFO - PROCESS | 25499 | Values: 83.0 85.0 148.0 85.0 83.0 83.0 142.0 84.0 83.0 153.0 13:49:42 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 13:49:42 INFO - PROCESS | 25499 | Values: 117.0 118.0 118.0 118.0 120.0 117.0 118.0 117.0 117.0 118.0 13:49:42 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 13:49:42 INFO - PROCESS | 25499 | Values: 147.0 147.0 148.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 13:49:42 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:49:42 INFO - PROCESS | 25499 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 13:49:42 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.00 stddev:2.46 (4.6%) stddev-sans-first:0.97 13:49:42 INFO - PROCESS | 25499 | Values: 60.0 52.0 52.0 53.0 55.0 53.0 52.0 52.0 53.0 53.0 13:49:42 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.88 (1.4%) stddev-sans-first:0.50 13:49:42 INFO - PROCESS | 25499 | Values: 63.0 60.0 61.0 61.0 61.0 61.0 61.0 60.0 61.0 60.0 13:49:42 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.00 stddev:1.63 (2.2%) stddev-sans-first:1.69 13:49:42 INFO - PROCESS | 25499 | Values: 75.0 73.0 73.0 73.0 78.0 74.0 74.0 74.0 74.0 72.0 13:49:42 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:124.50 stddev:10.17 (8.2%) stddev-sans-first:10.69 13:49:42 INFO - PROCESS | 25499 | Values: 122.0 117.0 133.0 125.0 117.0 117.0 134.0 121.0 149.0 124.0 13:49:42 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.10 Median:150.50 stddev:2.08 (1.4%) stddev-sans-first:1.92 13:49:42 INFO - PROCESS | 25499 | Values: 153.0 152.0 153.0 148.0 150.0 148.0 151.0 150.0 148.0 148.0 13:49:42 INFO - PROCESS | 25499 | 13:49:42 INFO - PROCESS | 25499 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:1.34 (2.2%) stddev-sans-first:1.33 13:49:42 INFO - PROCESS | 25499 | Values: 63.0 64.0 63.0 61.0 62.0 62.0 61.0 60.0 60.0 61.0 13:49:42 INFO - PROCESS | 25499 | -------- Summary: end -------- 13:49:42 INFO - PROCESS | 25499 | 13:49:44 INFO - TEST-INFO | 25499: exit 0 13:49:44 INFO - TEST-OK | kraken | took 66194ms 13:49:44 INFO - SUITE-END | took 1180s 13:49:45 INFO - Completed test suite (00:19:41) 13:49:45 INFO - javascript benchmark 13:49:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7714.588835353918, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3269.231730543322, 3319.0706602151404, 3321.9169520761993, 3330.7501937354705, 3340.482225255085, 5757.395473475282, 5773.711314434272, 5834.708264586775, 5838.591298609093, 5843.853903652411, 5766.625169363989, 5805.535557155428, 5817.447342502455, 5821.27234095738, 5837.620554663944, 5257.973710131444, 5290.656107353029, 5312.60155488338, 5332.253484512172, 5343.251944727741, 5154.768035438415, 5155.175171972485, 5163.199704045879, 5206.271122042917, 5250.553702935236, 5242.947570524284, 5274.841754747345, 5300.655457395257, 5306.575473962073, 5339.119045357531, 5318.893622127536, 5333.839984800462, 5337.4662533746705, 5343.599230057742, 5357.383900851393, 5082.263071854561, 5203.609729270282, 5238.842834714965, 5266.710330931797, 5282.920756188661, 5606.467385598362, 5676.801311954062, 5682.573806964494, 5767.567432442542, 5809.302883653946, 6155.599886007395, 6194.225721784777, 6197.349278325756, 6210.50315974721, 6216.254049514042, 6077.635341879457, 6214.4407003369915, 6245.812625621239, 6247.406496382836, 6249.2813326467585, 5717.485426311652, 5766.106253530709, 5797.536197104221, 5841.06542953134, 5880.617759845596, 6305.211848518935, 6319.052142178618, 6393.104965304861, 6396.712147953353, 6403.0, 5959.195508606283, 6088.1476593276975, 6148.4773794227995, 6151.2618485781995, 6156.199694039746, 6009.579329446984, 6060.727267272983, 6062.727177277033, 6137.376985335611, 6138.265785110792, 6107.090308983151, 6119.186697939807, 6119.877602447926, 6148.692565371803, 6162.291336496361, 6028.577999540078, 6139.185504090456, 6139.74593465464, 6152.200213972155, 6167.198264225622, 4666.789994450258, 4668.649851261169, 4698.835540756126, 4707.741074240881, 4761.0, 4136.772477513706, 4166.812493437803, 4178.707490475637, 4216.746995180238, 4247.277962746279, 5654.604177707521, 5779.913301300484, 5830.82507524775, 5841.4450627190345, 5857.736401861926, 6051.122587224828, 6102.786402475892, 6118.694065296718, 6125.693326622233, 6153.446189842846, 5747.511461525817, 5770.5095066919785, 5784.797532086357, 5790.507806836466, 5793.797217097465, 5077.060743762342, 5080.060188865072, 5122.385313762373, 5122.92315615266, 5128.205128205134, 6220.129181914535, 6408.1349017881985, 6417.03744438338, 6517.51118666102, 6517.869642607121, 6253.030780229072, 6269.373062693694, 6271.247450305992, 6273.874522509615, 6294.213223347082, 6226.283977342664, 6264.937350626436, 6481.287058423664, 6483.935160648522, 6497.837554061186, 6036.486898613667, 6131.376666650161, 6157.32269450369, 6169.722362493789, 6186.876262474815, 6165.167702360303, 6169.105479705508, 6170.3212646607935, 6216.2540495140875, 6287.30839607652, 5905.4685078343155, 5941.22764040672, 6100.786472473442, 6110.358412366815, 6119.051547010221, 5968.791092311748, 6044.727987240497, 6054.091886217103, 6064.0, 6064.120702498201, 5934.258217722785, 5970.134330522137, 5983.9401605983385, 5984.251968503937, 5985.6408615483215, 5917.230760001173, 5951.732172052181, 6004.939950600613, 6082.90875636857, 6085.1785009023215, 5919.467247947706, 5950.642961422329, 5993.011153159854, 6016.8796624068145, 6024.909626355696], "value": 5685.263870310501, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.5268706004606, 601.4722604584356, 622.5424313129851, 628.9465395441388, 649.3538928765877, 41461.17077658449, 47127.0, 47157.52842471574, 47234.0, 47252.29121563179, 46674.0, 46774.76612616941, 46847.0, 46911.0, 47309.52690473094, 9133.634654613808, 9252.352335336529, 9259.305552083588, 9261.0, 9267.304952128618, 9160.816783664355, 9184.678536251233, 9228.307876909259, 9261.120193581599, 9261.72214833556, 9254.953725231364, 9298.512238041914, 9300.674476393327, 9303.395279306857, 9309.674161404353, 9210.309226807984, 9246.260299176083, 9271.119243671874, 9276.814463710689, 9307.720768376892, 9159.267258619295, 9185.402948808307, 9261.490618016007, 9288.071192880725, 9290.0, 44498.110037799066, 44698.106037879385, 44769.77615111903, 44821.10357792859, 44864.3270350945, 3221.871125154991, 3720.274546463441, 3769.4722738816586, 3854.9807250963568, 4344.565543445662, 33860.32279354399, 34041.319173616386, 34045.659543404494, 34381.48427773586, 34456.48315275273, 4429.490608580022, 4515.729056256602, 4541.205289074399, 4584.770761461914, 4646.767661616939, 327246.0, 330155.0, 331254.0, 333070.0, 333862.0, 38243.61756382456, 38429.80785096057, 38438.23123537513, 38443.23113537714, 38463.230735385696, 39082.2183556333, 39395.40906886399, 39425.60574394277, 40145.59854401477, 40208.0, 19042.42872713821, 19118.522036949187, 19121.904390478237, 19303.131359088875, 19352.903235483733, 14078.436862525385, 14152.71694566103, 14204.360803763855, 14219.289035548181, 14248.287585620885, 20659.380218593466, 20679.79320206809, 20838.58322833535, 20844.895775521327, 21009.369718908456, 7645.694172233159, 7657.923420765721, 7705.345045671069, 7733.3426658733515, 7803.492772969739, 1046.3669479964665, 1111.149970272742, 1165.5279611757082, 1177.952881884732, 1179.2688533109356, 33546.66453335436, 34260.14349641279, 34278.31443371119, 34442.483362749575, 34523.482147767805, 1138.2544433396138, 1165.4755360087825, 1185.9703507412385, 1234.1731040203085, 1251.8122281657825, 18044.729329060076, 18125.456236312933, 18128.274869005356, 18142.909285453487, 18149.546261343574, 663351.0, 667974.0, 670939.0, 671602.0, 673031.0, 63334.0, 64038.67980660067, 64338.0, 64393.67803160954, 64420.677896610214, 1433.333499922541, 1455.039673815298, 1456.1845366594741, 1466.9046511976687, 1487.4050379847931, 31863.840680797373, 33331.333373332884, 33403.33193336168, 33628.831855840566, 34155.316893662486, 55448.72275638596, 55840.44159558352, 55950.0, 56050.15924761214, 56248.0, 396374.0, 398669.0, 399111.0, 399674.0, 400758.0, 31162.37675246437, 31305.37389252248, 31337.37325253528, 31701.20746981344, 31710.0, 46836.29745553751, 47169.76415117903, 51180.74409628077, 52411.0, 53480.46519534755, 44320.335194971456, 45085.32372014488, 45445.0, 45782.77108614569, 46797.0, 43758.781206093765, 45248.0, 45671.543284568055, 45969.0, 46986.0, 44416.55583444124, 44735.55264447314, 45097.323540146266, 45771.0, 48157.27764083612, 39687.60312396839, 39986.40020399638, 40188.397174043, 40550.79724601358, 41220.79389603033, 29764.55353169661, 30697.53953690741, 31227.219319517193, 31346.21634459157, 31472.370552589276], "value": 20973.68994204136, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.36426446214983, 405.0824881643079, 425.1284866024649, 432.0667358505627, 432.3709003400052, 19225.0, 20751.584968300624, 20787.673972164455, 20797.68803467947, 21612.459688507795, 19947.501312467197, 20086.096125674343, 20540.38378848633, 20644.69032964503, 20710.378688639328, 5713.571482138836, 5950.285965684124, 5951.345352011275, 5960.135780311853, 5961.105834124873, 5459.590530710193, 5727.026405511052, 5753.223314852504, 5838.124281357809, 5933.34733179352, 5780.9710951445395, 5819.359870414251, 5827.213326200972, 5839.036558967765, 6452.548321617489, 6400.423961843433, 6403.455706264973, 6409.679516024226, 6445.9355406446275, 6555.541112122153, 4930.901381972376, 5069.822556210552, 5085.110105731519, 5099.0, 5105.974470127626, 13859.4456221751, 14097.083689560146, 19013.61972760551, 23916.40208994789, 24094.638580421306, 2542.9491410171877, 2564.6024866145776, 2619.7642212200994, 2771.431856469419, 2978.4489869374233, 10498.475076246234, 10503.0, 10860.0, 10878.292910960841, 11078.723031924186, 1941.5437372217518, 2034.471037530238, 2049.3749406431034, 2054.732884724991, 2075.7716651168357, 59834.401655983755, 78388.0, 84101.57949210276, 84455.0, 84494.57752711259, 11296.43517824122, 11324.490397931948, 11639.185257031926, 11677.065834733201, 11801.763964720658, 16327.59181020484, 16368.017918924903, 16382.75425868613, 16397.91801041011, 16434.589135271715, 8686.261667758312, 8698.086700896441, 8708.956455217683, 8720.520371379635, 8815.206631403076, 8468.110848360957, 8605.31157507398, 8717.0, 8846.248068914085, 9100.590473428712, 4809.543093406191, 4896.730679812573, 4906.656534042654, 5069.974650126799, 5073.315102461121, 2021.6057868715754, 2024.7367842180422, 2034.5829105033433, 2119.9682004769943, 2180.4003898927604, 1025.487256371814, 1058.2010582010687, 1063.0857462582328, 1117.2235296468875, 1129.6385156749761, 20497.48756281075, 20546.486337841674, 20851.58296834055, 20891.37325880226, 20915.0, 1056.4717641179411, 1083.1334932054326, 1087.244365166202, 1091.5688303120223, 1111.1333160135107, 10553.26127171106, 11468.0, 11556.537738490535, 11567.248128871597, 11581.42092895352, 418563.0, 568670.0, 570138.0, 570165.0, 572572.0, 94002.52998734963, 94404.0, 94565.0, 96822.51588742012, 104058.47970760097, 1063.5373612478443, 1095.9890401095886, 1140.43548443521, 1147.0995268714018, 1149.454009345571, 18335.266589336276, 18406.35577754772, 18984.0, 18989.430317090508, 19135.8086419134, 41001.38497922474, 43438.131237374444, 44337.77831110824, 45136.322955156356, 46669.299960501296, 62332.68833655803, 63013.68493157505, 63115.0, 64149.3585064162, 64261.0, 8564.357673174662, 8565.785855353666, 8588.484690918565, 8777.341699372444, 8794.868076978979, 12154.696132596755, 14000.229987350385, 14164.433422662978, 14186.148831069757, 14207.715845683235, 12064.517419303129, 12082.637520874388, 12236.327002014974, 12349.32078735678, 12454.128211025141, 6306.779262725782, 11940.76118477643, 11956.461959211681, 12005.879941200476, 12174.634760957186, 11041.33751974884, 11555.942220289182, 11758.823617645914, 11801.52793888235, 12035.939820301193, 8667.17661822126, 8797.692080777142, 8870.423422477776, 8915.821683566423, 8987.325950553604, 8567.186117318844, 10808.351498910091, 12090.0, 12181.0, 12316.876831231573], "value": 9604.651650933296, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.9615509612258, 1568.6156891561566, 1778.1020584604773, 1843.3363988963963, 1891.8959457229846, 8256.215659512352, 8850.734477965663, 8957.596908139132, 9538.427694338336, 9570.090841370067, 9315.20820730237, 9331.58007889645, 9343.532823358839, 9442.339036267447, 9442.433453992766, 2400.8079353651665, 2443.5601591713485, 2462.4705688277018, 2465.506898620274, 2465.630155476675, 2439.658447817307, 2480.913168039119, 2492.5638013347684, 2496.7378425265356, 2513.736057713932, 2435.6833611630464, 2447.412620970972, 2485.0805202075258, 2493.6010238361864, 2497.463045445229, 2409.771071748181, 2415.6738840256603, 2424.321190066775, 2453.9509209815706, 2465.1988103866315, 2309.5265470578493, 2344.6365813298967, 2350.4241460842204, 2365.31405892291, 2375.3467796355967, 9332.300077494147, 9423.717288481288, 9439.339246252764, 9450.102240287162, 9463.621455141785, 5300.469953004668, 5497.120460726264, 5522.22688823565, 5522.66863988162, 5532.114861622162, 3478.9826050869838, 3520.1551627609188, 3575.94636080459, 3597.622249663774, 3610.4223324268255, 1151.8214676725122, 1193.0455635491658, 1193.176708071428, 1200.5317926008777, 1206.221986818506, 13122.671933201746, 13324.733505329936, 13336.933315333457, 13395.263260520667, 13420.396082176325, 4484.304932735431, 4533.455985281721, 4692.95307046932, 4701.600363969101, 4816.0, 11194.160437967184, 11208.103351731841, 11210.719732006602, 11226.045786108272, 11236.269642473213, 5429.864253393696, 5439.510444059974, 5444.047291723932, 5457.69982650958, 5464.972675136599, 4469.128519938581, 4956.256561515729, 5016.072026675077, 5027.547520723152, 5065.214891691794, 3997.8400863965117, 4005.759654420744, 4126.051008268055, 4151.14901445209, 4153.68847336451, 1179.4102948525738, 1202.3567391445536, 1233.3709807997986, 1243.25404757145, 1249.731307768834, 1048.99475502622, 1073.983890241647, 1077.5474300793685, 1085.3270971997413, 1090.8363745438248, 6254.593451425642, 6314.873702525923, 6327.17746692927, 6387.297397286387, 6395.776147834804, 454.1666042811412, 459.9931001034987, 467.04489319342025, 471.96403893454226, 472.65732344050974, 4336.479622445327, 4439.933400998988, 4516.81932722694, 4589.242774942164, 4624.28323609841, 11064.502097405637, 11763.823542646867, 11790.0, 11814.704632384088, 11816.409179540988, 10908.50911708975, 11400.885991139983, 11472.426378681033, 11620.825687614693, 11689.941550292195, 8588.48469091844, 8702.521361325187, 8775.780605484786, 8810.295176385875, 8823.205911467998, 6585.539012269287, 6613.107230523818, 6616.669166541557, 6618.834529136618, 6684.83287917806, 10457.0, 10777.892221078002, 10898.0, 10993.120550355792, 11067.501962411872, 10911.563537458731, 10924.672259832218, 11062.502187401748, 11090.16823738239, 11104.722381940515, 7985.480943738638, 8298.128696486781, 8344.499330040217, 8363.540005299767, 8561.700340488052, 9192.17270445663, 9205.355625106178, 9269.073092690676, 9286.767830804283, 9289.767755806159, 8240.464369815943, 8267.545285009382, 8275.668973241003, 8357.832843343222, 8380.20388063133, 7969.681212751425, 8020.839583208186, 8066.717664881701, 8311.25198732117, 8353.37349698763, 7578.848423031619, 7594.924050759421, 7598.544087354777, 7630.0, 7636.350910172698, 5818.33089194748, 5828.242328497268, 5917.881642367214, 6029.065494848305, 6034.849128771816, 5771.047777116896, 5819.912701309399, 5862.355140934579, 5871.089981052944, 5974.641521508724], "value": 4842.13395618826, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.1119333027505, 325.87290956526954, 327.7050654411031, 331.6915268800015, 334.4281279012887, 5857.619254748443, 5920.9407905920925, 5932.792352267671, 5943.0, 5960.0331890476145, 5741.770329186827, 5766.855828604276, 5815.592908496396, 5818.389069147742, 5887.705614719258, 4302.612764851163, 4382.0, 4476.462824461069, 4516.54834516549, 4519.0, 4515.841945531907, 4523.5024147343765, 4530.478994915594, 4539.409876716022, 4548.567886050836, 4481.910361792762, 4508.594226519613, 4509.391232183662, 4518.97740511297, 4533.478649955265, 4249.426327445802, 4398.97800510997, 4443.688941774077, 4443.733375997418, 4451.532589078165, 3835.137094153793, 3881.437191607201, 3882.844686212548, 3899.78551179685, 3929.7838618876235, 5697.0599851024535, 5705.172749951275, 5713.8001869280215, 5729.8772169167905, 5753.395893431171, 4947.579455746266, 5022.974885125551, 5070.974645126787, 5077.0, 5104.081265372269, 5932.19915311436, 6055.545834062419, 6069.696515174223, 6091.0, 6114.755409783604, 4188.643965262956, 4237.131388065439, 4252.808623611945, 4295.8496452624, 4303.289957157065, 6289.905651415233, 6290.213723284635, 6321.399467050669, 6334.904976425358, 6364.777232796876, 4287.4855017397485, 4345.478542574911, 4348.108637729258, 4354.804033818486, 4369.584889435499, 4256.638185754246, 4401.801918913657, 4422.624076953495, 4424.823007079745, 4425.827155803715, 5037.0, 5038.168702164176, 5063.3417655704525, 5075.467075957045, 5109.514596113363, 6063.727132279058, 6103.38966103395, 6136.509079273647, 6139.815805525842, 6140.815775526652, 1442.9134251944918, 1513.735096358133, 1519.1568679382829, 1538.8384219656775, 1543.772700702944, 938.2869019545195, 946.4605175050156, 961.6538046303325, 1011.676263595657, 1040.8750949886062, 5809.431453507614, 5833.620814647034, 5840.5035571976005, 5878.764849406061, 5899.882002359929, 6122.938770612237, 6218.875622487525, 6276.780312689034, 6336.968315158487, 6342.809715708536, 5762.740676669476, 5789.421057894261, 5793.217915581343, 5814.767409303665, 5826.863761566454, 3327.5507806446303, 3353.3796247694254, 3361.46216605342, 3396.456566949326, 3404.14896275931, 6266.436020758154, 6288.723514722953, 6352.174217351807, 6437.742490300336, 6536.379043990813, 6313.779017734358, 6354.062011086663, 6354.586951848115, 6357.078223657636, 6415.390537898986, 6233.475442445817, 6443.613383197023, 6470.741170353133, 6481.935180648227, 6543.672816359163, 6135.877282454415, 6191.876162476815, 6232.314445411092, 6247.68761561911, 6260.308067531006, 6190.566660333913, 6206.224221972254, 6217.658028808278, 6224.62652240867, 6235.251769787655, 6348.682565871595, 6582.473402127914, 6584.967075164594, 6604.735810567524, 6627.719278956947, 4456.398386217819, 4469.128519938581, 4482.238019536751, 4482.663800214932, 4483.461984561874, 6223.782167624111, 6361.681915904093, 6398.616083035033, 6409.9488163789, 6440.323766004502, 6158.476529495043, 6176.66028368426, 6182.165407669907, 6197.194364732556, 6235.189425374853, 6011.819645410645, 6205.503559715122, 6209.223847019122, 6245.96877015612, 6252.062190671436, 5841.8539536510225, 5961.433663802105, 6122.877542449215, 6141.447269745744, 6156.506614821004, 6230.408111229426, 6240.812775616557, 6253.374662533893, 6261.55984123645, 6275.305667469666, 5938.138969849434, 5984.371640977809, 6001.169643258848, 6011.182898859169, 6031.4270144336215], "value": 4619.432020858233, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.4435539477756, 824.3034635732805, 858.0861382627501, 902.2150728865888, 957.3394357893055, 17273.913630431845, 18114.27542898286, 18192.181351839165, 18429.98635075072, 18672.906635466803, 16895.15524223787, 16915.83084169161, 16923.0, 17156.656866862657, 17212.13939303036, 880.1814312689196, 885.437747030637, 900.7612982559627, 901.5221932375819, 906.0984320601011, 906.2161230535572, 915.8809354783868, 917.0371110334156, 918.2699753695828, 919.4942781470198, 949.924006079512, 952.9761755956088, 953.3279038277998, 955.106974978394, 959.0744931141447, 945.7399215215802, 949.7530642033087, 951.9857202141974, 954.203240294355, 956.2111258212003, 700.5621486570893, 700.7862601906417, 701.6456689371886, 702.3924305475778, 702.7751119641716, 15936.760948585781, 15943.123128227942, 16053.678926421406, 16060.0, 16065.116418596972, 15164.545063648107, 16654.0840253786, 16726.24731887056, 16852.073135977516, 17040.233189506504, 14114.294285285798, 14989.550313490503, 14991.475298364505, 15054.397824087024, 15333.846661533353, 4875.390576177978, 4888.535589119064, 4898.338724272213, 4979.6265280104135, 5069.290299358093, 94414.0, 94664.0, 95472.0, 96856.51571742167, 98217.5089124557, 12616.0, 12632.489940463467, 12722.491100355883, 12905.0, 12992.870071299356, 23031.193908213132, 23152.884235578713, 23185.420364491023, 23210.53578928446, 23303.650445243336, 8884.466931983972, 9143.817123657489, 9193.172614464731, 9300.0, 9324.487153206639, 5219.295395121686, 5251.081060814418, 5289.0, 5302.602304827154, 5426.430224826416, 3833.9424908626393, 3969.285528604821, 3971.1660551283976, 3982.8406863725127, 3987.3819557968563, 666.3669513961755, 675.490005046187, 693.3898169610811, 695.02696225285, 700.9264027277062, 729.9233877965954, 732.8204589875407, 753.3709352690455, 756.0305404421513, 758.3743411685382, 9728.951355243178, 9859.704208873745, 10037.247206459544, 10661.253712240225, 10673.0, 669.581511555278, 706.4877963476439, 721.913370395556, 728.9271072892668, 765.3991616580957, 4505.752183629932, 4624.97687511567, 4781.737004464719, 4797.040591881638, 4802.807887684454, 97859.51070244603, 135557.3222133883, 136350.0, 137097.31451342878, 138519.0, 116479.0, 116821.0, 117189.41405292919, 117429.0, 117447.0, 102282.0, 104258.4787076075, 106172.0, 106271.0, 108236.0, 9073.410228335137, 9262.305327100628, 9317.0, 9375.24998000172, 9406.341556091282, 56972.71513642405, 59687.0, 60117.39882601118, 60382.698086511045, 60700.0, 76683.61658191674, 79670.0, 89260.5536972311, 91700.0, 92805.53597232241, 11752.177347585586, 11794.292342459137, 11924.523019079139, 12047.216930899463, 12225.266484010632, 13478.326083695973, 13506.59480215595, 13757.0, 13781.655458613213, 13856.237906914814, 12423.937880310541, 12614.873851261369, 13082.084254102501, 13310.40103195378, 13398.464061437824, 13241.536546220836, 13301.733965320833, 13423.185411783448, 14383.928080359532, 14461.566153015427, 12842.101052926206, 13031.674208144872, 13037.227829524905, 13081.803772943224, 13232.801507977196, 10243.334183278062, 10376.377417354983, 10404.427756473468, 10504.842427363748, 10628.574857005633, 10808.621698240524, 11232.831507527557, 11262.324260544394, 11445.885541144815, 11504.94247528757], "value": 8228.1693124257, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1494.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 105.0, 108.0, 111.0, 113.0, 110.0, 109.0, 112.0, 111.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 115.0, 136.0, 173.0, 120.0, 143.0, 147.0, 121.0, 172.0, 116.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 164.0, 164.0, 164.0, 162.0, 161.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 75.0, 173.0, 75.0, 76.0, 77.0, 76.0, 162.0, 75.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 148.0, 85.0, 83.0, 83.0, 142.0, 84.0, 83.0, 153.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 120.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 52.0, 52.0, 53.0, 55.0, 53.0, 52.0, 52.0, 53.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 60.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 73.0, 73.0, 78.0, 74.0, 74.0, 74.0, 74.0, 72.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 117.0, 133.0, 125.0, 117.0, 117.0, 134.0, 121.0, 149.0, 124.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 153.0, 148.0, 150.0, 148.0, 151.0, 150.0, 148.0, 148.0], "value": 150.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 61.0, 62.0, 62.0, 61.0, 60.0, 60.0, 61.0], "value": 61.7, "unit": "score"}]}]} 13:49:45 INFO - Return code: 0 13:49:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:49:45 ERROR - # TBPL SUCCESS # 13:49:45 INFO - Running post-action listener: _resource_record_post_action 13:49:45 INFO - [mozharness: 2016-08-10 20:49:45.221818Z] Finished run-tests step (success) 13:49:45 INFO - Running post-run listener: _resource_record_post_run 13:49:45 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 266240; Write bytes: 330530816; Read time: 40; Write time: 1757868 13:49:45 INFO - TinderboxPrint: CPU usage
13.4% 13:49:45 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 40 13:49:45 INFO - TinderboxPrint: I/O write bytes / time
330,530,816 / 1,757,868 13:49:45 INFO - TinderboxPrint: CPU idle
8,299.7 (86.5%) 13:49:45 INFO - TinderboxPrint: CPU user
1,195.5 (12.5%) 13:49:45 INFO - TinderboxPrint: Swap in / out
0 / 0 13:49:45 INFO - install - Wall time: 21s; CPU: 14.0%; Read bytes: 0; Write bytes: 79765504; Read time: 0; Write time: 347684 13:49:45 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 262144; Write bytes: 250765312; Read time: 32; Write time: 1410184 13:49:45 INFO - Running post-run listener: _upload_blobber_files 13:49:45 INFO - Blob upload gear active. 13:49:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:49:45 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 13:49:45 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'] 13:49:45 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 13:49:46 INFO - (blobuploader) - INFO - Open directory for files ... 13:49:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:49:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:49:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:49:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:49:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:49:50 INFO - (blobuploader) - INFO - Done attempting. 13:49:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:49:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:49:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:49:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:49:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:49:51 INFO - (blobuploader) - INFO - Done attempting. 13:49:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:49:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:49:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:49:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:49:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:49:52 INFO - (blobuploader) - INFO - Done attempting. 13:49:52 INFO - (blobuploader) - INFO - Iteration through files over. 13:49:52 INFO - Return code: 0 13:49:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:49:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:49:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/113b23286664c4ba0382d9e7509d81fc1c255155cb9c82da83e9fc28592935bf2f706d3f5c2958cd7f2abadc8e94df2cf98a1b539911b040a04eabbe9cfd02c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/670f3c8c2c97554d3745c2d26326123aa3a301633ea1fe9468516c01d95517a14f30aea745cd01fc116aebfe416e481060843f2fcef147274041da33e4d12fac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb1ff247e3e84e2901264246f5b711c8c26e1bd213680191dcf6564c81a0aeee1d561f1df849a73d0bc8e3685e313e93fe40027c55209eb572cc36d808a7a690"} 13:49:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:49:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:49:52 INFO - Contents: 13:49:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/113b23286664c4ba0382d9e7509d81fc1c255155cb9c82da83e9fc28592935bf2f706d3f5c2958cd7f2abadc8e94df2cf98a1b539911b040a04eabbe9cfd02c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/670f3c8c2c97554d3745c2d26326123aa3a301633ea1fe9468516c01d95517a14f30aea745cd01fc116aebfe416e481060843f2fcef147274041da33e4d12fac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb1ff247e3e84e2901264246f5b711c8c26e1bd213680191dcf6564c81a0aeee1d561f1df849a73d0bc8e3685e313e93fe40027c55209eb572cc36d808a7a690"} 13:49:52 INFO - Running post-run listener: copy_logs_to_upload_dir 13:49:52 INFO - Copying logs to upload dir... 13:49:52 INFO - mkdir: /builds/slave/test/build/upload/logs 13:49:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1693.414478 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 13 secs) (at 2016-08-10 13:49:52.075329) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 13:49:52.078587) ========= 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=33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169 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/113b23286664c4ba0382d9e7509d81fc1c255155cb9c82da83e9fc28592935bf2f706d3f5c2958cd7f2abadc8e94df2cf98a1b539911b040a04eabbe9cfd02c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/670f3c8c2c97554d3745c2d26326123aa3a301633ea1fe9468516c01d95517a14f30aea745cd01fc116aebfe416e481060843f2fcef147274041da33e4d12fac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb1ff247e3e84e2901264246f5b711c8c26e1bd213680191dcf6564c81a0aeee1d561f1df849a73d0bc8e3685e313e93fe40027c55209eb572cc36d808a7a690"} build_url:https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/Py85bT1pTG6mykdB315W-g/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/113b23286664c4ba0382d9e7509d81fc1c255155cb9c82da83e9fc28592935bf2f706d3f5c2958cd7f2abadc8e94df2cf98a1b539911b040a04eabbe9cfd02c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/670f3c8c2c97554d3745c2d26326123aa3a301633ea1fe9468516c01d95517a14f30aea745cd01fc116aebfe416e481060843f2fcef147274041da33e4d12fac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb1ff247e3e84e2901264246f5b711c8c26e1bd213680191dcf6564c81a0aeee1d561f1df849a73d0bc8e3685e313e93fe40027c55209eb572cc36d808a7a690"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 13:49:52.103331) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 13:49:52.103630) ========= 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=33d5923976266a1c518c4bf7000001ab-1470860417.682172-632141169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 13:49:52.186066) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 13:49:52.186398) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 13:49:52.186706) ========= ========= Total master_lag: 0.18 =========