builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1471953651.09 results: success (0) buildid: 20160823021946 builduid: 02ccb8740a0b4837bb0ec955db62c1e6 revision: 36fd886d42c158fb2c613681c938960dfccda74b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 05:00:51.092973) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 05:00:51.093598) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 05:00:51.093886) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 05:00:51.213079) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 05:00:51.213394) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 05:00:51-- 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% 43.1M=0s 2016-08-23 05:00:51 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.194554 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 05:00:51.465551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 05:00:51.466114) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020647 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 05:00:51.516224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 05:00:51.516621) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 36fd886d42c158fb2c613681c938960dfccda74b --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 36fd886d42c158fb2c613681c938960dfccda74b --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=5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 05:00:51,588 truncating revision to first 12 chars 2016-08-23 05:00:51,588 Setting DEBUG logging. 2016-08-23 05:00:51,588 attempt 1/10 2016-08-23 05:00:51,588 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/36fd886d42c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 05:00:51,851 unpacking tar archive at: mozilla-aurora-36fd886d42c1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559794 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 05:00:52.090101) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 05:00:52.090502) ========= script_repo_revision: 36fd886d42c158fb2c613681c938960dfccda74b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 05:00:52.090955) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 05:00:52.091296) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 05:00:52.101505) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 4 secs) (at 2016-08-23 05:00:52.101915) ========= /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=5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:00:52 INFO - MultiFileLogger online at 20160823 05:00:52 in /builds/slave/test 05:00:52 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 05:00:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:00:52 INFO - {'append_to_log': False, 05:00:52 INFO - 'base_work_dir': '/builds/slave/test', 05:00:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:00:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:00:52 INFO - 'branch': 'Mozilla-Aurora', 05:00:52 INFO - 'buildbot_json_path': 'buildprops.json', 05:00:52 INFO - 'config_files': ('talos/linux_config.py',), 05:00:52 INFO - 'default_actions': ('clobber', 05:00:52 INFO - 'read-buildbot-config', 05:00:52 INFO - 'download-and-extract', 05:00:52 INFO - 'populate-webroot', 05:00:52 INFO - 'create-virtualenv', 05:00:52 INFO - 'install', 05:00:52 INFO - 'run-tests'), 05:00:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:00:52 INFO - 'download_minidump_stackwalk': True, 05:00:52 INFO - 'download_symbols': 'ondemand', 05:00:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:00:52 INFO - 'tooltool.py': '/tools/tooltool.py', 05:00:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:00:52 INFO - '/tools/misc-python/virtualenv.py')}, 05:00:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:00:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:00:52 INFO - 'installer_path': 'installer.exe', 05:00:52 INFO - 'log_level': 'info', 05:00:52 INFO - 'log_name': 'talos', 05:00:52 INFO - 'log_to_console': True, 05:00:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:00:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:00:52 INFO - 'opt_config_files': (), 05:00:52 INFO - 'pip_index': False, 05:00:52 INFO - 'sps_profile': False, 05:00:52 INFO - 'sps_profile_interval': 0, 05:00:52 INFO - 'suite': 'dromaeojs-e10s', 05:00:52 INFO - 'system_bits': '32', 05:00:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:00:52 INFO - 'title': 'talos-linux64-ix-011', 05:00:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:00:52 INFO - 'use_talos_json': True, 05:00:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:00:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:00:52 INFO - 'work_dir': 'build'} 05:00:52 INFO - [mozharness: 2016-08-23 12:00:52.381693Z] Running clobber step. 05:00:52 INFO - Running pre-action listener: _resource_record_pre_action 05:00:52 INFO - Running main action method: clobber 05:00:52 INFO - rmtree: /builds/slave/test/build 05:00:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:00:52 INFO - Running post-action listener: _resource_record_post_action 05:00:52 INFO - [mozharness: 2016-08-23 12:00:52.795234Z] Finished clobber step (success) 05:00:52 INFO - [mozharness: 2016-08-23 12:00:52.795334Z] Running read-buildbot-config step. 05:00:52 INFO - Running pre-action listener: _resource_record_pre_action 05:00:52 INFO - Running main action method: read_buildbot_config 05:00:52 INFO - Using buildbot properties: 05:00:52 INFO - { 05:00:52 INFO - "project": "", 05:00:52 INFO - "product": "firefox", 05:00:52 INFO - "script_repo_revision": "production", 05:00:52 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:00:52 INFO - "repository": "", 05:00:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:00:52 INFO - "buildid": "20160823021946", 05:00:52 INFO - "pgo_build": "True", 05:00:52 INFO - "basedir": "/builds/slave/test", 05:00:52 INFO - "buildnumber": 502, 05:00:52 INFO - "slavename": "talos-linux64-ix-011", 05:00:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:00:52 INFO - "platform": "ubuntu64_hw", 05:00:52 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:00:52 INFO - "branch": "mozilla-aurora", 05:00:52 INFO - "repo_path": "releases/mozilla-aurora", 05:00:52 INFO - "revision": "36fd886d42c158fb2c613681c938960dfccda74b", 05:00:52 INFO - "stage_platform": "linux64-pgo", 05:00:52 INFO - "builduid": "02ccb8740a0b4837bb0ec955db62c1e6", 05:00:52 INFO - "slavebuilddir": "test" 05:00:52 INFO - } 05:00:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 05:00:52 INFO - Running post-action listener: _resource_record_post_action 05:00:52 INFO - [mozharness: 2016-08-23 12:00:52.797790Z] Finished read-buildbot-config step (success) 05:00:52 INFO - [mozharness: 2016-08-23 12:00:52.797877Z] Running download-and-extract step. 05:00:52 INFO - Running pre-action listener: _resource_record_pre_action 05:00:52 INFO - Running main action method: download_and_extract 05:00:52 INFO - mkdir: /builds/slave/test/build/tests 05:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:52 INFO - https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:00:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 05:00:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 05:00:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:00:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:00:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 05:00:52 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:00:52 INFO - retry: Failed, sleeping 30 seconds before retrying 05:01:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:01:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 05:01:22 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:01:22 INFO - retry: Failed, sleeping 60 seconds before retrying 05:02:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:02:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 05:02:22 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:02:22 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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! 05:02:22 INFO - Caught exception: HTTP Error 404: Not Found 05:02:22 INFO - Caught exception: HTTP Error 404: Not Found 05:02:22 INFO - Caught exception: HTTP Error 404: Not Found 05:02:22 INFO - trying https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 05:02:22 INFO - Downloading https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:02:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:02:23 INFO - Downloaded 1361 bytes. 05:02:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 05:02:23 INFO - Using the following test package requirements: 05:02:23 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 05:02:23 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 05:02:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:02:23 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 05:02:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:02:23 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 05:02:23 INFO - u'jsshell-linux-x86_64.zip'], 05:02:23 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 05:02:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:02:23 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 05:02:23 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 05:02:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:02:23 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 05:02:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:02:23 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 05:02:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:02:23 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 05:02:23 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:02:23 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:02: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')]} 05:02:23 INFO - https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:02:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:02:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:02:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:02:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:02:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:02:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:02:23 INFO - retry: Failed, sleeping 30 seconds before retrying 05:02:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:02:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:02:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:02:53 INFO - retry: Failed, sleeping 60 seconds before retrying 05:03:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:03:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:03:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:03:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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! 05:03:53 INFO - Caught exception: HTTP Error 404: Not Found 05:03:53 INFO - Caught exception: HTTP Error 404: Not Found 05:03:53 INFO - Caught exception: HTTP Error 404: Not Found 05:03:53 INFO - trying https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:03:53 INFO - Downloading https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:03:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:03:54 INFO - Downloaded 21768541 bytes. 05:03:54 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'] 05:03:54 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 05:03:55 INFO - Return code: 0 05:03:55 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 05:03:55 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')]} 05:03:55 INFO - https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:03:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:03:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:03:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:03:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:03:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:03:55 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:03:55 INFO - retry: Failed, sleeping 30 seconds before retrying 05:04:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:04:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:04:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:04:25 INFO - retry: Failed, sleeping 60 seconds before retrying 05:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:05:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:05:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:05:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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! 05:05:25 INFO - Caught exception: HTTP Error 404: Not Found 05:05:25 INFO - Caught exception: HTTP Error 404: Not Found 05:05:25 INFO - Caught exception: HTTP Error 404: Not Found 05:05:25 INFO - trying https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 05:05:25 INFO - Downloading https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:05:26 INFO - Downloaded 21768541 bytes. 05:05:26 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'] 05:05:26 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 05:05:28 INFO - Return code: 0 05:05: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')]} 05:05:28 INFO - https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:05:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 05:05:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 05:05:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:05:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:05:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 05:05:28 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:05:28 INFO - retry: Failed, sleeping 30 seconds before retrying 05:05:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:05:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 05:05:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:05:58 INFO - retry: Failed, sleeping 60 seconds before retrying 05:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:06:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 05:06:58 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:06:58 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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! 05:06:58 INFO - Caught exception: HTTP Error 404: Not Found 05:06:58 INFO - Caught exception: HTTP Error 404: Not Found 05:06:58 INFO - Caught exception: HTTP Error 404: Not Found 05:06:58 INFO - trying https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 05:06:58 INFO - Downloading https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:06:59 INFO - Downloaded 14413723 bytes. 05:06:59 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'] 05:06:59 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 05:06:59 INFO - Return code: 0 05:06:59 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')]} 05:06:59 INFO - https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:06:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 05:06:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 05:06:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:06:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:06:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 05:06:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:06:59 INFO - retry: Failed, sleeping 30 seconds before retrying 05:07:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:07:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 05:07:29 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:07:29 INFO - retry: Failed, sleeping 60 seconds before retrying 05:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:08:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 05:08:29 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:08:29 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UU5ud5VcTOCVkr1af8EoRw/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! 05:08:29 INFO - Caught exception: HTTP Error 404: Not Found 05:08:29 INFO - Caught exception: HTTP Error 404: Not Found 05:08:29 INFO - Caught exception: HTTP Error 404: Not Found 05:08:29 INFO - trying https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 05:08:29 INFO - Downloading https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/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 05:08:31 INFO - Downloaded 63737437 bytes. 05:08:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 05:08:31 INFO - mkdir: /builds/slave/test/properties 05:08:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:08:31 INFO - Writing to file /builds/slave/test/properties/build_url 05:08:31 INFO - Contents: 05:08:31 INFO - build_url:https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 05:08:32 INFO - Running post-action listener: _resource_record_post_action 05:08:32 INFO - Running post-action listener: set_extra_try_arguments 05:08:32 INFO - [mozharness: 2016-08-23 12:08:32.220350Z] Finished download-and-extract step (success) 05:08:32 INFO - [mozharness: 2016-08-23 12:08:32.220583Z] Running populate-webroot step. 05:08:32 INFO - Running pre-action listener: _resource_record_pre_action 05:08:32 INFO - Running main action method: populate_webroot 05:08:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:08:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:08:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:08:32 INFO - '--tppagecycles', 05:08:32 INFO - '7'], 05:08:32 INFO - 'tests': ['tsvgm']}}, 05:08:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:08:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:08:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:08:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:08:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:08:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:08:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:32 INFO - 'talos_options': ['--disable-e10s'], 05:08:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:32 INFO - 'talos_options': ['--disable-e10s'], 05:08:32 INFO - 'tests': ['damp', 'tps']}, 05:08:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:32 INFO - 'tests': ['damp', 'tps']}, 05:08:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:08:32 INFO - 'tests': ['dromaeo_dom']}, 05:08:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:08:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:08:32 INFO - 'tests': ['basic_compositor_video']}, 05:08:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:08:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:08:32 INFO - 'tests': ['a11yr', 05:08:32 INFO - 'ts_paint', 05:08:32 INFO - 'tpaint', 05:08:32 INFO - 'sessionrestore', 05:08:32 INFO - 'sessionrestore_no_auto_restore', 05:08:32 INFO - 'tabpaint']}, 05:08:32 INFO - 'other-e10s': {'tests': ['a11yr', 05:08:32 INFO - 'ts_paint', 05:08:32 INFO - 'tpaint', 05:08:32 INFO - 'sessionrestore', 05:08:32 INFO - 'sessionrestore_no_auto_restore', 05:08:32 INFO - 'tabpaint']}, 05:08:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:08:32 INFO - 'ts_paint', 05:08:32 INFO - 'tpaint', 05:08:32 INFO - 'sessionrestore', 05:08:32 INFO - 'sessionrestore_no_auto_restore', 05:08:32 INFO - 'tabpaint']}, 05:08:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:08:32 INFO - 'ts_paint', 05:08:32 INFO - 'tpaint', 05:08:32 INFO - 'sessionrestore', 05:08:32 INFO - 'sessionrestore_no_auto_restore', 05:08:32 INFO - 'tabpaint']}, 05:08:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:08:32 INFO - 'tests': ['a11yr', 05:08:32 INFO - 'ts_paint', 05:08:32 INFO - 'tpaint', 05:08:32 INFO - 'sessionrestore', 05:08:32 INFO - 'sessionrestore_no_auto_restore', 05:08:32 INFO - 'tabpaint']}, 05:08:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:08:32 INFO - 'tests': ['a11yr', 05:08:32 INFO - 'ts_paint', 05:08:32 INFO - 'tpaint', 05:08:32 INFO - 'sessionrestore', 05:08:32 INFO - 'sessionrestore_no_auto_restore', 05:08:32 INFO - 'tabpaint']}, 05:08:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:08:32 INFO - 'tests': ['tsvgx', 05:08:32 INFO - 'tsvgr_opacity', 05:08:32 INFO - 'tart', 05:08:32 INFO - 'tscrollx', 05:08:32 INFO - 'cart']}, 05:08:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:08:32 INFO - 'tsvgr_opacity', 05:08:32 INFO - 'tart', 05:08:32 INFO - 'tscrollx', 05:08:32 INFO - 'cart']}, 05:08:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:32 INFO - 'talos_options': ['--disable-e10s'], 05:08:32 INFO - 'tests': ['tp5o']}, 05:08:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:32 INFO - 'tests': ['tp5o']}, 05:08:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:32 INFO - 'talos_options': ['--disable-e10s', 05:08:32 INFO - '--xperf_path', 05:08:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:32 INFO - 'tests': ['tp5n']}, 05:08:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:32 INFO - 'talos_options': ['--xperf_path', 05:08:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:32 INFO - 'tests': ['tp5n']}}, 05:08:32 INFO - 'talos.zip': {'path': '', 05:08:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:08:32 INFO - Running post-action listener: _resource_record_post_action 05:08:32 INFO - [mozharness: 2016-08-23 12:08:32.241918Z] Finished populate-webroot step (success) 05:08:32 INFO - [mozharness: 2016-08-23 12:08:32.242006Z] Running create-virtualenv step. 05:08:32 INFO - Running pre-action listener: _resource_record_pre_action 05:08:32 INFO - Running main action method: create_virtualenv 05:08:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:08:32 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 05:08:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:08:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:08:32 INFO - Using real prefix '/usr' 05:08:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:08:33 INFO - Installing distribute.............................................................................................................................................................................................done. 05:08:34 INFO - Installing pip.................done. 05:08:34 INFO - Return code: 0 05:08:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf36400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5570>, '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 0xfc6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', '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 05:08:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:08:34 INFO - Using env: {'DISPLAY': ':0', 05:08:34 INFO - 'HOME': '/home/cltbld', 05:08:34 INFO - 'LANG': 'en_US.UTF-8', 05:08:34 INFO - 'LANGUAGE': 'en_US:en', 05:08:34 INFO - 'LOGNAME': 'cltbld', 05:08:34 INFO - 'MAIL': '/var/mail/cltbld', 05:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:34 INFO - 'MOZ_NO_REMOTE': '1', 05:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:34 INFO - 'NO_EM_RESTART': '1', 05:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:34 INFO - 'PWD': '/builds/slave/test', 05:08:34 INFO - 'SHELL': '/bin/bash', 05:08:34 INFO - 'SHLVL': '1', 05:08:34 INFO - 'TERM': 'linux', 05:08:34 INFO - 'TMOUT': '86400', 05:08:34 INFO - 'USER': 'cltbld', 05:08:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', 05:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:34 INFO - '_': '/tools/buildbot/bin/python'} 05:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:35 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 05:08:35 INFO - Cleaning up... 05:08:35 INFO - Return code: 0 05:08:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:08:35 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')]} 05:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:35 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')]} 05:08:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:35 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 0xd07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf36400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5570>, '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 0xfc6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', '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 05:08:35 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 05:08:35 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 05:08:35 INFO - Using env: {'DISPLAY': ':0', 05:08:35 INFO - 'HOME': '/home/cltbld', 05:08:35 INFO - 'LANG': 'en_US.UTF-8', 05:08:35 INFO - 'LANGUAGE': 'en_US:en', 05:08:35 INFO - 'LOGNAME': 'cltbld', 05:08:35 INFO - 'MAIL': '/var/mail/cltbld', 05:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:35 INFO - 'MOZ_NO_REMOTE': '1', 05:08:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:35 INFO - 'NO_EM_RESTART': '1', 05:08:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:35 INFO - 'PWD': '/builds/slave/test', 05:08:35 INFO - 'SHELL': '/bin/bash', 05:08:35 INFO - 'SHLVL': '1', 05:08:35 INFO - 'TERM': 'linux', 05:08:35 INFO - 'TMOUT': '86400', 05:08:35 INFO - 'USER': 'cltbld', 05:08:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', 05:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:35 INFO - '_': '/tools/buildbot/bin/python'} 05:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:35 INFO - Downloading/unpacking psutil>=3.1.1 05:08:35 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 05:08:35 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 05:08:35 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 05:08:35 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 05:08:35 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 05:08:35 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 05:08:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:08:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:37 INFO - Installing collected packages: psutil 05:08:37 INFO - Running setup.py install for psutil 05:08:37 INFO - building 'psutil._psutil_linux' extension 05:08:37 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 05:08:38 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 05:08:38 INFO - building 'psutil._psutil_posix' extension 05:08:38 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 05:08:39 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 05:08:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:39 INFO - Successfully installed psutil 05:08:39 INFO - Cleaning up... 05:08:39 INFO - Return code: 0 05:08:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:39 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 0xd07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf36400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5570>, '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 0xfc6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', '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 05:08:39 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 05:08:39 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 05:08:39 INFO - Using env: {'DISPLAY': ':0', 05:08:39 INFO - 'HOME': '/home/cltbld', 05:08:39 INFO - 'LANG': 'en_US.UTF-8', 05:08:39 INFO - 'LANGUAGE': 'en_US:en', 05:08:39 INFO - 'LOGNAME': 'cltbld', 05:08:39 INFO - 'MAIL': '/var/mail/cltbld', 05:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:39 INFO - 'MOZ_NO_REMOTE': '1', 05:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:39 INFO - 'NO_EM_RESTART': '1', 05:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:39 INFO - 'PWD': '/builds/slave/test', 05:08:39 INFO - 'SHELL': '/bin/bash', 05:08:39 INFO - 'SHLVL': '1', 05:08:39 INFO - 'TERM': 'linux', 05:08:39 INFO - 'TMOUT': '86400', 05:08:39 INFO - 'USER': 'cltbld', 05:08:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', 05:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:39 INFO - '_': '/tools/buildbot/bin/python'} 05:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:08:41 INFO - Installing collected packages: mozsystemmonitor 05:08:41 INFO - Running setup.py install for mozsystemmonitor 05:08:41 INFO - Successfully installed mozsystemmonitor 05:08:41 INFO - Cleaning up... 05:08:41 INFO - Return code: 0 05:08:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:41 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 0xd07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf36400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5570>, '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 0xfc6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', '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 05:08:41 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 05:08:41 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 05:08:41 INFO - Using env: {'DISPLAY': ':0', 05:08:41 INFO - 'HOME': '/home/cltbld', 05:08:41 INFO - 'LANG': 'en_US.UTF-8', 05:08:41 INFO - 'LANGUAGE': 'en_US:en', 05:08:41 INFO - 'LOGNAME': 'cltbld', 05:08:41 INFO - 'MAIL': '/var/mail/cltbld', 05:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:41 INFO - 'MOZ_NO_REMOTE': '1', 05:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:41 INFO - 'NO_EM_RESTART': '1', 05:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:41 INFO - 'PWD': '/builds/slave/test', 05:08:41 INFO - 'SHELL': '/bin/bash', 05:08:41 INFO - 'SHLVL': '1', 05:08:41 INFO - 'TERM': 'linux', 05:08:41 INFO - 'TMOUT': '86400', 05:08:41 INFO - 'USER': 'cltbld', 05:08:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', 05:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:41 INFO - '_': '/tools/buildbot/bin/python'} 05:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:41 INFO - Downloading/unpacking jsonschema==2.5.1 05:08:41 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 05:08:41 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 05:08:41 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 05:08:41 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 05:08:41 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 05:08:41 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 05:08:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:08:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:08:43 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 05:08:43 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 05:08:43 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 05:08:43 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 05:08:43 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 05:08:43 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 05:08:43 INFO - Downloading functools32-3.2.3-2.tar.gz 05:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:08:43 INFO - warning: no files found matching '*.txt' 05:08:43 INFO - no previously-included directories found matching 'build' 05:08:43 INFO - no previously-included directories found matching 'dist' 05:08:43 INFO - no previously-included directories found matching '.git*' 05:08:43 INFO - Installing collected packages: jsonschema, functools32 05:08:43 INFO - Running setup.py install for functools32 05:08:43 INFO - warning: no files found matching '*.txt' 05:08:43 INFO - no previously-included directories found matching 'build' 05:08:43 INFO - no previously-included directories found matching 'dist' 05:08:43 INFO - no previously-included directories found matching '.git*' 05:08:44 INFO - Successfully installed jsonschema functools32 05:08:44 INFO - Cleaning up... 05:08:44 INFO - Return code: 0 05:08:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:08:44 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')]} 05:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:44 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')]} 05:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:44 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 0xd07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf36400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5570>, '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 0xfc6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', '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 05:08:44 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 05:08:44 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 05:08:44 INFO - Using env: {'DISPLAY': ':0', 05:08:44 INFO - 'HOME': '/home/cltbld', 05:08:44 INFO - 'LANG': 'en_US.UTF-8', 05:08:44 INFO - 'LANGUAGE': 'en_US:en', 05:08:44 INFO - 'LOGNAME': 'cltbld', 05:08:44 INFO - 'MAIL': '/var/mail/cltbld', 05:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:44 INFO - 'MOZ_NO_REMOTE': '1', 05:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:44 INFO - 'NO_EM_RESTART': '1', 05:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:44 INFO - 'PWD': '/builds/slave/test', 05:08:44 INFO - 'SHELL': '/bin/bash', 05:08:44 INFO - 'SHLVL': '1', 05:08:44 INFO - 'TERM': 'linux', 05:08:44 INFO - 'TMOUT': '86400', 05:08:44 INFO - 'USER': 'cltbld', 05:08:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', 05:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:44 INFO - '_': '/tools/buildbot/bin/python'} 05:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:08:44 INFO - Cleaning up... 05:08:44 INFO - Return code: 0 05:08:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:08:44 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')]} 05:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:44 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')]} 05:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:44 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 0xd07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf36400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5570>, '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 0xfc6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', '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 05:08:44 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 05:08:44 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 05:08:44 INFO - Using env: {'DISPLAY': ':0', 05:08:44 INFO - 'HOME': '/home/cltbld', 05:08:44 INFO - 'LANG': 'en_US.UTF-8', 05:08:44 INFO - 'LANGUAGE': 'en_US:en', 05:08:44 INFO - 'LOGNAME': 'cltbld', 05:08:44 INFO - 'MAIL': '/var/mail/cltbld', 05:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:44 INFO - 'MOZ_NO_REMOTE': '1', 05:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:44 INFO - 'NO_EM_RESTART': '1', 05:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:44 INFO - 'PWD': '/builds/slave/test', 05:08:44 INFO - 'SHELL': '/bin/bash', 05:08:44 INFO - 'SHLVL': '1', 05:08:44 INFO - 'TERM': 'linux', 05:08:44 INFO - 'TMOUT': '86400', 05:08:44 INFO - 'USER': 'cltbld', 05:08:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', 05:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:44 INFO - '_': '/tools/buildbot/bin/python'} 05:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:44 INFO - Downloading/unpacking blobuploader==1.2.4 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:46 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08:46 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 05:08:46 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 05:08:46 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 05:08:46 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 05:08:46 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 05:08:46 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 05:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:08:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08:46 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 05:08:46 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 05:08:46 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 05:08:46 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 05:08:46 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 05:08:46 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 05:08:47 INFO - Downloading docopt-0.6.1.tar.gz 05:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:47 INFO - Running setup.py install for blobuploader 05:08:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:08:47 INFO - Running setup.py install for requests 05:08:47 INFO - Running setup.py install for docopt 05:08:47 INFO - Successfully installed blobuploader requests docopt 05:08:47 INFO - Cleaning up... 05:08:47 INFO - Return code: 0 05:08:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:47 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')]} 05:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:47 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')]} 05:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:47 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 0xd07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf36400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5570>, '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 0xfc6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', '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 05:08:47 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 05:08:47 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 05:08:47 INFO - Using env: {'DISPLAY': ':0', 05:08:47 INFO - 'HOME': '/home/cltbld', 05:08:47 INFO - 'LANG': 'en_US.UTF-8', 05:08:47 INFO - 'LANGUAGE': 'en_US:en', 05:08:47 INFO - 'LOGNAME': 'cltbld', 05:08:47 INFO - 'MAIL': '/var/mail/cltbld', 05:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:47 INFO - 'MOZ_NO_REMOTE': '1', 05:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:47 INFO - 'NO_EM_RESTART': '1', 05:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:47 INFO - 'PWD': '/builds/slave/test', 05:08:47 INFO - 'SHELL': '/bin/bash', 05:08:47 INFO - 'SHLVL': '1', 05:08:47 INFO - 'TERM': 'linux', 05:08:47 INFO - 'TMOUT': '86400', 05:08:47 INFO - 'USER': 'cltbld', 05:08:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', 05:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:47 INFO - '_': '/tools/buildbot/bin/python'} 05:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:47 INFO - Running setup.py (path:/tmp/pip-G_BdoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:48 INFO - Running setup.py (path:/tmp/pip-twqXU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:48 INFO - Running setup.py (path:/tmp/pip-po6Ibc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:48 INFO - Running setup.py (path:/tmp/pip-WS2UxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:48 INFO - Running setup.py (path:/tmp/pip-nr_8nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:48 INFO - Running setup.py (path:/tmp/pip-sQwf7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:48 INFO - Running setup.py (path:/tmp/pip-Q2kp7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:48 INFO - Running setup.py (path:/tmp/pip-dYzH3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:48 INFO - Running setup.py (path:/tmp/pip-vAW2RD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:48 INFO - Running setup.py (path:/tmp/pip-DiAWNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:48 INFO - Running setup.py (path:/tmp/pip-_9PMig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:48 INFO - Running setup.py (path:/tmp/pip-WaLD1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:48 INFO - Running setup.py (path:/tmp/pip-7Jjfrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:48 INFO - Running setup.py (path:/tmp/pip-CBQWy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:48 INFO - Running setup.py (path:/tmp/pip-AgZOdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:49 INFO - Running setup.py (path:/tmp/pip-N2Us7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:49 INFO - Running setup.py (path:/tmp/pip-qwBXba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:49 INFO - Running setup.py install for manifestparser 05:08:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:49 INFO - Running setup.py install for mozcrash 05:08:49 INFO - Running setup.py install for mozdebug 05:08:49 INFO - Running setup.py install for mozdevice 05:08:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:08:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:49 INFO - Running setup.py install for mozfile 05:08:49 INFO - Running setup.py install for mozhttpd 05:08:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:49 INFO - Running setup.py install for mozinfo 05:08:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:49 INFO - Running setup.py install for mozInstall 05:08:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Running setup.py install for mozleak 05:08:50 INFO - Running setup.py install for mozlog 05:08:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Running setup.py install for moznetwork 05:08:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Running setup.py install for mozprocess 05:08:50 INFO - Running setup.py install for mozprofile 05:08:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Running setup.py install for mozrunner 05:08:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Running setup.py install for mozscreenshot 05:08:50 INFO - Running setup.py install for moztest 05:08:50 INFO - Running setup.py install for mozversion 05:08:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:50 INFO - Cleaning up... 05:08:51 INFO - Return code: 0 05:08:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:51 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 0xd07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf36400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5570>, '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 0xfc6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', '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 05:08:51 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 05:08:51 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 05:08:51 INFO - Using env: {'DISPLAY': ':0', 05:08:51 INFO - 'HOME': '/home/cltbld', 05:08:51 INFO - 'LANG': 'en_US.UTF-8', 05:08:51 INFO - 'LANGUAGE': 'en_US:en', 05:08:51 INFO - 'LOGNAME': 'cltbld', 05:08:51 INFO - 'MAIL': '/var/mail/cltbld', 05:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:51 INFO - 'MOZ_NO_REMOTE': '1', 05:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:51 INFO - 'NO_EM_RESTART': '1', 05:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:51 INFO - 'PWD': '/builds/slave/test', 05:08:51 INFO - 'SHELL': '/bin/bash', 05:08:51 INFO - 'SHLVL': '1', 05:08:51 INFO - 'TERM': 'linux', 05:08:51 INFO - 'TMOUT': '86400', 05:08:51 INFO - 'USER': 'cltbld', 05:08:51 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', 05:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:51 INFO - '_': '/tools/buildbot/bin/python'} 05:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:51 INFO - Running setup.py (path:/tmp/pip-XEZClq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:51 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)) 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:51 INFO - Running setup.py (path:/tmp/pip-eLgphu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:51 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)) 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:51 INFO - Running setup.py (path:/tmp/pip-zbSMxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:51 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)) 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:51 INFO - Running setup.py (path:/tmp/pip-C2K2b9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:51 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)) 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:51 INFO - Running setup.py (path:/tmp/pip-83gsv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:51 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)) 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:51 INFO - Running setup.py (path:/tmp/pip-iJP0nT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:51 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)) 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:51 INFO - Running setup.py (path:/tmp/pip-Ok8xkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:51 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)) 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:51 INFO - Running setup.py (path:/tmp/pip-9lJOiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:51 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)) 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:51 INFO - Running setup.py (path:/tmp/pip-WkdvPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:51 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)) 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:51 INFO - Running setup.py (path:/tmp/pip-ARQZe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:51 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)) 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:51 INFO - Running setup.py (path:/tmp/pip-ytxcd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:51 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)) 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:52 INFO - Running setup.py (path:/tmp/pip-H_3BH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:52 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)) 05:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:52 INFO - Running setup.py (path:/tmp/pip-Bfpr0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:52 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)) 05:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:52 INFO - Running setup.py (path:/tmp/pip-5_SbrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:52 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)) 05:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:52 INFO - Running setup.py (path:/tmp/pip-Q6gjxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:52 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)) 05:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:52 INFO - Running setup.py (path:/tmp/pip-jFJCsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:52 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)) 05:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:52 INFO - Running setup.py (path:/tmp/pip-If3Ysp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:52 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)) 05:08:52 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)) 05:08:52 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)) 05:08:52 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)) 05:08:52 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)) 05:08:52 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)) 05:08:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:52 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 05:08:52 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 05:08:52 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 05:08:52 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 05:08:52 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 05:08:52 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 05:08:54 INFO - Downloading blessings-1.6.tar.gz 05:08:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:54 INFO - Installing collected packages: blessings 05:08:54 INFO - Running setup.py install for blessings 05:08:54 INFO - Successfully installed blessings 05:08:54 INFO - Cleaning up... 05:08:54 INFO - Return code: 0 05:08:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:54 INFO - Reading from file tmpfile_stdout 05:08:54 INFO - Current package versions: 05:08:54 INFO - argparse == 1.2.1 05:08:54 INFO - blessings == 1.6 05:08:54 INFO - blobuploader == 1.2.4 05:08:54 INFO - docopt == 0.6.1 05:08:54 INFO - functools32 == 3.2.3-2 05:08:54 INFO - jsonschema == 2.5.1 05:08:54 INFO - manifestparser == 1.1 05:08:54 INFO - mozInstall == 1.12 05:08:54 INFO - mozcrash == 0.17 05:08:54 INFO - mozdebug == 0.1 05:08:54 INFO - mozdevice == 0.48 05:08:54 INFO - mozfile == 1.2 05:08:54 INFO - mozhttpd == 0.7 05:08:54 INFO - mozinfo == 0.9 05:08:54 INFO - mozleak == 0.1 05:08:54 INFO - mozlog == 3.3 05:08:54 INFO - moznetwork == 0.27 05:08:54 INFO - mozprocess == 0.23 05:08:54 INFO - mozprofile == 0.28 05:08:54 INFO - mozrunner == 6.12 05:08:54 INFO - mozscreenshot == 0.1 05:08:54 INFO - mozsystemmonitor == 0.3 05:08:54 INFO - moztest == 0.7 05:08:54 INFO - mozversion == 1.4 05:08:54 INFO - psutil == 3.1.1 05:08:54 INFO - requests == 1.2.3 05:08:54 INFO - wsgiref == 0.1.2 05:08:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:54 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')]} 05:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:54 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')]} 05:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:54 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 0xd07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf36400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5570>, '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 0xfc6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', '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 05:08:54 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 05:08:54 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 05:08:54 INFO - Using env: {'DISPLAY': ':0', 05:08:54 INFO - 'HOME': '/home/cltbld', 05:08:54 INFO - 'LANG': 'en_US.UTF-8', 05:08:54 INFO - 'LANGUAGE': 'en_US:en', 05:08:54 INFO - 'LOGNAME': 'cltbld', 05:08:54 INFO - 'MAIL': '/var/mail/cltbld', 05:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:54 INFO - 'MOZ_NO_REMOTE': '1', 05:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:54 INFO - 'NO_EM_RESTART': '1', 05:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:54 INFO - 'PWD': '/builds/slave/test', 05:08:54 INFO - 'SHELL': '/bin/bash', 05:08:54 INFO - 'SHLVL': '1', 05:08:54 INFO - 'TERM': 'linux', 05:08:54 INFO - 'TMOUT': '86400', 05:08:54 INFO - 'USER': 'cltbld', 05:08:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', 05:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:54 INFO - '_': '/tools/buildbot/bin/python'} 05:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:55 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)) 05:08:55 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)) 05:08:55 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)) 05:08:55 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)) 05:08:55 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)) 05:08:55 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)) 05:08:55 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)) 05:08:55 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)) 05:08:55 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)) 05:08:55 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)) 05:08:55 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)) 05:08:55 INFO - Cleaning up... 05:08:55 INFO - Return code: 0 05:08:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08:55 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')]} 05:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:55 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')]} 05:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:55 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 0xd07030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf36400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc5570>, '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 0xfc6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6900>, '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': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', '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 05:08:55 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 05:08:55 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 05:08:55 INFO - Using env: {'DISPLAY': ':0', 05:08:55 INFO - 'HOME': '/home/cltbld', 05:08:55 INFO - 'LANG': 'en_US.UTF-8', 05:08:55 INFO - 'LANGUAGE': 'en_US:en', 05:08:55 INFO - 'LOGNAME': 'cltbld', 05:08:55 INFO - 'MAIL': '/var/mail/cltbld', 05:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:55 INFO - 'MOZ_NO_REMOTE': '1', 05:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:55 INFO - 'NO_EM_RESTART': '1', 05:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:55 INFO - 'PWD': '/builds/slave/test', 05:08:55 INFO - 'SHELL': '/bin/bash', 05:08:55 INFO - 'SHLVL': '1', 05:08:55 INFO - 'TERM': 'linux', 05:08:55 INFO - 'TMOUT': '86400', 05:08:55 INFO - 'USER': 'cltbld', 05:08:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', 05:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:55 INFO - '_': '/tools/buildbot/bin/python'} 05:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:08:55 INFO - Cleaning up... 05:08:55 INFO - Return code: 0 05:08:55 INFO - Running post-action listener: _resource_record_post_action 05:08:55 INFO - Running post-action listener: _start_resource_monitoring 05:08:55 INFO - Starting resource monitoring. 05:08:55 INFO - [mozharness: 2016-08-23 12:08:55.300823Z] Finished create-virtualenv step (success) 05:08:55 INFO - [mozharness: 2016-08-23 12:08:55.301812Z] Running install step. 05:08:55 INFO - Running pre-action listener: _resource_record_pre_action 05:08:55 INFO - Running main action method: install 05:08:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:55 INFO - Reading from file tmpfile_stdout 05:08:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:08:55 INFO - Reading from file tmpfile_stdout 05:08:55 INFO - Output received: 05:08:55 INFO - Usage: mozinstall [options] installer 05:08:55 INFO - Options: 05:08:55 INFO - -h, --help show this help message and exit 05:08:55 INFO - -d DEST, --destination=DEST 05:08:55 INFO - Directory to install application into. [default: 05:08:55 INFO - "/builds/slave/test"] 05:08:55 INFO - --app=APP Application being installed. [default: firefox] 05:08:55 INFO - mkdir: /builds/slave/test/build/application 05:08:55 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'] 05:08:55 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 05:09:11 INFO - Reading from file tmpfile_stdout 05:09:11 INFO - Output received: 05:09:11 INFO - /builds/slave/test/build/application/firefox/firefox 05:09:11 INFO - Running post-action listener: _resource_record_post_action 05:09:11 INFO - [mozharness: 2016-08-23 12:09:11.559088Z] Finished install step (success) 05:09:11 INFO - [mozharness: 2016-08-23 12:09:11.559364Z] Running run-tests step. 05:09:11 INFO - Running pre-action listener: _resource_record_pre_action 05:09:11 INFO - Running main action method: run_tests 05:09:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:11 INFO - Python 2.7.3 05:09:11 INFO - Return code: 0 05:09:11 INFO - grabbing minidump binary from tooltool 05:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:11 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 0xfc5570>, '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 0xfc6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc6900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:11 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 05:09:11 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 05:09:11 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 05:09:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:11 INFO - Return code: 0 05:09:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:09:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:09:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:11 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/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 05:09:11 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/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 05:09:11 INFO - Using env: {'DISPLAY': ':0', 05:09:11 INFO - 'HOME': '/home/cltbld', 05:09:11 INFO - 'LANG': 'en_US.UTF-8', 05:09:11 INFO - 'LANGUAGE': 'en_US:en', 05:09:11 INFO - 'LOGNAME': 'cltbld', 05:09:11 INFO - 'MAIL': '/var/mail/cltbld', 05:09:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:11 INFO - 'MOZ_NO_REMOTE': '1', 05:09:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:11 INFO - 'NO_EM_RESTART': '1', 05:09:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:11 INFO - 'PWD': '/builds/slave/test', 05:09:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:11 INFO - 'SHELL': '/bin/bash', 05:09:11 INFO - 'SHLVL': '1', 05:09:11 INFO - 'TERM': 'linux', 05:09:11 INFO - 'TMOUT': '86400', 05:09:11 INFO - 'USER': 'cltbld', 05:09:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670', 05:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:11 INFO - '_': '/tools/buildbot/bin/python'} 05:09:11 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/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 05:09:11 INFO - mozversion application_buildid: 20160823021946 05:09:11 INFO - mozversion application_changeset: 36fd886d42c158fb2c613681c938960dfccda74b 05:09:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:09:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:11 INFO - mozversion application_name: Firefox 05:09:11 INFO - mozversion application_remotingname: firefox-dev 05:09:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:09:11 INFO - mozversion application_vendor: Mozilla 05:09:11 INFO - mozversion application_version: 50.0a2 05:09:11 INFO - mozversion platform_buildid: 20160823021946 05:09:11 INFO - mozversion platform_changeset: 36fd886d42c158fb2c613681c938960dfccda74b 05:09:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:09:11 INFO - mozversion platform_version: 50.0a2 05:09:11 INFO - using testdate: 1471954151 05:09:11 INFO - actual date: 1471954151 05:09:11 INFO - starting webserver on 'localhost:39064' 05:09:11 INFO - SUITE-START | Running 2 tests 05:09:11 INFO - TEST-START | dromaeo_css 05:09:11 INFO - operating with platform_type : linux_ 05:09:11 INFO - Initialising browser for dromaeo_css test... 05:09:11 INFO - TEST-INFO | started process 3384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg48twH/profile http://localhost:39064/getInfo.html) 05:09:20 INFO - PROCESS | 3384 | __metrics Screen width/height:1600/1200 05:09:20 INFO - PROCESS | 3384 | colorDepth:24 05:09:20 INFO - PROCESS | 3384 | Browser inner width/height: 1024/697 05:09:20 INFO - PROCESS | 3384 | __metrics 05:09:21 ERROR - PROCESS | 3384 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:09:22 INFO - TEST-INFO | 3384: exit 0 05:09:22 INFO - Browser initialized. 05:09:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:09:22 INFO - TEST-INFO | started process 3513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg48twH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:33 INFO - PROCESS | 3513 | RSS: Main: 152678400 05:09:33 INFO - PROCESS | 3513 | 05:10:23 INFO - PROCESS | 3513 | 1471954223567 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] 05:12:31 INFO - PROCESS | 3513 | Cycle 1(1): loaded http://localhost:39064/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39064/tests/dromaeo/cssquery-ext.html) 05:12:33 INFO - PROCESS | 3513 | RSS: Main: 157773824 05:12:33 INFO - PROCESS | 3513 | 05:15:34 INFO - PROCESS | 3513 | Cycle 1(1): loaded http://localhost:39064/tests/dromaeo/cssquery-ext.html (next: http://localhost:39064/tests/dromaeo/cssquery-jquery.html) 05:15:35 INFO - PROCESS | 3513 | RSS: Main: 153808896 05:15:35 INFO - PROCESS | 3513 | 05:18:37 INFO - PROCESS | 3513 | Cycle 1(1): loaded http://localhost:39064/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39064/tests/dromaeo/cssquery-mootools.html) 05:18:37 INFO - PROCESS | 3513 | RSS: Main: 154427392 05:18:37 INFO - PROCESS | 3513 | 05:21:39 INFO - PROCESS | 3513 | Cycle 1(1): loaded http://localhost:39064/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39064/tests/dromaeo/cssquery-prototype.html) 05:21:40 INFO - PROCESS | 3513 | RSS: Main: 153153536 05:21:40 INFO - PROCESS | 3513 | 05:24:42 INFO - PROCESS | 3513 | Cycle 1(1): loaded http://localhost:39064/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39064/tests/dromaeo/cssquery-yui.html) 05:24:43 INFO - PROCESS | 3513 | RSS: Main: 154951680 05:24:43 INFO - PROCESS | 3513 | 05:27:45 INFO - PROCESS | 3513 | Cycle 1(1): loaded http://localhost:39064/tests/dromaeo/cssquery-yui.html (next: http://localhost:39064/tests/dromaeo/cssquery-dojo.html) 05:27:46 INFO - PROCESS | 3513 | RSS: Main: 155820032 05:27:46 INFO - PROCESS | 3513 | 05:27:46 INFO - PROCESS | 3513 | __start_tp_report 05:27:46 INFO - PROCESS | 3513 | _x_x_mozilla_page_load 05:27:46 INFO - PROCESS | 3513 | _x_x_mozilla_page_load_details 05:27:46 INFO - PROCESS | 3513 | |i|pagename|runs| 05:27:46 INFO - PROCESS | 3513 | |0;dojo.html;3287.260366417556;3352.463605823069;3356.412627790139;3359.7312215022794;3393.1177893747636;5747.482726554609;5766.798162064329;5801.82594522164;5818.2145410369585;5819.563532735041;5805.36141024487;5813.924423981566;5850.912236316459;5869.7358618862145;5874.88250234995;5234.319538460004;5296.232046353276;5317.494837990384;5350.732463376816;5374.3013408256875;5185;5198.714070726109;5227.21591761237;5229.738513074331;5252.71110088945;5221.817236396727;5232.869178270555;5241.921371179416;5307.336582927134;5331.600129990247;5292.44429334922;5297.894042119175;5308.601854860901;5315.149576067849;5319.707416092114;5056.620753443506;5070.645054846163;5193.8961220775755;5221.660592061542;5284.128118860383;5615.859603509945;5697.829065128011;5723.341815691166;5727.599068065237;5775.88448231033;6113.908291375633;6136.877262454771;6158.815235542941;6173.41352571505;6192.597481163755;6086.543509236781;6142.161149281699;6218.409251121137;6218.81343559694;6223.190985171944;5665.405132461074;5699.401562835884;5767.826965191051;5796.072628379481;5799.927013502515;6254.749810007549;6281.654509001957;6288.151099601587;6295.527835412271;6297.622142671455;5969.522438204933;5970.104484327386;6016.849578760479;6027.60820546663;6047.15339852421;6098.908516372258;6102.0541816018585;6112.602680825732;6159.045347971071;6204;6092.817215483543;6123.4488895999575;6160.691965401802;6160.860240855456;6190.907136392958;5981.641101533922;6148.047052706837;6149.907751383733;6168.599041062316;6179.28938172116;4655.627549796008;4674.69614475058;4676.368690226844;4718.0328032753205;4740.976295118502;4217.915641687149;4226.218149642326;4234.830606775756;4236.406903033578;4252.4471818664;5749.396313387034;5788.942110578924;5843.561732870052;5849.590528663038;5852.268466441695;6122.755089796358;6123.679189354777;6145.539084568675;6201.255849298022;6224.097505861625;5897.616654917417;5899.056151015817;5899.557533184942;5904.4685978261305;5911.586188966731;5106.693598384109;5200.609954253446;5208.114620514521;5208.348956380452;5209.114450543417;6253.437190652772;6370.968145159244;6400.295967443578;6431.356864313531;6506.837329066717;6189.102580125947;6202.5658203925295;6232.158658581124;6243.625382477066;6246.312905580474;6230.408111229426;6306.274778400542;6454.2900280968115;6468.126802881739;6473.514486413632;6085.117657939485;6117.553376797925;6150.753969841336;6161.568690191643;6165.6608886509875;6240.656763877849;6247.281562620356;6267.341929097562;6286.15136956505;6328.968355158379;6002.309734380602;6004.459598636144;6147.139400484025;6163.691815409122;6165.5375846810775;6014.188084608521;6056.939430605814;6096.634201947897;6096.786612468542;6126.172966649446;6008.789692360747;6014.127951446928;6019.54853385989;6029.698515074317;6046.09308603713;6013.218281623361;6063.818085457443;6123.663198524124;6131.601445906002;6157.168782214523;5923.851903702442;5981.0729336952845;5993.041113421831;6028.638281703112;6030.396960303934 05:27:46 INFO - PROCESS | 3513 | |1;ext.html;583.6498101139317;641.9952773908832;646.2503495944702;667.1393901866593;718.0844423360212;41309;45810.770946145305;45874.08251834961;45906.31140532895;45958.770206148925;46863.53136468634;47224;47432.52567474324;47653.28520072201;47778.52221477793;9007.819843603123;9151.359404841663;9198.540072996357;9203.309751768611;9205.355625106245;9139.95430022849;9221.95389023054;9269.675561355354;9309.394889332172;9309.394889332172;9298.163165315154;9300.581473833694;9319.62721491143;9334.393264437824;9370.765730856714;9314.115159059844;9330.066993300616;9330.626774928995;9377.390469619453;9379.108984646447;9163.770905727344;9179.082091790835;9202.723918282396;9272.165505104573;9283.442993420349;44253.77873110646;44872.3269150963;44916;45104.77447612741;45262.54737452649;3944.7041471889725;3998.620131087542;4076.9592304077173;4110.897227569305;4124.319487284594;34399.140021499414;36002.45996310058;36070.8196459016;36123.4581481278;37648.62351376479;4690.788914498856;4771.522847715235;4833.4441539222735;4846.079244943449;4910.803567857281;391342;392166;392293;392989;394056;66827;66853;67123.66438167778;67290.66354668196;67376;40336.39495407571;41221.58778412238;41476;43671.126577468276;69661;19757.506062348555;19844.404667859697;19895.204191832454;19965;20044.899775501322;13813.861861381458;13821.101628394123;13907.513237036857;13942.512012079529;13954.58136255914;21104;21172.47068823292;21375.786242137692;21444.142234310766;21713.457163571038;7846.058472983279;7976.561289129154;8089.47418417801;8133.5526546039355;8153.266206041485;1002.0830939690247;1066.6906597086913;1114.1866437500669;1158.212415557429;1186.104491109207;31925.52111718326;33980.660193398246;34334.313313734085;34412.311753764785;34912;1131.7849608574345;1141.3209140561353;1155.96532104037;1198.7063169523522;1233.6237447578396;17550.210240539207;17587.824121758873;17662.911685441748;17709.557261068578;17777.46667599974;587634;591428;596844;597159;599166;64576.35423645798;65031.67484162549;65057.34942650513;65097.34902651008;65112;1452.6949340638373;1469.1185288826832;1484.161448781435;1509.230292550807;1524.1693277163972;33119;33349.666503335626;33450.83274583709;33473.49789753204;33950.49074263938;57928.71035644795;58888.70555647366;58889;58961.70519147377;59021.63913443414;530721;531778;533550;534166;535712;30878.228044298172;31855.203619909687;31993;31996.6800332003;32050.35899282048;53667.19499207593;54100.729496352265;54222.45777542332;56048.719756400955;56058.439415606954;45179.54820451754;45810.31284530668;46271;47634.285485718436;48142;45558.54441455543;45787.77106114448;46332.7683361581;46507.04690101379;47020.7648961753;45138.548614513435;47901.28148077712;48565;50041;50163.74918125532;40175.59824401836;40750.38874416945;40889.795551022056;41178.38232426456;41442.792786035876;30388.24029399283;30852.845735771178;31273.687263127988;31385.529217061307;31684.36631267408 05:27:46 INFO - PROCESS | 3513 | |2;jquery.html;396.11073140798914;407.15108997739713;426.9380939763734;431.29698591296193;438.5395334898358;20310.89844550777;20512.89743551282;21259.19296859767;21492;21498;16903.816732828676;19668;20358.796412035874;20430.69353959688;20475.180992760274;5248.895022099565;5408.323959505062;5410.1073322901875;5414.458554144593;5422.864428389283;5446.373667028283;5456.727163641822;5474.479924407175;5492.038893193695;5495.093309603911;5333.653312534692;5426.104692725715;5427.48438898304;5502.972485137569;5503.504684578387;5357.651752636066;5363.356397232318;5417.64785288957;5422.864428389283;5436.972815135939;5124.205748109049;5284.973575132138;5286.233496143076;5290.1800220965815;5291.126964050927;12011.57959471423;14872.925635371863;22813;25040.37399065038;25129.12048078327;2464.29767516257;2485.8632775197357;2590.520753660579;2880.8271503709843;3120.3915236528887;10685.946570267177;10966.561337546489;11797.056235501139;11884.940575297154;15791.052536847827;2028.8174064334132;2107.725995620575;2131.6482780341225;2144.7533533643673;2145.506533497304;86638.56680716557;89182.10817891738;89510.55244723799;89590;90546.5472672639;11447.656570302905;11529.423528823692;11590.362530060927;11770.52917883275;11776.705582360339;16380.344786208418;16399.754003689955;16429.26068326928;16454.917725411295;16464.01215927048;8702.21680048786;8869.947923408634;8920.375573709907;9050.185483306534;9103.544822758835;8609.311255099703;8696.95651521751;8707.47755134694;8896.46621202717;8925.553722313858;4884.704189031149;4947.381577302837;5034.144195486776;5052.595792336604;5090.4728581425425;2053.8254248389053;2102.5374417628095;2121.1091341636547;2135.903884325209;2184.5084855907294;999.2855108597388;1113.6046703420332;1113.9053180479589;1118.3960661243;1171.244547267025;20654.690179647318;20873.34282076255;20970.47573810667;21082.472938176667;21133.894330528557;1044.3107549017611;1054.7943151085465;1067.386252904583;1077.4612693653173;1091.3124731419155;10500.579976800995;11526.71831644267;11637.709057273467;11752.412379380996;11773.88226117745;464189;477177;517757;519827;520078;92005.53997229971;94971;95632;96151;96885.0311496876;1066.2589500297374;1100.14738577603;1125.549780087955;1132.5356603792407;1136.1138312116561;18532.629347413247;18905.621887562447;19126.426207213804;19194;19293.228270869007;43955.12089758251;44420;45277.320840188084;45549.31676024796;45955.77022114868;56107.719461402434;58848.70575647095;60234;61585;63095.36904630895;9011.414258073204;9263.258939284706;9377.671781487616;9465.290103242147;9596.040395960348;14392.856071439151;14489.347979341166;14531.200783956983;14565.781513277521;14618.561443156723;11713.121515886172;11842.28946263227;11859.169858110195;11909.344986025852;12020.939895300817;11369.374684392107;11862.822057669315;11877.109216808602;12046.397680115784;12069.939650301692;11700.180987330805;11745.354005529778;11911;11935.16453848257;12695.301758403377;9025.954870225607;9334.25325973934;9356.532173391439;9432.339736218399;9534.998825123539;5858.5898987070495;8847.46915185091;11384.43077846121;11433.59982400612;11506.597269095542 05:27:46 INFO - PROCESS | 3513 | |3;mootools.html;1536.4084827341474;1552.1230504764808;1714.3142742902837;1780.5548612846787;1829.7895741989676;8363.121872203423;9041.186293233615;9149.725508234747;9812.411255324676;9812.754681132967;9214.262858971282;9579.281553883451;9587.424754514734;9588.185004274628;9612.519374031288;2193.8903054847233;2217.323716266538;2218.4121207879925;2219.2454565447742;2232.0402227042364;2449.620308852122;2486.415692312305;2487.0797804812155;2489.041718938213;2506;2412.6260429633435;2425.1754403502805;2437.402836305108;2451.9754802452017;2467.469494058777;2392.3779817247555;2397.184957114581;2403.6034054381007;2405.3505553500545;2440.2191298784396;2433.3429973907123;2441.1944058460667;2459.508098380313;2468.679071720665;2474.2948259745885;9028.954855225747;9139.634414623408;9147.359684822066;9147.679831205876;9156.816863662689;5571.526420254283;5666.348369937468;5692.17463467799;5698.7435565399655;5720.856978575527;3725;3740.7942563159017;3761.492198553188;3765.6422639849443;3830.080780612661;1247.9188852724544;1249.537671061713;1260.6785269756244;1275.79587266037;1313.1398933698347;13470.326483675875;13505.86494135056;13506.797398039038;13519.324033798272;13542.526011589645;4888.902221955541;4949.7030178189425;4961.05739909416;5002.74986250686;5119.87200319995;11197.66407007791;11307.038901693448;11307.208495405243;11317.094632429385;11330.490127944262;5615.213870058195;5632.831015069554;5649.096144616924;5661.405552416937;5665;4474.418325617714;5109.029284435946;5109.08036553424;5145.794168233228;5180.8963820723375;4278.850240241639;4337.566243375637;4347.478302603708;4388.868333949923;4392;1335.6393773681245;1338.3709656461447;1339.4374362767467;1351.8039884216732;1360.585021568431;1024.2727663358949;1033.1373303291834;1049.4805071489661;1058.9576416943237;1062.697131317571;6328.778492752732;6409.711562979677;6450.161479007699;6525.902111468332;6601.438877695354;495.6431369414016;506.46061944030225;506.8454121492906;508.0626244578746;509.1827616675257;4447.777611119496;4491.05687805558;4500;4529.750863702462;4560.475545312265;11546.826797598043;11753.88246117545;11839.822402663967;11849.407529623657;11926.105542084204;11187.72030699239;11706.824397634042;11788.46951887167;11811.586594469152;12159.088068394729;8839.734807955772;9075.183233509017;9084.8637270441;9094;9094.772630684285;6516.869662606627;6757.391834734897;6819.522633415613;6838.965805170942;6855.211650660238;10634.84047739269;10889.237753357505;10959.890401095887;11023.559057637605;11079.169062320198;10834;11092.445377730919;11232.719182020515;11232.887671123512;11338.659840204808;7724.420668449777;8188.058373287148;8410.831783364176;8489.83020339602;8614.095519970564;8934.061923498199;9027.09729027092;9036.774080648036;9069.546522673709;9110.31672624569;8129.4715843469985;8328;8361.874571881548;8392.622331995197;8548.145185481402;7983.1617680142745;8058.194180581895;8127.75616731499;8169.959150204211;8221.671133154607;7437.367823735043;7502.174760776419;7510.248975102446;7572.091349038151;7690.230976902265;5596.664200148004;5761.423857614205;5893.823185304448;5945.346011938596;6006.339302676614;5679.261695979496;5680.062789639664;5760.279965004374;5844.912326315024;5901.645901245939 05:27:46 INFO - PROCESS | 3513 | |4;prototype.html;348.32946577837663;348.9092835862676;350.93858574749413;353.688753896571;356.21454692403256;5795.884082318351;5798.5361171106315;5838.737256823442;5850;5873.442023007813;5735.827925162242;5768.682722450274;5779.913301300484;5787.755632539003;5792.160136780164;3935.762900691309;4394.758288294142;4478.552144785528;4496.504440035796;4503.211937910869;4493.752843593601;4521.819127234907;4530.161920044786;4544.227481328166;4574.9542504574865;4527.909441811162;4528.25283828168;4532.274836026237;4534.161180181677;4539.0921815637;4224.591982569937;4465.352523884051;4472.731636101845;4484.641228701696;4532.592066713995;3934.960650393488;3939.1333906540517;3939.763614183158;3949.328614135604;3970.305196590614;5686.147077938301;5708.001099807517;5712.971435142839;5716.370834312201;5727.971360143214;4917.827876024322;5109.20807274873;5187.247849061865;5188.092083885343;5241.947580524222;6022.367651396584;6083.361247069039;6105.542084343692;6119.877602447926;6120.44915957566;4364.127174565068;4384.12317536494;4401.713888597231;4403.559644035603;4412.536683648203;6150.8769824603705;6163.198784158076;6293.590916590453;6335.493160547145;6365.140706004677;4395.7142785718825;4434.711743736647;4434.778261086933;4446.733196008186;4463.776811159429;4469.597736203757;4482.036362182146;4486.900709326236;4512.684112112186;4517.412736344254;5023.1711767557945;5174;5184.092783762826;5206;5216.217567364925;6140.973478752001;6169.81490555284;6182.28903676074;6185.443310102112;6191.907121393183;1560.9843901561067;1573.2920185916385;1577.7791109244715;1579.6919600677988;1580.083551540127;975.6097560975667;991.7074463033423;999.4702807512031;1004.9196064314838;1015.4110615842793;5120.257562653394;5181.010621821252;5195.948040519622;5233.947660523422;5323.600729945269;5473.084420452809;5489.478499542537;5500.80747173847;5527.319250163668;5546.389897111315;4915.336429582032;5173.922391164136;5221.55616772571;5246.711430871339;5250.369955605275;2960.8815647374295;2972.75144439336;2975.895843645462;2995.666928216966;3032.3935212957053;5651.237082993825;5661.518770904519;5699.373068962494;5726.513246374105;5729.598928075078;5984.8803023940145;6438.742450301936;6483.351664833479;6490.772822951174;6512.902306465407;6613.503987200979;6620;6629.502787290972;6670.599764014175;6737.59574425536;6231.781887633911;6328.4053538049175;6392.369945663826;6398.616083035033;6420.6147631142285;6278.905816412666;6314.137329487904;6319.842003949938;6330.341256672116;6334;6266.2480502338185;6402.775902843565;6514.934850651623;6534.444572211225;6539.7384104637185;4447.7998490067375;4464;4491.528389519184;4513.68404211702;4538.364628951884;6291.653959032297;6308.589941653778;6396.29640739509;6409.35906409374;6441.452476539546;6207.937920620736;6213.316535181036;6215.06773983906;6223.626582405071;6251.656158911122;5939.91090133657;6168.814935551941;6210.31686514474;6222.377762223741;6222.439980401786;6100.786472473442;6172.938270617236;6176.567640265318;6181.876362472815;6196.256449225942;6298.779542715983;6305.747770089145;6311.400416960381;6312.7159277833525;6319.368063193644;5829.795957141479;6070.817875463743;6097.268327800515;6108.847278818065;6119.938800612115 05:27:46 INFO - PROCESS | 3513 | |5;yui.html;819.0949001353504;825.4758228524888;827.0695467598944;898.991010089899;925.8703781470591;16115.113668748214;16875.40936067238;16960.151992400362;17039.14804259788;17112.14439278034;15760.369585216578;15976.760348594751;16080.919595402007;16118.75821862673;16204.432844850433;706.4313227851577;859.1151114352227;882.2192359761625;893.852514335134;897.5287973813768;884.8628462588309;886.2024178239603;894.4186278918722;895.3553441522093;895.6238379880466;942.726609283307;945.9290553208502;948.0566835998158;950.1638558068889;951.1914872358475;939.4363381970832;940.9012053734327;940.920021798148;942.1520631431766;942.8444306689388;689.675852349395;692.8129405060605;693.6254422611784;695.1033167214288;696.5994553131919;16357.67284654312;16445.09551974641;16497.422590209284;16501.752473712902;16514.42199523023;16429.6714065718;17077.276812983273;17280.740788888175;17707.645847082986;17865.7320140198;13537;13740.450381984709;14088.366023528966;14150.929245353811;14179.78730319046;4218.915621687549;4240.1307731914885;4253.957460425387;4266.637335826458;4326.740395576276;91605.08394916033;91767;92815;94927.52536237275;98449.50775246078;11957.641270761891;12181.634550963485;12347.135700501058;13311.40098695561;13359.799603005962;25874.482510350063;25904.22287331383;26048.609270860954;26056.218313450627;26084.217473475826;9409.90590094104;9641;9641;9714.271429642664;10225.642102526524;5102.290732604545;5121;5157.535821776059;5161.380634323905;5311.601629877775;3780.4707340972286;3893.5911729268587;3901.0637447012514;3906.4921560196995;3909.882703518899;659.0641289369107;666.4801454865213;674.8886433738477;678.8268991407258;680.6732768271158;795.7652492514607;800.279748226589;817.6811043692845;818.2962652119173;827.7227128911882;10693.144548436107;10751.569937202425;11048.281861678965;11102.389368584805;11556.711082223012;761.3186198352554;767.9001729775205;799.2127754162145;803.7066470738256;817.7138001699476;5196.029776674938;5226.555742761831;5291.51500404715;5300.628955973122;5404.702741349263;93460.53269733743;131938.34030829783;132630;133218;136627.31686341504;93529.5323523378;94178;116737;118469;119016.40491797659;90686.54656726673;90744;92593.5370323144;94033.52983235176;94142.5292873545;10632.362058276529;10693.679189624323;10834.512446939749;10838.458077096271;10951.726206844893;50841.49158508368;51871;52507.21239181339;52707.51665648198;53622.73188634032;71504;71870.64064679643;80718;82092;82972.17027829644;14179.809542852776;14233.786493202817;14375.568732938029;14563.635909102357;14702.41190352374;16471.67056658884;16501.752473713143;16668.08325542107;16722;17059.829401705825;14716.264186790831;15002.474913377979;15744.527664170093;16197.109158996369;16247.350105995627;14857.40570377216;15146.848531514985;15388.461403850812;15916.602084947968;16281.918590406973;11043.558257669603;13386.263755493152;14402.42390304418;14911.105333680014;15533.611659708598;12352.75294494123;12639.557615483414;13074.150180238254;13335.133081368422;13336.866631333562;12966.740665186455;12971.156874803108;13095.476180953036;13298.072542144248;13436.126651767603 05:27:46 INFO - PROCESS | 3513 | __end_tp_report 05:27:46 INFO - PROCESS | 3513 | __start_cc_report 05:27:46 INFO - PROCESS | 3513 | _x_x_mozilla_cycle_collect,322 05:27:46 INFO - PROCESS | 3513 | __end_cc_report 05:27:46 INFO - PROCESS | 3513 | __startTimestamp1471955266033__endTimestamp 05:27:46 INFO - PROCESS | 3513 | 05:27:46 INFO - PROCESS | 3513 | ------- Summary: start ------- 05:27:46 INFO - PROCESS | 3513 | Number of tests: 6 05:27:46 INFO - PROCESS | 3513 | 05:27:46 INFO - PROCESS | 3513 | [#0] dojo.html Cycles:165 Average:5740.45 Median:6004.46 stddev:655.85 (10.9%) stddev-sans-first:628.99 05:27:46 INFO - PROCESS | 3513 | Values: 3287.3 3352.5 3356.4 3359.7 3393.1 5747.5 5766.8 5801.8 5818.2 5819.6 5805.4 5813.9 5850.9 5869.7 5874.9 5234.3 5296.2 5317.5 5350.7 5374.3 5185.0 5198.7 5227.2 5229.7 5252.7 5221.8 5232.9 5241.9 5307.3 5331.6 5292.4 5297.9 5308.6 5315.1 5319.7 5056.6 5070.6 5193.9 5221.7 5284.1 5615.9 5697.8 5723.3 5727.6 5775.9 6113.9 6136.9 6158.8 6173.4 6192.6 6086.5 6142.2 6218.4 6218.8 6223.2 5665.4 5699.4 5767.8 5796.1 5799.9 6254.7 6281.7 6288.2 6295.5 6297.6 5969.5 5970.1 6016.8 6027.6 6047.2 6098.9 6102.1 6112.6 6159.0 6204.0 6092.8 6123.4 6160.7 6160.9 6190.9 5981.6 6148.0 6149.9 6168.6 6179.3 4655.6 4674.7 4676.4 4718.0 4741.0 4217.9 4226.2 4234.8 4236.4 4252.4 5749.4 5788.9 5843.6 5849.6 5852.3 6122.8 6123.7 6145.5 6201.3 6224.1 5897.6 5899.1 5899.6 5904.5 5911.6 5106.7 5200.6 5208.1 5208.3 5209.1 6253.4 6371.0 6400.3 6431.4 6506.8 6189.1 6202.6 6232.2 6243.6 6246.3 6230.4 6306.3 6454.3 6468.1 6473.5 6085.1 6117.6 6150.8 6161.6 6165.7 6240.7 6247.3 6267.3 6286.2 6329.0 6002.3 6004.5 6147.1 6163.7 6165.5 6014.2 6056.9 6096.6 6096.8 6126.2 6008.8 6014.1 6019.5 6029.7 6046.1 6013.2 6063.8 6123.7 6131.6 6157.2 5923.9 5981.1 5993.0 6028.6 6030.4 05:27:46 INFO - PROCESS | 3513 | 05:27:46 INFO - PROCESS | 3513 | [#1] ext.html Cycles:180 Average:67754.63 Median:45842.43 stddev:136406.27 (297.6%) stddev-sans-first:136695.69 05:27:46 INFO - PROCESS | 3513 | Values: 583.6 642.0 646.3 667.1 718.1 41309.0 45810.8 45874.1 45906.3 45958.8 46863.5 47224.0 47432.5 47653.3 47778.5 9007.8 9151.4 9198.5 9203.3 9205.4 9140.0 9222.0 9269.7 9309.4 9309.4 9298.2 9300.6 9319.6 9334.4 9370.8 9314.1 9330.1 9330.6 9377.4 9379.1 9163.8 9179.1 9202.7 9272.2 9283.4 44253.8 44872.3 44916.0 45104.8 45262.5 3944.7 3998.6 4077.0 4110.9 4124.3 34399.1 36002.5 36070.8 36123.5 37648.6 4690.8 4771.5 4833.4 4846.1 4910.8 391342.0 392166.0 392293.0 392989.0 394056.0 66827.0 66853.0 67123.7 67290.7 67376.0 40336.4 41221.6 41476.0 43671.1 69661.0 19757.5 19844.4 19895.2 19965.0 20044.9 13813.9 13821.1 13907.5 13942.5 13954.6 21104.0 21172.5 21375.8 21444.1 21713.5 7846.1 7976.6 8089.5 8133.6 8153.3 1002.1 1066.7 1114.2 1158.2 1186.1 31925.5 33980.7 34334.3 34412.3 34912.0 1131.8 1141.3 1156.0 1198.7 1233.6 17550.2 17587.8 17662.9 17709.6 17777.5 587634.0 591428.0 596844.0 597159.0 599166.0 64576.4 65031.7 65057.3 65097.3 65112.0 1452.7 1469.1 1484.2 1509.2 1524.2 33119.0 33349.7 33450.8 33473.5 33950.5 57928.7 58888.7 58889.0 58961.7 59021.6 530721.0 531778.0 533550.0 534166.0 535712.0 30878.2 31855.2 31993.0 31996.7 32050.4 53667.2 54100.7 54222.5 56048.7 56058.4 45179.5 45810.3 46271.0 47634.3 48142.0 45558.5 45787.8 46332.8 46507.0 47020.8 45138.5 47901.3 48565.0 50041.0 50163.7 40175.6 40750.4 40889.8 41178.4 41442.8 30388.2 30852.8 31273.7 31385.5 31684.4 05:27:46 INFO - PROCESS | 3513 | 05:27:46 INFO - PROCESS | 3513 | [#2] jquery.html Cycles:180 Average:30007.20 Median:2475.08 stddev:82658.17 (3339.6%) stddev-sans-first:82860.15 05:27:46 INFO - PROCESS | 3513 | Values: 396.1 407.2 426.9 431.3 438.5 20310.9 20512.9 21259.2 21492.0 21498.0 16903.8 19668.0 20358.8 20430.7 20475.2 5248.9 5408.3 5410.1 5414.5 5422.9 5446.4 5456.7 5474.5 5492.0 5495.1 5333.7 5426.1 5427.5 5503.0 5503.5 5357.7 5363.4 5417.6 5422.9 5437.0 5124.2 5285.0 5286.2 5290.2 5291.1 12011.6 14872.9 22813.0 25040.4 25129.1 2464.3 2485.9 2590.5 2880.8 3120.4 10685.9 10966.6 11797.1 11884.9 15791.1 2028.8 2107.7 2131.6 2144.8 2145.5 86638.6 89182.1 89510.6 89590.0 90546.5 11447.7 11529.4 11590.4 11770.5 11776.7 16380.3 16399.8 16429.3 16454.9 16464.0 8702.2 8869.9 8920.4 9050.2 9103.5 8609.3 8697.0 8707.5 8896.5 8925.6 4884.7 4947.4 5034.1 5052.6 5090.5 2053.8 2102.5 2121.1 2135.9 2184.5 999.3 1113.6 1113.9 1118.4 1171.2 20654.7 20873.3 20970.5 21082.5 21133.9 1044.3 1054.8 1067.4 1077.5 1091.3 10500.6 11526.7 11637.7 11752.4 11773.9 464189.0 477177.0 517757.0 519827.0 520078.0 92005.5 94971.0 95632.0 96151.0 96885.0 1066.3 1100.1 1125.5 1132.5 1136.1 18532.6 18905.6 19126.4 19194.0 19293.2 43955.1 44420.0 45277.3 45549.3 45955.8 56107.7 58848.7 60234.0 61585.0 63095.4 9011.4 9263.3 9377.7 9465.3 9596.0 14392.9 14489.3 14531.2 14565.8 14618.6 11713.1 11842.3 11859.2 11909.3 12020.9 11369.4 11862.8 11877.1 12046.4 12069.9 11700.2 11745.4 11911.0 11935.2 12695.3 9026.0 9334.3 9356.5 9432.3 9535.0 5858.6 8847.5 11384.4 11433.6 11506.6 05:27:46 INFO - PROCESS | 3513 | 05:27:46 INFO - PROCESS | 3513 | [#3] mootools.html Cycles:180 Average:6256.31 Median:4724.69 stddev:3599.08 (76.2%) stddev-sans-first:3591.70 05:27:46 INFO - PROCESS | 3513 | Values: 1536.4 1552.1 1714.3 1780.6 1829.8 8363.1 9041.2 9149.7 9812.4 9812.8 9214.3 9579.3 9587.4 9588.2 9612.5 2193.9 2217.3 2218.4 2219.2 2232.0 2449.6 2486.4 2487.1 2489.0 2506.0 2412.6 2425.2 2437.4 2452.0 2467.5 2392.4 2397.2 2403.6 2405.4 2440.2 2433.3 2441.2 2459.5 2468.7 2474.3 9029.0 9139.6 9147.4 9147.7 9156.8 5571.5 5666.3 5692.2 5698.7 5720.9 3725.0 3740.8 3761.5 3765.6 3830.1 1247.9 1249.5 1260.7 1275.8 1313.1 13470.3 13505.9 13506.8 13519.3 13542.5 4888.9 4949.7 4961.1 5002.7 5119.9 11197.7 11307.0 11307.2 11317.1 11330.5 5615.2 5632.8 5649.1 5661.4 5665.0 4474.4 5109.0 5109.1 5145.8 5180.9 4278.9 4337.6 4347.5 4388.9 4392.0 1335.6 1338.4 1339.4 1351.8 1360.6 1024.3 1033.1 1049.5 1059.0 1062.7 6328.8 6409.7 6450.2 6525.9 6601.4 495.6 506.5 506.8 508.1 509.2 4447.8 4491.1 4500.0 4529.8 4560.5 11546.8 11753.9 11839.8 11849.4 11926.1 11187.7 11706.8 11788.5 11811.6 12159.1 8839.7 9075.2 9084.9 9094.0 9094.8 6516.9 6757.4 6819.5 6839.0 6855.2 10634.8 10889.2 10959.9 11023.6 11079.2 10834.0 11092.4 11232.7 11232.9 11338.7 7724.4 8188.1 8410.8 8489.8 8614.1 8934.1 9027.1 9036.8 9069.5 9110.3 8129.5 8328.0 8361.9 8392.6 8548.1 7983.2 8058.2 8127.8 8170.0 8221.7 7437.4 7502.2 7510.2 7572.1 7690.2 5596.7 5761.4 5893.8 5945.3 6006.3 5679.3 5680.1 5760.3 5844.9 5901.6 05:27:46 INFO - PROCESS | 3513 | 05:27:46 INFO - PROCESS | 3513 | [#4] prototype.html Cycles:180 Average:5073.90 Median:5703.69 stddev:1521.53 (26.7%) stddev-sans-first:1483.88 05:27:46 INFO - PROCESS | 3513 | Values: 348.3 348.9 350.9 353.7 356.2 5795.9 5798.5 5838.7 5850.0 5873.4 5735.8 5768.7 5779.9 5787.8 5792.2 3935.8 4394.8 4478.6 4496.5 4503.2 4493.8 4521.8 4530.2 4544.2 4575.0 4527.9 4528.3 4532.3 4534.2 4539.1 4224.6 4465.4 4472.7 4484.6 4532.6 3935.0 3939.1 3939.8 3949.3 3970.3 5686.1 5708.0 5713.0 5716.4 5728.0 4917.8 5109.2 5187.2 5188.1 5241.9 6022.4 6083.4 6105.5 6119.9 6120.4 4364.1 4384.1 4401.7 4403.6 4412.5 6150.9 6163.2 6293.6 6335.5 6365.1 4395.7 4434.7 4434.8 4446.7 4463.8 4469.6 4482.0 4486.9 4512.7 4517.4 5023.2 5174.0 5184.1 5206.0 5216.2 6141.0 6169.8 6182.3 6185.4 6191.9 1561.0 1573.3 1577.8 1579.7 1580.1 975.6 991.7 999.5 1004.9 1015.4 5120.3 5181.0 5195.9 5233.9 5323.6 5473.1 5489.5 5500.8 5527.3 5546.4 4915.3 5173.9 5221.6 5246.7 5250.4 2960.9 2972.8 2975.9 2995.7 3032.4 5651.2 5661.5 5699.4 5726.5 5729.6 5984.9 6438.7 6483.4 6490.8 6512.9 6613.5 6620.0 6629.5 6670.6 6737.6 6231.8 6328.4 6392.4 6398.6 6420.6 6278.9 6314.1 6319.8 6330.3 6334.0 6266.2 6402.8 6514.9 6534.4 6539.7 4447.8 4464.0 4491.5 4513.7 4538.4 6291.7 6308.6 6396.3 6409.4 6441.5 6207.9 6213.3 6215.1 6223.6 6251.7 5939.9 6168.8 6210.3 6222.4 6222.4 6100.8 6172.9 6176.6 6181.9 6196.3 6298.8 6305.7 6311.4 6312.7 6319.4 5829.8 6070.8 6097.3 6108.8 6119.9 05:27:46 INFO - PROCESS | 3513 | 05:27:46 INFO - PROCESS | 3513 | [#5] yui.html Cycles:180 Average:23037.54 Median:3903.78 stddev:33039.10 (846.3%) stddev-sans-first:33089.66 05:27:46 INFO - PROCESS | 3513 | Values: 819.1 825.5 827.1 899.0 925.9 16115.1 16875.4 16960.2 17039.1 17112.1 15760.4 15976.8 16080.9 16118.8 16204.4 706.4 859.1 882.2 893.9 897.5 884.9 886.2 894.4 895.4 895.6 942.7 945.9 948.1 950.2 951.2 939.4 940.9 940.9 942.2 942.8 689.7 692.8 693.6 695.1 696.6 16357.7 16445.1 16497.4 16501.8 16514.4 16429.7 17077.3 17280.7 17707.6 17865.7 13537.0 13740.5 14088.4 14150.9 14179.8 4218.9 4240.1 4254.0 4266.6 4326.7 91605.1 91767.0 92815.0 94927.5 98449.5 11957.6 12181.6 12347.1 13311.4 13359.8 25874.5 25904.2 26048.6 26056.2 26084.2 9409.9 9641.0 9641.0 9714.3 10225.6 5102.3 5121.0 5157.5 5161.4 5311.6 3780.5 3893.6 3901.1 3906.5 3909.9 659.1 666.5 674.9 678.8 680.7 795.8 800.3 817.7 818.3 827.7 10693.1 10751.6 11048.3 11102.4 11556.7 761.3 767.9 799.2 803.7 817.7 5196.0 5226.6 5291.5 5300.6 5404.7 93460.5 131938.3 132630.0 133218.0 136627.3 93529.5 94178.0 116737.0 118469.0 119016.4 90686.5 90744.0 92593.5 94033.5 94142.5 10632.4 10693.7 10834.5 10838.5 10951.7 50841.5 51871.0 52507.2 52707.5 53622.7 71504.0 71870.6 80718.0 82092.0 82972.2 14179.8 14233.8 14375.6 14563.6 14702.4 16471.7 16501.8 16668.1 16722.0 17059.8 14716.3 15002.5 15744.5 16197.1 16247.4 14857.4 15146.8 15388.5 15916.6 16281.9 11043.6 13386.3 14402.4 14911.1 15533.6 12352.8 12639.6 13074.2 13335.1 13336.9 12966.7 12971.2 13095.5 13298.1 13436.1 05:27:46 INFO - PROCESS | 3513 | -------- Summary: end -------- 05:27:46 INFO - PROCESS | 3513 | 05:27:46 INFO - TEST-INFO | 3513: exit 0 05:27:46 INFO - TEST-OK | dromaeo_css | took 1114819ms 05:27:46 INFO - TEST-START | kraken 05:27:46 INFO - operating with platform_type : linux_ 05:27:46 INFO - Initialising browser for kraken test... 05:27:46 INFO - TEST-INFO | started process 3777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLIz91W/profile http://localhost:39064/getInfo.html) 05:27:51 INFO - PROCESS | 3777 | __metrics Screen width/height:1600/1200 05:27:51 INFO - PROCESS | 3777 | colorDepth:24 05:27:51 INFO - PROCESS | 3777 | Browser inner width/height: 1024/697 05:27:51 INFO - PROCESS | 3777 | __metrics 05:27:52 ERROR - PROCESS | 3777 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:27:53 INFO - TEST-INFO | 3777: exit 0 05:27:53 INFO - Browser initialized. 05:27:53 INFO - Running cycle 1/1 for kraken test... 05:27:53 INFO - TEST-INFO | started process 3902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLIz91W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:05 INFO - PROCESS | 3902 | RSS: Main: 153235456 05:28:05 INFO - PROCESS | 3902 | 05:28:07 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:39064/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39064/tests/kraken/driver.html?testName=audio-beat-detection) 05:28:08 INFO - PROCESS | 3902 | RSS: Main: 158068736 05:28:08 INFO - PROCESS | 3902 | 05:28:11 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:39064/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39064/tests/kraken/driver.html?testName=audio-dft) 05:28:11 INFO - PROCESS | 3902 | RSS: Main: 156725248 05:28:11 INFO - PROCESS | 3902 | 05:28:14 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:39064/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39064/tests/kraken/driver.html?testName=audio-fft) 05:28:15 INFO - PROCESS | 3902 | RSS: Main: 158126080 05:28:15 INFO - PROCESS | 3902 | 05:28:17 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:39064/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39064/tests/kraken/driver.html?testName=audio-oscillator) 05:28:17 INFO - PROCESS | 3902 | RSS: Main: 157642752 05:28:17 INFO - PROCESS | 3902 | 05:28:20 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:39064/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39064/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:20 INFO - PROCESS | 3902 | RSS: Main: 156856320 05:28:20 INFO - PROCESS | 3902 | 05:28:23 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:39064/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39064/tests/kraken/driver.html?testName=imaging-darkroom) 05:28:24 INFO - PROCESS | 3902 | RSS: Main: 156512256 05:28:24 INFO - PROCESS | 3902 | 05:28:27 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:39064/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39064/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:28 INFO - PROCESS | 3902 | RSS: Main: 156852224 05:28:28 INFO - PROCESS | 3902 | 05:28:31 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:39064/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39064/tests/kraken/driver.html?testName=json-parse-financial) 05:28:31 INFO - PROCESS | 3902 | RSS: Main: 157822976 05:28:31 INFO - PROCESS | 3902 | 05:28:33 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:39064/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39064/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:28:33 INFO - PROCESS | 3902 | RSS: Main: 157429760 05:28:33 INFO - PROCESS | 3902 | 05:28:35 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:39064/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39064/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:28:36 INFO - PROCESS | 3902 | RSS: Main: 157380608 05:28:36 INFO - PROCESS | 3902 | 05:28:38 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:39064/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39064/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:28:39 INFO - PROCESS | 3902 | RSS: Main: 156954624 05:28:39 INFO - PROCESS | 3902 | 05:28:41 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:39064/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:28:42 INFO - PROCESS | 3902 | RSS: Main: 157151232 05:28:42 INFO - PROCESS | 3902 | 05:28:44 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:39064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:28:45 INFO - PROCESS | 3902 | RSS: Main: 157814784 05:28:45 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | Cycle 1(1): loaded http://localhost:39064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39064/tests/kraken/driver.html?testName=ai-astar) 05:28:47 INFO - PROCESS | 3902 | RSS: Main: 158580736 05:28:47 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | __start_tp_report 05:28:47 INFO - PROCESS | 3902 | _x_x_mozilla_page_load 05:28:47 INFO - PROCESS | 3902 | _x_x_mozilla_page_load_details 05:28:47 INFO - PROCESS | 3902 | |i|pagename|runs| 05:28:47 INFO - PROCESS | 3902 | |0;ai-astar;100;112;104;111;111;112;110;111;108;110 05:28:47 INFO - PROCESS | 3902 | |1;audio-beat-detection;146;116;155;182;116;147;145;119;171;119 05:28:47 INFO - PROCESS | 3902 | |2;audio-dft;162;164;160;161;162;161;162;162;160;159 05:28:47 INFO - PROCESS | 3902 | |3;audio-fft;74;74;75;181;76;76;75;75;164;76 05:28:47 INFO - PROCESS | 3902 | |4;audio-oscillator;83;82;143;84;84;84;138;84;82;143 05:28:47 INFO - PROCESS | 3902 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;118;120;117 05:28:47 INFO - PROCESS | 3902 | |6;imaging-darkroom;147;148;147;147;147;147;147;146;148;148 05:28:47 INFO - PROCESS | 3902 | |7;imaging-desaturate;95;95;96;96;96;96;96;95;96;95 05:28:47 INFO - PROCESS | 3902 | |8;json-parse-financial;53;53;55;53;53;54;58;52;54;53 05:28:47 INFO - PROCESS | 3902 | |9;json-stringify-tinderbox;60;60;60;61;61;59;59;60;61;61 05:28:47 INFO - PROCESS | 3902 | |10;stanford-crypto-aes;73;73;78;72;76;81;81;72;78;72 05:28:47 INFO - PROCESS | 3902 | |11;stanford-crypto-ccm;124;118;120;128;119;117;120;124;150;121 05:28:47 INFO - PROCESS | 3902 | |12;stanford-crypto-pbkdf2;155;157;158;153;154;153;158;154;157;153 05:28:47 INFO - PROCESS | 3902 | |13;stanford-crypto-sha256-iterative;64;65;64;63;65;61;61;60;60;62 05:28:47 INFO - PROCESS | 3902 | __end_tp_report 05:28:47 INFO - PROCESS | 3902 | __start_cc_report 05:28:47 INFO - PROCESS | 3902 | _x_x_mozilla_cycle_collect,854 05:28:47 INFO - PROCESS | 3902 | __end_cc_report 05:28:47 INFO - PROCESS | 3902 | __startTimestamp1471955327363__endTimestamp 05:28:47 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | ------- Summary: start ------- 05:28:47 INFO - PROCESS | 3902 | Number of tests: 14 05:28:47 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:3.93 (3.5%) stddev-sans-first:2.52 05:28:47 INFO - PROCESS | 3902 | Values: 100.0 112.0 104.0 111.0 111.0 112.0 110.0 111.0 108.0 110.0 05:28:47 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:146.50 stddev:23.73 (16.2%) stddev-sans-first:25.12 05:28:47 INFO - PROCESS | 3902 | Values: 146.0 116.0 155.0 182.0 116.0 147.0 145.0 119.0 171.0 119.0 05:28:47 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.42 (0.9%) stddev-sans-first:1.48 05:28:47 INFO - PROCESS | 3902 | Values: 162.0 164.0 160.0 161.0 162.0 161.0 162.0 162.0 160.0 159.0 05:28:47 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | [#3] audio-fft Cycles:10 Average:94.60 Median:75.00 stddev:41.26 (55.0%) stddev-sans-first:43.08 05:28:47 INFO - PROCESS | 3902 | Values: 74.0 74.0 75.0 181.0 76.0 76.0 75.0 75.0 164.0 76.0 05:28:47 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:83.50 stddev:28.08 (33.6%) stddev-sans-first:29.05 05:28:47 INFO - PROCESS | 3902 | Values: 83.0 82.0 143.0 84.0 84.0 84.0 138.0 84.0 82.0 143.0 05:28:47 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 05:28:47 INFO - PROCESS | 3902 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 120.0 117.0 05:28:47 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:28:47 INFO - PROCESS | 3902 | Values: 147.0 148.0 147.0 147.0 147.0 147.0 147.0 146.0 148.0 148.0 05:28:47 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:28:47 INFO - PROCESS | 3902 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 05:28:47 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.50 stddev:1.69 (3.2%) stddev-sans-first:1.76 05:28:47 INFO - PROCESS | 3902 | Values: 53.0 53.0 55.0 53.0 53.0 54.0 58.0 52.0 54.0 53.0 05:28:47 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.50 stddev:0.79 (1.3%) stddev-sans-first:0.83 05:28:47 INFO - PROCESS | 3902 | Values: 60.0 60.0 60.0 61.0 61.0 59.0 59.0 60.0 61.0 61.0 05:28:47 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:77.00 stddev:3.69 (4.8%) stddev-sans-first:3.79 05:28:47 INFO - PROCESS | 3902 | Values: 73.0 73.0 78.0 72.0 76.0 81.0 81.0 72.0 78.0 72.0 05:28:47 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:122.50 stddev:9.68 (7.9%) stddev-sans-first:10.26 05:28:47 INFO - PROCESS | 3902 | Values: 124.0 118.0 120.0 128.0 119.0 117.0 120.0 124.0 150.0 121.0 05:28:47 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:156.00 stddev:2.10 (1.3%) stddev-sans-first:2.22 05:28:47 INFO - PROCESS | 3902 | Values: 155.0 157.0 158.0 153.0 154.0 153.0 158.0 154.0 157.0 153.0 05:28:47 INFO - PROCESS | 3902 | 05:28:47 INFO - PROCESS | 3902 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.50 stddev:1.96 (3.1%) stddev-sans-first:2.00 05:28:47 INFO - PROCESS | 3902 | Values: 64.0 65.0 64.0 63.0 65.0 61.0 61.0 60.0 60.0 62.0 05:28:47 INFO - PROCESS | 3902 | -------- Summary: end -------- 05:28:47 INFO - PROCESS | 3902 | 05:28:49 INFO - TEST-INFO | 3902: exit 0 05:28:49 INFO - TEST-OK | kraken | took 62896ms 05:28:49 INFO - SUITE-END | took 1177s 05:28:50 INFO - Completed test suite (00:19:38) 05:28:50 INFO - javascript benchmark 05:28:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7816.468817283394, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3287.260366417556, 3352.463605823069, 3356.412627790139, 3359.7312215022794, 3393.1177893747636, 5747.482726554609, 5766.798162064329, 5801.82594522164, 5818.2145410369585, 5819.563532735041, 5805.36141024487, 5813.924423981566, 5850.912236316459, 5869.7358618862145, 5874.88250234995, 5234.319538460004, 5296.232046353276, 5317.494837990384, 5350.732463376816, 5374.3013408256875, 5185.0, 5198.714070726109, 5227.21591761237, 5229.738513074331, 5252.71110088945, 5221.817236396727, 5232.869178270555, 5241.921371179416, 5307.336582927134, 5331.600129990247, 5292.44429334922, 5297.894042119175, 5308.601854860901, 5315.149576067849, 5319.707416092114, 5056.620753443506, 5070.645054846163, 5193.8961220775755, 5221.660592061542, 5284.128118860383, 5615.859603509945, 5697.829065128011, 5723.341815691166, 5727.599068065237, 5775.88448231033, 6113.908291375633, 6136.877262454771, 6158.815235542941, 6173.41352571505, 6192.597481163755, 6086.543509236781, 6142.161149281699, 6218.409251121137, 6218.81343559694, 6223.190985171944, 5665.405132461074, 5699.401562835884, 5767.826965191051, 5796.072628379481, 5799.927013502515, 6254.749810007549, 6281.654509001957, 6288.151099601587, 6295.527835412271, 6297.622142671455, 5969.522438204933, 5970.104484327386, 6016.849578760479, 6027.60820546663, 6047.15339852421, 6098.908516372258, 6102.0541816018585, 6112.602680825732, 6159.045347971071, 6204.0, 6092.817215483543, 6123.4488895999575, 6160.691965401802, 6160.860240855456, 6190.907136392958, 5981.641101533922, 6148.047052706837, 6149.907751383733, 6168.599041062316, 6179.28938172116, 4655.627549796008, 4674.69614475058, 4676.368690226844, 4718.0328032753205, 4740.976295118502, 4217.915641687149, 4226.218149642326, 4234.830606775756, 4236.406903033578, 4252.4471818664, 5749.396313387034, 5788.942110578924, 5843.561732870052, 5849.590528663038, 5852.268466441695, 6122.755089796358, 6123.679189354777, 6145.539084568675, 6201.255849298022, 6224.097505861625, 5897.616654917417, 5899.056151015817, 5899.557533184942, 5904.4685978261305, 5911.586188966731, 5106.693598384109, 5200.609954253446, 5208.114620514521, 5208.348956380452, 5209.114450543417, 6253.437190652772, 6370.968145159244, 6400.295967443578, 6431.356864313531, 6506.837329066717, 6189.102580125947, 6202.5658203925295, 6232.158658581124, 6243.625382477066, 6246.312905580474, 6230.408111229426, 6306.274778400542, 6454.2900280968115, 6468.126802881739, 6473.514486413632, 6085.117657939485, 6117.553376797925, 6150.753969841336, 6161.568690191643, 6165.6608886509875, 6240.656763877849, 6247.281562620356, 6267.341929097562, 6286.15136956505, 6328.968355158379, 6002.309734380602, 6004.459598636144, 6147.139400484025, 6163.691815409122, 6165.5375846810775, 6014.188084608521, 6056.939430605814, 6096.634201947897, 6096.786612468542, 6126.172966649446, 6008.789692360747, 6014.127951446928, 6019.54853385989, 6029.698515074317, 6046.09308603713, 6013.218281623361, 6063.818085457443, 6123.663198524124, 6131.601445906002, 6157.168782214523, 5923.851903702442, 5981.0729336952845, 5993.041113421831, 6028.638281703112, 6030.396960303934], "value": 5695.918741749013, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.6498101139317, 641.9952773908832, 646.2503495944702, 667.1393901866593, 718.0844423360212, 41309.0, 45810.770946145305, 45874.08251834961, 45906.31140532895, 45958.770206148925, 46863.53136468634, 47224.0, 47432.52567474324, 47653.28520072201, 47778.52221477793, 9007.819843603123, 9151.359404841663, 9198.540072996357, 9203.309751768611, 9205.355625106245, 9139.95430022849, 9221.95389023054, 9269.675561355354, 9309.394889332172, 9309.394889332172, 9298.163165315154, 9300.581473833694, 9319.62721491143, 9334.393264437824, 9370.765730856714, 9314.115159059844, 9330.066993300616, 9330.626774928995, 9377.390469619453, 9379.108984646447, 9163.770905727344, 9179.082091790835, 9202.723918282396, 9272.165505104573, 9283.442993420349, 44253.77873110646, 44872.3269150963, 44916.0, 45104.77447612741, 45262.54737452649, 3944.7041471889725, 3998.620131087542, 4076.9592304077173, 4110.897227569305, 4124.319487284594, 34399.140021499414, 36002.45996310058, 36070.8196459016, 36123.4581481278, 37648.62351376479, 4690.788914498856, 4771.522847715235, 4833.4441539222735, 4846.079244943449, 4910.803567857281, 391342.0, 392166.0, 392293.0, 392989.0, 394056.0, 66827.0, 66853.0, 67123.66438167778, 67290.66354668196, 67376.0, 40336.39495407571, 41221.58778412238, 41476.0, 43671.126577468276, 69661.0, 19757.506062348555, 19844.404667859697, 19895.204191832454, 19965.0, 20044.899775501322, 13813.861861381458, 13821.101628394123, 13907.513237036857, 13942.512012079529, 13954.58136255914, 21104.0, 21172.47068823292, 21375.786242137692, 21444.142234310766, 21713.457163571038, 7846.058472983279, 7976.561289129154, 8089.47418417801, 8133.5526546039355, 8153.266206041485, 1002.0830939690247, 1066.6906597086913, 1114.1866437500669, 1158.212415557429, 1186.104491109207, 31925.52111718326, 33980.660193398246, 34334.313313734085, 34412.311753764785, 34912.0, 1131.7849608574345, 1141.3209140561353, 1155.96532104037, 1198.7063169523522, 1233.6237447578396, 17550.210240539207, 17587.824121758873, 17662.911685441748, 17709.557261068578, 17777.46667599974, 587634.0, 591428.0, 596844.0, 597159.0, 599166.0, 64576.35423645798, 65031.67484162549, 65057.34942650513, 65097.34902651008, 65112.0, 1452.6949340638373, 1469.1185288826832, 1484.161448781435, 1509.230292550807, 1524.1693277163972, 33119.0, 33349.666503335626, 33450.83274583709, 33473.49789753204, 33950.49074263938, 57928.71035644795, 58888.70555647366, 58889.0, 58961.70519147377, 59021.63913443414, 530721.0, 531778.0, 533550.0, 534166.0, 535712.0, 30878.228044298172, 31855.203619909687, 31993.0, 31996.6800332003, 32050.35899282048, 53667.19499207593, 54100.729496352265, 54222.45777542332, 56048.719756400955, 56058.439415606954, 45179.54820451754, 45810.31284530668, 46271.0, 47634.285485718436, 48142.0, 45558.54441455543, 45787.77106114448, 46332.7683361581, 46507.04690101379, 47020.7648961753, 45138.548614513435, 47901.28148077712, 48565.0, 50041.0, 50163.74918125532, 40175.59824401836, 40750.38874416945, 40889.795551022056, 41178.38232426456, 41442.792786035876, 30388.24029399283, 30852.845735771178, 31273.687263127988, 31385.529217061307, 31684.36631267408], "value": 21934.21549834958, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.11073140798914, 407.15108997739713, 426.9380939763734, 431.29698591296193, 438.5395334898358, 20310.89844550777, 20512.89743551282, 21259.19296859767, 21492.0, 21498.0, 16903.816732828676, 19668.0, 20358.796412035874, 20430.69353959688, 20475.180992760274, 5248.895022099565, 5408.323959505062, 5410.1073322901875, 5414.458554144593, 5422.864428389283, 5446.373667028283, 5456.727163641822, 5474.479924407175, 5492.038893193695, 5495.093309603911, 5333.653312534692, 5426.104692725715, 5427.48438898304, 5502.972485137569, 5503.504684578387, 5357.651752636066, 5363.356397232318, 5417.64785288957, 5422.864428389283, 5436.972815135939, 5124.205748109049, 5284.973575132138, 5286.233496143076, 5290.1800220965815, 5291.126964050927, 12011.57959471423, 14872.925635371863, 22813.0, 25040.37399065038, 25129.12048078327, 2464.29767516257, 2485.8632775197357, 2590.520753660579, 2880.8271503709843, 3120.3915236528887, 10685.946570267177, 10966.561337546489, 11797.056235501139, 11884.940575297154, 15791.052536847827, 2028.8174064334132, 2107.725995620575, 2131.6482780341225, 2144.7533533643673, 2145.506533497304, 86638.56680716557, 89182.10817891738, 89510.55244723799, 89590.0, 90546.5472672639, 11447.656570302905, 11529.423528823692, 11590.362530060927, 11770.52917883275, 11776.705582360339, 16380.344786208418, 16399.754003689955, 16429.26068326928, 16454.917725411295, 16464.01215927048, 8702.21680048786, 8869.947923408634, 8920.375573709907, 9050.185483306534, 9103.544822758835, 8609.311255099703, 8696.95651521751, 8707.47755134694, 8896.46621202717, 8925.553722313858, 4884.704189031149, 4947.381577302837, 5034.144195486776, 5052.595792336604, 5090.4728581425425, 2053.8254248389053, 2102.5374417628095, 2121.1091341636547, 2135.903884325209, 2184.5084855907294, 999.2855108597388, 1113.6046703420332, 1113.9053180479589, 1118.3960661243, 1171.244547267025, 20654.690179647318, 20873.34282076255, 20970.47573810667, 21082.472938176667, 21133.894330528557, 1044.3107549017611, 1054.7943151085465, 1067.386252904583, 1077.4612693653173, 1091.3124731419155, 10500.579976800995, 11526.71831644267, 11637.709057273467, 11752.412379380996, 11773.88226117745, 464189.0, 477177.0, 517757.0, 519827.0, 520078.0, 92005.53997229971, 94971.0, 95632.0, 96151.0, 96885.0311496876, 1066.2589500297374, 1100.14738577603, 1125.549780087955, 1132.5356603792407, 1136.1138312116561, 18532.629347413247, 18905.621887562447, 19126.426207213804, 19194.0, 19293.228270869007, 43955.12089758251, 44420.0, 45277.320840188084, 45549.31676024796, 45955.77022114868, 56107.719461402434, 58848.70575647095, 60234.0, 61585.0, 63095.36904630895, 9011.414258073204, 9263.258939284706, 9377.671781487616, 9465.290103242147, 9596.040395960348, 14392.856071439151, 14489.347979341166, 14531.200783956983, 14565.781513277521, 14618.561443156723, 11713.121515886172, 11842.28946263227, 11859.169858110195, 11909.344986025852, 12020.939895300817, 11369.374684392107, 11862.822057669315, 11877.109216808602, 12046.397680115784, 12069.939650301692, 11700.180987330805, 11745.354005529778, 11911.0, 11935.16453848257, 12695.301758403377, 9025.954870225607, 9334.25325973934, 9356.532173391439, 9432.339736218399, 9534.998825123539, 5858.5898987070495, 8847.46915185091, 11384.43077846121, 11433.59982400612, 11506.597269095542], "value": 9621.734332254486, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1536.4084827341474, 1552.1230504764808, 1714.3142742902837, 1780.5548612846787, 1829.7895741989676, 8363.121872203423, 9041.186293233615, 9149.725508234747, 9812.411255324676, 9812.754681132967, 9214.262858971282, 9579.281553883451, 9587.424754514734, 9588.185004274628, 9612.519374031288, 2193.8903054847233, 2217.323716266538, 2218.4121207879925, 2219.2454565447742, 2232.0402227042364, 2449.620308852122, 2486.415692312305, 2487.0797804812155, 2489.041718938213, 2506.0, 2412.6260429633435, 2425.1754403502805, 2437.402836305108, 2451.9754802452017, 2467.469494058777, 2392.3779817247555, 2397.184957114581, 2403.6034054381007, 2405.3505553500545, 2440.2191298784396, 2433.3429973907123, 2441.1944058460667, 2459.508098380313, 2468.679071720665, 2474.2948259745885, 9028.954855225747, 9139.634414623408, 9147.359684822066, 9147.679831205876, 9156.816863662689, 5571.526420254283, 5666.348369937468, 5692.17463467799, 5698.7435565399655, 5720.856978575527, 3725.0, 3740.7942563159017, 3761.492198553188, 3765.6422639849443, 3830.080780612661, 1247.9188852724544, 1249.537671061713, 1260.6785269756244, 1275.79587266037, 1313.1398933698347, 13470.326483675875, 13505.86494135056, 13506.797398039038, 13519.324033798272, 13542.526011589645, 4888.902221955541, 4949.7030178189425, 4961.05739909416, 5002.74986250686, 5119.87200319995, 11197.66407007791, 11307.038901693448, 11307.208495405243, 11317.094632429385, 11330.490127944262, 5615.213870058195, 5632.831015069554, 5649.096144616924, 5661.405552416937, 5665.0, 4474.418325617714, 5109.029284435946, 5109.08036553424, 5145.794168233228, 5180.8963820723375, 4278.850240241639, 4337.566243375637, 4347.478302603708, 4388.868333949923, 4392.0, 1335.6393773681245, 1338.3709656461447, 1339.4374362767467, 1351.8039884216732, 1360.585021568431, 1024.2727663358949, 1033.1373303291834, 1049.4805071489661, 1058.9576416943237, 1062.697131317571, 6328.778492752732, 6409.711562979677, 6450.161479007699, 6525.902111468332, 6601.438877695354, 495.6431369414016, 506.46061944030225, 506.8454121492906, 508.0626244578746, 509.1827616675257, 4447.777611119496, 4491.05687805558, 4500.0, 4529.750863702462, 4560.475545312265, 11546.826797598043, 11753.88246117545, 11839.822402663967, 11849.407529623657, 11926.105542084204, 11187.72030699239, 11706.824397634042, 11788.46951887167, 11811.586594469152, 12159.088068394729, 8839.734807955772, 9075.183233509017, 9084.8637270441, 9094.0, 9094.772630684285, 6516.869662606627, 6757.391834734897, 6819.522633415613, 6838.965805170942, 6855.211650660238, 10634.84047739269, 10889.237753357505, 10959.890401095887, 11023.559057637605, 11079.169062320198, 10834.0, 11092.445377730919, 11232.719182020515, 11232.887671123512, 11338.659840204808, 7724.420668449777, 8188.058373287148, 8410.831783364176, 8489.83020339602, 8614.095519970564, 8934.061923498199, 9027.09729027092, 9036.774080648036, 9069.546522673709, 9110.31672624569, 8129.4715843469985, 8328.0, 8361.874571881548, 8392.622331995197, 8548.145185481402, 7983.1617680142745, 8058.194180581895, 8127.75616731499, 8169.959150204211, 8221.671133154607, 7437.367823735043, 7502.174760776419, 7510.248975102446, 7572.091349038151, 7690.230976902265, 5596.664200148004, 5761.423857614205, 5893.823185304448, 5945.346011938596, 6006.339302676614, 5679.261695979496, 5680.062789639664, 5760.279965004374, 5844.912326315024, 5901.645901245939], "value": 4908.037003583275, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.32946577837663, 348.9092835862676, 350.93858574749413, 353.688753896571, 356.21454692403256, 5795.884082318351, 5798.5361171106315, 5838.737256823442, 5850.0, 5873.442023007813, 5735.827925162242, 5768.682722450274, 5779.913301300484, 5787.755632539003, 5792.160136780164, 3935.762900691309, 4394.758288294142, 4478.552144785528, 4496.504440035796, 4503.211937910869, 4493.752843593601, 4521.819127234907, 4530.161920044786, 4544.227481328166, 4574.9542504574865, 4527.909441811162, 4528.25283828168, 4532.274836026237, 4534.161180181677, 4539.0921815637, 4224.591982569937, 4465.352523884051, 4472.731636101845, 4484.641228701696, 4532.592066713995, 3934.960650393488, 3939.1333906540517, 3939.763614183158, 3949.328614135604, 3970.305196590614, 5686.147077938301, 5708.001099807517, 5712.971435142839, 5716.370834312201, 5727.971360143214, 4917.827876024322, 5109.20807274873, 5187.247849061865, 5188.092083885343, 5241.947580524222, 6022.367651396584, 6083.361247069039, 6105.542084343692, 6119.877602447926, 6120.44915957566, 4364.127174565068, 4384.12317536494, 4401.713888597231, 4403.559644035603, 4412.536683648203, 6150.8769824603705, 6163.198784158076, 6293.590916590453, 6335.493160547145, 6365.140706004677, 4395.7142785718825, 4434.711743736647, 4434.778261086933, 4446.733196008186, 4463.776811159429, 4469.597736203757, 4482.036362182146, 4486.900709326236, 4512.684112112186, 4517.412736344254, 5023.1711767557945, 5174.0, 5184.092783762826, 5206.0, 5216.217567364925, 6140.973478752001, 6169.81490555284, 6182.28903676074, 6185.443310102112, 6191.907121393183, 1560.9843901561067, 1573.2920185916385, 1577.7791109244715, 1579.6919600677988, 1580.083551540127, 975.6097560975667, 991.7074463033423, 999.4702807512031, 1004.9196064314838, 1015.4110615842793, 5120.257562653394, 5181.010621821252, 5195.948040519622, 5233.947660523422, 5323.600729945269, 5473.084420452809, 5489.478499542537, 5500.80747173847, 5527.319250163668, 5546.389897111315, 4915.336429582032, 5173.922391164136, 5221.55616772571, 5246.711430871339, 5250.369955605275, 2960.8815647374295, 2972.75144439336, 2975.895843645462, 2995.666928216966, 3032.3935212957053, 5651.237082993825, 5661.518770904519, 5699.373068962494, 5726.513246374105, 5729.598928075078, 5984.8803023940145, 6438.742450301936, 6483.351664833479, 6490.772822951174, 6512.902306465407, 6613.503987200979, 6620.0, 6629.502787290972, 6670.599764014175, 6737.59574425536, 6231.781887633911, 6328.4053538049175, 6392.369945663826, 6398.616083035033, 6420.6147631142285, 6278.905816412666, 6314.137329487904, 6319.842003949938, 6330.341256672116, 6334.0, 6266.2480502338185, 6402.775902843565, 6514.934850651623, 6534.444572211225, 6539.7384104637185, 4447.7998490067375, 4464.0, 4491.528389519184, 4513.68404211702, 4538.364628951884, 6291.653959032297, 6308.589941653778, 6396.29640739509, 6409.35906409374, 6441.452476539546, 6207.937920620736, 6213.316535181036, 6215.06773983906, 6223.626582405071, 6251.656158911122, 5939.91090133657, 6168.814935551941, 6210.31686514474, 6222.377762223741, 6222.439980401786, 6100.786472473442, 6172.938270617236, 6176.567640265318, 6181.876362472815, 6196.256449225942, 6298.779542715983, 6305.747770089145, 6311.400416960381, 6312.7159277833525, 6319.368063193644, 5829.795957141479, 6070.817875463743, 6097.268327800515, 6108.847278818065, 6119.938800612115], "value": 4586.428050900722, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.0949001353504, 825.4758228524888, 827.0695467598944, 898.991010089899, 925.8703781470591, 16115.113668748214, 16875.40936067238, 16960.151992400362, 17039.14804259788, 17112.14439278034, 15760.369585216578, 15976.760348594751, 16080.919595402007, 16118.75821862673, 16204.432844850433, 706.4313227851577, 859.1151114352227, 882.2192359761625, 893.852514335134, 897.5287973813768, 884.8628462588309, 886.2024178239603, 894.4186278918722, 895.3553441522093, 895.6238379880466, 942.726609283307, 945.9290553208502, 948.0566835998158, 950.1638558068889, 951.1914872358475, 939.4363381970832, 940.9012053734327, 940.920021798148, 942.1520631431766, 942.8444306689388, 689.675852349395, 692.8129405060605, 693.6254422611784, 695.1033167214288, 696.5994553131919, 16357.67284654312, 16445.09551974641, 16497.422590209284, 16501.752473712902, 16514.42199523023, 16429.6714065718, 17077.276812983273, 17280.740788888175, 17707.645847082986, 17865.7320140198, 13537.0, 13740.450381984709, 14088.366023528966, 14150.929245353811, 14179.78730319046, 4218.915621687549, 4240.1307731914885, 4253.957460425387, 4266.637335826458, 4326.740395576276, 91605.08394916033, 91767.0, 92815.0, 94927.52536237275, 98449.50775246078, 11957.641270761891, 12181.634550963485, 12347.135700501058, 13311.40098695561, 13359.799603005962, 25874.482510350063, 25904.22287331383, 26048.609270860954, 26056.218313450627, 26084.217473475826, 9409.90590094104, 9641.0, 9641.0, 9714.271429642664, 10225.642102526524, 5102.290732604545, 5121.0, 5157.535821776059, 5161.380634323905, 5311.601629877775, 3780.4707340972286, 3893.5911729268587, 3901.0637447012514, 3906.4921560196995, 3909.882703518899, 659.0641289369107, 666.4801454865213, 674.8886433738477, 678.8268991407258, 680.6732768271158, 795.7652492514607, 800.279748226589, 817.6811043692845, 818.2962652119173, 827.7227128911882, 10693.144548436107, 10751.569937202425, 11048.281861678965, 11102.389368584805, 11556.711082223012, 761.3186198352554, 767.9001729775205, 799.2127754162145, 803.7066470738256, 817.7138001699476, 5196.029776674938, 5226.555742761831, 5291.51500404715, 5300.628955973122, 5404.702741349263, 93460.53269733743, 131938.34030829783, 132630.0, 133218.0, 136627.31686341504, 93529.5323523378, 94178.0, 116737.0, 118469.0, 119016.40491797659, 90686.54656726673, 90744.0, 92593.5370323144, 94033.52983235176, 94142.5292873545, 10632.362058276529, 10693.679189624323, 10834.512446939749, 10838.458077096271, 10951.726206844893, 50841.49158508368, 51871.0, 52507.21239181339, 52707.51665648198, 53622.73188634032, 71504.0, 71870.64064679643, 80718.0, 82092.0, 82972.17027829644, 14179.809542852776, 14233.786493202817, 14375.568732938029, 14563.635909102357, 14702.41190352374, 16471.67056658884, 16501.752473713143, 16668.08325542107, 16722.0, 17059.829401705825, 14716.264186790831, 15002.474913377979, 15744.527664170093, 16197.109158996369, 16247.350105995627, 14857.40570377216, 15146.848531514985, 15388.461403850812, 15916.602084947968, 16281.918590406973, 11043.558257669603, 13386.263755493152, 14402.42390304418, 14911.105333680014, 15533.611659708598, 12352.75294494123, 12639.557615483414, 13074.150180238254, 13335.133081368422, 13336.866631333562, 12966.740665186455, 12971.156874803108, 13095.476180953036, 13298.072542144248, 13436.126651767603], "value": 8427.51274284497, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1498.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 112.0, 104.0, 111.0, 111.0, 112.0, 110.0, 111.0, 108.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 155.0, 182.0, 116.0, 147.0, 145.0, 119.0, 171.0, 119.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 160.0, 161.0, 162.0, 161.0, 162.0, 162.0, 160.0, 159.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 181.0, 76.0, 76.0, 75.0, 75.0, 164.0, 76.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 143.0, 84.0, 84.0, 84.0, 138.0, 84.0, 82.0, 143.0], "value": 100.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 120.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 148.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 55.0, 53.0, 53.0, 54.0, 58.0, 52.0, 54.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 61.0, 59.0, 59.0, 60.0, 61.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 78.0, 72.0, 76.0, 81.0, 81.0, 72.0, 78.0, 72.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 118.0, 120.0, 128.0, 119.0, 117.0, 120.0, 124.0, 150.0, 121.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 157.0, 158.0, 153.0, 154.0, 153.0, 158.0, 154.0, 157.0, 153.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 63.0, 65.0, 61.0, 61.0, 60.0, 60.0, 62.0], "value": 62.5, "unit": "score"}]}]} 05:28:50 INFO - Return code: 0 05:28:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:28:50 ERROR - # TBPL SUCCESS # 05:28:50 INFO - Running post-action listener: _resource_record_post_action 05:28:50 INFO - [mozharness: 2016-08-23 12:28:50.186634Z] Finished run-tests step (success) 05:28:50 INFO - Running post-run listener: _resource_record_post_run 05:28:50 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8056832; Write bytes: 488591360; Read time: 3488; Write time: 783876 05:28:50 INFO - TinderboxPrint: CPU usage
13.3% 05:28:50 INFO - TinderboxPrint: I/O read bytes / time
8,056,832 / 3,488 05:28:50 INFO - TinderboxPrint: I/O write bytes / time
488,591,360 / 783,876 05:28:50 INFO - TinderboxPrint: CPU idle
8,260.1 (86.7%) 05:28:50 INFO - TinderboxPrint: CPU user
1,198.8 (12.6%) 05:28:50 INFO - TinderboxPrint: Swap in / out
0 / 0 05:28:50 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 79081472; Read time: 428; Write time: 158120 05:28:50 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 5812224; Write bytes: 409509888; Read time: 2852; Write time: 625756 05:28:50 INFO - Running post-run listener: _upload_blobber_files 05:28:50 INFO - Blob upload gear active. 05:28:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:28:50 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 05:28:50 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'] 05:28:50 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 05:28:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:28:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:28:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:28:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:51 INFO - (blobuploader) - INFO - Done attempting. 05:28:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:28:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:28:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:52 INFO - (blobuploader) - INFO - Done attempting. 05:28:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:28:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:28:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:56 INFO - (blobuploader) - INFO - Done attempting. 05:28:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:28:56 INFO - Return code: 0 05:28:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:28:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:28:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65a51f76c43296afd967d323fa8403d84c77d90742876ac96cf954b3c54277a68d2cc65d92960b3321d803fac3f1a7ac05aa8fe741333d79ec492896bf9eea9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26a25f8b58eeb3c17d1cc1e9676530000f4e6bf00892352b919886c4d1f644b671a115a5cff43446cd7c863e5de56df96b61c92d80d7f0b65ecb46a831170038", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2174813bc916f468599cd28c687e64bf975838a33ec28771ba6c6e9a4d8a42ce9a7f63243c95a78c1659362292ff8db8465c7202f3adb2df8ff8719cdb89e8ca"} 05:28:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:28:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:28:56 INFO - Contents: 05:28:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65a51f76c43296afd967d323fa8403d84c77d90742876ac96cf954b3c54277a68d2cc65d92960b3321d803fac3f1a7ac05aa8fe741333d79ec492896bf9eea9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26a25f8b58eeb3c17d1cc1e9676530000f4e6bf00892352b919886c4d1f644b671a115a5cff43446cd7c863e5de56df96b61c92d80d7f0b65ecb46a831170038", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2174813bc916f468599cd28c687e64bf975838a33ec28771ba6c6e9a4d8a42ce9a7f63243c95a78c1659362292ff8db8465c7202f3adb2df8ff8719cdb89e8ca"} 05:28:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:28:56 INFO - Copying logs to upload dir... 05:28:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:28:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1684.211143 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 4 secs) (at 2016-08-23 05:28:56.326799) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 05:28:56.330455) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670 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/65a51f76c43296afd967d323fa8403d84c77d90742876ac96cf954b3c54277a68d2cc65d92960b3321d803fac3f1a7ac05aa8fe741333d79ec492896bf9eea9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26a25f8b58eeb3c17d1cc1e9676530000f4e6bf00892352b919886c4d1f644b671a115a5cff43446cd7c863e5de56df96b61c92d80d7f0b65ecb46a831170038", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2174813bc916f468599cd28c687e64bf975838a33ec28771ba6c6e9a4d8a42ce9a7f63243c95a78c1659362292ff8db8465c7202f3adb2df8ff8719cdb89e8ca"} build_url:https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/UU5ud5VcTOCVkr1af8EoRw/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/65a51f76c43296afd967d323fa8403d84c77d90742876ac96cf954b3c54277a68d2cc65d92960b3321d803fac3f1a7ac05aa8fe741333d79ec492896bf9eea9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26a25f8b58eeb3c17d1cc1e9676530000f4e6bf00892352b919886c4d1f644b671a115a5cff43446cd7c863e5de56df96b61c92d80d7f0b65ecb46a831170038", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2174813bc916f468599cd28c687e64bf975838a33ec28771ba6c6e9a4d8a42ce9a7f63243c95a78c1659362292ff8db8465c7202f3adb2df8ff8719cdb89e8ca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 05:28:56.357730) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 05:28:56.358244) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471952710.64529-908754670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 05:28:56.439281) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 05:28:56.439597) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 05:28:56.439892) ========= ========= Total master_lag: 0.21 =========