builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1471339929.77 results: success (0) buildid: 20160816004012 builduid: 48261218acdb4fdba2ab509b6db394cd revision: c16b845d20803e1d4e785b144ffd63e9545eb16b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 02:32:09.775468) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 02:32:09.775881) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 02:32:09.776161) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 02:32:09.798107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 02:32:09.798373) ========= 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=ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 02:32:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.3M=0s 2016-08-16 02:32:10 (32.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153868 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 02:32:09.967627) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 02:32:09.967915) ========= 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=ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022855 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 02:32:10.016930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 02:32:10.017245) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c16b845d20803e1d4e785b144ffd63e9545eb16b --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 c16b845d20803e1d4e785b144ffd63e9545eb16b --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=ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 02:32:10,453 truncating revision to first 12 chars 2016-08-16 02:32:10,453 Setting DEBUG logging. 2016-08-16 02:32:10,453 attempt 1/10 2016-08-16 02:32:10,453 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c16b845d2080?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 02:32:10,754 unpacking tar archive at: mozilla-aurora-c16b845d2080/testing/mozharness/ program finished with exit code 0 elapsedTime=0.710243 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 02:32:10.740366) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 02:32:10.740647) ========= script_repo_revision: c16b845d20803e1d4e785b144ffd63e9545eb16b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 02:32:10.741018) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 02:32:10.741287) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 02:32:10.751560) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 0 secs) (at 2016-08-16 02:32:10.751828) ========= /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=ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:32:11 INFO - MultiFileLogger online at 20160816 02:32:11 in /builds/slave/test 02:32:11 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 02:32:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:32:11 INFO - {'append_to_log': False, 02:32:11 INFO - 'base_work_dir': '/builds/slave/test', 02:32:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:32:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:32:11 INFO - 'branch': 'Mozilla-Aurora', 02:32:11 INFO - 'buildbot_json_path': 'buildprops.json', 02:32:11 INFO - 'config_files': ('talos/linux_config.py',), 02:32:11 INFO - 'default_actions': ('clobber', 02:32:11 INFO - 'read-buildbot-config', 02:32:11 INFO - 'download-and-extract', 02:32:11 INFO - 'populate-webroot', 02:32:11 INFO - 'create-virtualenv', 02:32:11 INFO - 'install', 02:32:11 INFO - 'run-tests'), 02:32:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:32:11 INFO - 'download_minidump_stackwalk': True, 02:32:11 INFO - 'download_symbols': 'ondemand', 02:32:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:32:11 INFO - 'tooltool.py': '/tools/tooltool.py', 02:32:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:32:11 INFO - '/tools/misc-python/virtualenv.py')}, 02:32:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:32:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:32:11 INFO - 'installer_path': 'installer.exe', 02:32:11 INFO - 'log_level': 'info', 02:32:11 INFO - 'log_name': 'talos', 02:32:11 INFO - 'log_to_console': True, 02:32:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:32:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:32:11 INFO - 'opt_config_files': (), 02:32:11 INFO - 'pip_index': False, 02:32:11 INFO - 'sps_profile': False, 02:32:11 INFO - 'sps_profile_interval': 0, 02:32:11 INFO - 'suite': 'dromaeojs-e10s', 02:32:11 INFO - 'system_bits': '32', 02:32:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:32:11 INFO - 'title': 'talos-linux64-ix-035', 02:32:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:32:11 INFO - 'use_talos_json': True, 02:32:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:32:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:32:11 INFO - 'work_dir': 'build'} 02:32:11 INFO - [mozharness: 2016-08-16 09:32:11.277361Z] Running clobber step. 02:32:11 INFO - Running pre-action listener: _resource_record_pre_action 02:32:11 INFO - Running main action method: clobber 02:32:11 INFO - rmtree: /builds/slave/test/build 02:32:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:32:12 INFO - Running post-action listener: _resource_record_post_action 02:32:12 INFO - [mozharness: 2016-08-16 09:32:12.250677Z] Finished clobber step (success) 02:32:12 INFO - [mozharness: 2016-08-16 09:32:12.250778Z] Running read-buildbot-config step. 02:32:12 INFO - Running pre-action listener: _resource_record_pre_action 02:32:12 INFO - Running main action method: read_buildbot_config 02:32:12 INFO - Using buildbot properties: 02:32:12 INFO - { 02:32:12 INFO - "project": "", 02:32:12 INFO - "product": "firefox", 02:32:12 INFO - "script_repo_revision": "production", 02:32:12 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 02:32:12 INFO - "repository": "", 02:32:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 02:32:12 INFO - "buildid": "20160816004012", 02:32:12 INFO - "stage_platform": "linux64-pgo", 02:32:12 INFO - "basedir": "/builds/slave/test", 02:32:12 INFO - "nightly_build": "True", 02:32:12 INFO - "buildnumber": 501, 02:32:12 INFO - "slavename": "talos-linux64-ix-035", 02:32:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:32:12 INFO - "platform": "ubuntu64_hw", 02:32:12 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:32:12 INFO - "branch": "mozilla-aurora", 02:32:12 INFO - "repo_path": "releases/mozilla-aurora", 02:32:12 INFO - "revision": "c16b845d20803e1d4e785b144ffd63e9545eb16b", 02:32:12 INFO - "pgo_build": "True", 02:32:12 INFO - "builduid": "48261218acdb4fdba2ab509b6db394cd", 02:32:12 INFO - "slavebuilddir": "test" 02:32:12 INFO - } 02:32:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 02:32:12 INFO - Running post-action listener: _resource_record_post_action 02:32:12 INFO - [mozharness: 2016-08-16 09:32:12.253600Z] Finished read-buildbot-config step (success) 02:32:12 INFO - [mozharness: 2016-08-16 09:32:12.253690Z] Running download-and-extract step. 02:32:12 INFO - Running pre-action listener: _resource_record_pre_action 02:32:12 INFO - Running main action method: download_and_extract 02:32:12 INFO - mkdir: /builds/slave/test/build/tests 02:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:12 INFO - https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:32:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 02:32:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 02:32:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:32:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:32:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 02:32:12 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 02:32:12 INFO - retry: Failed, sleeping 30 seconds before retrying 02:32:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:32:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 02:32:42 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 02:32:42 INFO - retry: Failed, sleeping 60 seconds before retrying 02:33:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:33:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 02:33:42 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 02:33:42 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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! 02:33:42 INFO - Caught exception: HTTP Error 404: Not Found 02:33:42 INFO - Caught exception: HTTP Error 404: Not Found 02:33:42 INFO - Caught exception: HTTP Error 404: Not Found 02:33:42 INFO - trying https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 02:33:42 INFO - Downloading https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:33:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:33:42 INFO - Downloaded 1361 bytes. 02:33:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 02:33:42 INFO - Using the following test package requirements: 02:33:42 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 02:33:42 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:33:42 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:33:42 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:42 INFO - u'jsshell-linux-x86_64.zip'], 02:33:42 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:33:42 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 02:33:42 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:33:42 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:33:42 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:33:42 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 02:33:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:33:42 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:42 INFO - https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:33:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:33:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:33:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:33:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:33:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:33:42 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 02:33:42 INFO - retry: Failed, sleeping 30 seconds before retrying 02:34:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:34:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:34:12 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 02:34:12 INFO - retry: Failed, sleeping 60 seconds before retrying 02:35:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:35:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:35:13 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 02:35:13 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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! 02:35:13 INFO - Caught exception: HTTP Error 404: Not Found 02:35:13 INFO - Caught exception: HTTP Error 404: Not Found 02:35:13 INFO - Caught exception: HTTP Error 404: Not Found 02:35:13 INFO - trying https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:35:13 INFO - Downloading https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:35:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:35:13 INFO - Downloaded 21766636 bytes. 02:35:13 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'] 02:35:13 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 02:35:15 INFO - Return code: 0 02:35:15 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 02:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:15 INFO - https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:35:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:35:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:35:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:35:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:35:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:35:15 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 02:35:15 INFO - retry: Failed, sleeping 30 seconds before retrying 02:35:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:35:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:35:45 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 02:35:45 INFO - retry: Failed, sleeping 60 seconds before retrying 02:36:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:36:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:36:45 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 02:36:45 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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! 02:36:45 INFO - Caught exception: HTTP Error 404: Not Found 02:36:45 INFO - Caught exception: HTTP Error 404: Not Found 02:36:45 INFO - Caught exception: HTTP Error 404: Not Found 02:36:45 INFO - trying https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:36:45 INFO - Downloading https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:36:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:36:46 INFO - Downloaded 21766636 bytes. 02:36:46 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'] 02:36:46 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 02:36:47 INFO - Return code: 0 02:36: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')]} 02:36:47 INFO - https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:36:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 02:36:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 02:36:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:36:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:36:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 02:36:47 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 02:36:47 INFO - retry: Failed, sleeping 30 seconds before retrying 02:37:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:37:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 02:37:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 02:37:17 INFO - retry: Failed, sleeping 60 seconds before retrying 02:38:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:38:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 02:38:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 02:38:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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! 02:38:17 INFO - Caught exception: HTTP Error 404: Not Found 02:38:17 INFO - Caught exception: HTTP Error 404: Not Found 02:38:17 INFO - Caught exception: HTTP Error 404: Not Found 02:38:17 INFO - trying https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 02:38:17 INFO - Downloading https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:38:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:38:18 INFO - Downloaded 14413723 bytes. 02:38:18 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'] 02:38:18 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 02:38:18 INFO - Return code: 0 02:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:18 INFO - https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:38:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 02:38:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 02:38:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:38:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:38:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 02:38:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 02:38:18 INFO - retry: Failed, sleeping 30 seconds before retrying 02:38:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:38:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 02:38:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 02:38:48 INFO - retry: Failed, sleeping 60 seconds before retrying 02:39:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:39:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 02:39:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 02:39:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFbudK1FRnyeFqh_BSQqlA/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! 02:39:48 INFO - Caught exception: HTTP Error 404: Not Found 02:39:48 INFO - Caught exception: HTTP Error 404: Not Found 02:39:48 INFO - Caught exception: HTTP Error 404: Not Found 02:39:48 INFO - trying https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 02:39:48 INFO - Downloading https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:39:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/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 02:39:51 INFO - Downloaded 63747872 bytes. 02:39:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 02:39:51 INFO - mkdir: /builds/slave/test/properties 02:39:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:39:51 INFO - Writing to file /builds/slave/test/properties/build_url 02:39:51 INFO - Contents: 02:39:51 INFO - build_url:https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 02:39:51 INFO - Running post-action listener: _resource_record_post_action 02:39:51 INFO - Running post-action listener: set_extra_try_arguments 02:39:51 INFO - [mozharness: 2016-08-16 09:39:51.633884Z] Finished download-and-extract step (success) 02:39:51 INFO - [mozharness: 2016-08-16 09:39:51.634118Z] Running populate-webroot step. 02:39:51 INFO - Running pre-action listener: _resource_record_pre_action 02:39:51 INFO - Running main action method: populate_webroot 02:39:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:39:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:39:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:39:51 INFO - '--tppagecycles', 02:39:51 INFO - '7'], 02:39:51 INFO - 'tests': ['tsvgm']}}, 02:39:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:39:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:39:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:39:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:39:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:39:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:39:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:51 INFO - 'talos_options': ['--disable-e10s'], 02:39:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:51 INFO - 'talos_options': ['--disable-e10s'], 02:39:51 INFO - 'tests': ['damp', 'tps']}, 02:39:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:51 INFO - 'tests': ['damp', 'tps']}, 02:39:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:39:51 INFO - 'tests': ['dromaeo_dom']}, 02:39:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:39:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:39:51 INFO - 'tests': ['basic_compositor_video']}, 02:39:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:39:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:39:51 INFO - 'tests': ['a11yr', 02:39:51 INFO - 'ts_paint', 02:39:51 INFO - 'tpaint', 02:39:51 INFO - 'sessionrestore', 02:39:51 INFO - 'sessionrestore_no_auto_restore', 02:39:51 INFO - 'tabpaint']}, 02:39:51 INFO - 'other-e10s': {'tests': ['a11yr', 02:39:51 INFO - 'ts_paint', 02:39:51 INFO - 'tpaint', 02:39:51 INFO - 'sessionrestore', 02:39:51 INFO - 'sessionrestore_no_auto_restore', 02:39:51 INFO - 'tabpaint']}, 02:39:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:39:51 INFO - 'ts_paint', 02:39:51 INFO - 'tpaint', 02:39:51 INFO - 'sessionrestore', 02:39:51 INFO - 'sessionrestore_no_auto_restore', 02:39:51 INFO - 'tabpaint']}, 02:39:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:39:51 INFO - 'ts_paint', 02:39:51 INFO - 'tpaint', 02:39:51 INFO - 'sessionrestore', 02:39:51 INFO - 'sessionrestore_no_auto_restore', 02:39:51 INFO - 'tabpaint']}, 02:39:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:39:51 INFO - 'tests': ['a11yr', 02:39:51 INFO - 'ts_paint', 02:39:51 INFO - 'tpaint', 02:39:51 INFO - 'sessionrestore', 02:39:51 INFO - 'sessionrestore_no_auto_restore', 02:39:51 INFO - 'tabpaint']}, 02:39:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:39:51 INFO - 'tests': ['a11yr', 02:39:51 INFO - 'ts_paint', 02:39:51 INFO - 'tpaint', 02:39:51 INFO - 'sessionrestore', 02:39:51 INFO - 'sessionrestore_no_auto_restore', 02:39:51 INFO - 'tabpaint']}, 02:39:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:39:51 INFO - 'tests': ['tsvgx', 02:39:51 INFO - 'tsvgr_opacity', 02:39:51 INFO - 'tart', 02:39:51 INFO - 'tscrollx', 02:39:51 INFO - 'cart']}, 02:39:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:39:51 INFO - 'tsvgr_opacity', 02:39:51 INFO - 'tart', 02:39:51 INFO - 'tscrollx', 02:39:51 INFO - 'cart']}, 02:39:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:51 INFO - 'talos_options': ['--disable-e10s'], 02:39:51 INFO - 'tests': ['tp5o']}, 02:39:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:51 INFO - 'tests': ['tp5o']}, 02:39:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:51 INFO - 'talos_options': ['--disable-e10s', 02:39:51 INFO - '--xperf_path', 02:39:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:51 INFO - 'tests': ['tp5n']}, 02:39:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:51 INFO - 'talos_options': ['--xperf_path', 02:39:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:51 INFO - 'tests': ['tp5n']}}, 02:39:51 INFO - 'talos.zip': {'path': '', 02:39:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:39:51 INFO - Running post-action listener: _resource_record_post_action 02:39:51 INFO - [mozharness: 2016-08-16 09:39:51.651409Z] Finished populate-webroot step (success) 02:39:51 INFO - [mozharness: 2016-08-16 09:39:51.651498Z] Running create-virtualenv step. 02:39:51 INFO - Running pre-action listener: _resource_record_pre_action 02:39:51 INFO - Running main action method: create_virtualenv 02:39:51 INFO - Creating virtualenv /builds/slave/test/build/venv 02:39:51 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 02:39:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:39:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:39:51 INFO - Using real prefix '/usr' 02:39:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:39:52 INFO - Installing distribute.............................................................................................................................................................................................done. 02:39:54 INFO - Installing pip.................done. 02:39:54 INFO - Return code: 0 02:39:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:54 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 0x12b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1575570>, '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 0x1576470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1576900>, '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': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', '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 02:39:54 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 02:39:54 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 02:39:54 INFO - Using env: {'DISPLAY': ':0', 02:39:54 INFO - 'HOME': '/home/cltbld', 02:39:54 INFO - 'LANG': 'en_US.UTF-8', 02:39:54 INFO - 'LANGUAGE': 'en_US:en', 02:39:54 INFO - 'LOGNAME': 'cltbld', 02:39:54 INFO - 'MAIL': '/var/mail/cltbld', 02:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:54 INFO - 'MOZ_NO_REMOTE': '1', 02:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:54 INFO - 'NO_EM_RESTART': '1', 02:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:54 INFO - 'PWD': '/builds/slave/test', 02:39:54 INFO - 'SHELL': '/bin/bash', 02:39:54 INFO - 'SHLVL': '1', 02:39:54 INFO - 'TERM': 'linux', 02:39:54 INFO - 'TMOUT': '86400', 02:39:54 INFO - 'USER': 'cltbld', 02:39:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', 02:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:54 INFO - '_': '/tools/buildbot/bin/python'} 02:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:54 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 02:39:54 INFO - Cleaning up... 02:39:54 INFO - Return code: 0 02:39:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:54 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 0x12b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1575570>, '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 0x1576470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1576900>, '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': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', '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 02:39:54 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 02:39:54 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 02:39:54 INFO - Using env: {'DISPLAY': ':0', 02:39:54 INFO - 'HOME': '/home/cltbld', 02:39:54 INFO - 'LANG': 'en_US.UTF-8', 02:39:54 INFO - 'LANGUAGE': 'en_US:en', 02:39:54 INFO - 'LOGNAME': 'cltbld', 02:39:54 INFO - 'MAIL': '/var/mail/cltbld', 02:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:54 INFO - 'MOZ_NO_REMOTE': '1', 02:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:54 INFO - 'NO_EM_RESTART': '1', 02:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:54 INFO - 'PWD': '/builds/slave/test', 02:39:54 INFO - 'SHELL': '/bin/bash', 02:39:54 INFO - 'SHLVL': '1', 02:39:54 INFO - 'TERM': 'linux', 02:39:54 INFO - 'TMOUT': '86400', 02:39:54 INFO - 'USER': 'cltbld', 02:39:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', 02:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:54 INFO - '_': '/tools/buildbot/bin/python'} 02:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:54 INFO - Downloading/unpacking psutil>=3.1.1 02:39:54 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 02:39:54 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 02:39:54 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 02:39:54 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 02:39:54 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 02:39:54 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 02:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:39:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:56 INFO - Installing collected packages: psutil 02:39:56 INFO - Running setup.py install for psutil 02:39:56 INFO - building 'psutil._psutil_linux' extension 02:39:56 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 02:39:56 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 02:39:56 INFO - building 'psutil._psutil_posix' extension 02:39:56 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 02:39:57 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 02:39:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:57 INFO - Successfully installed psutil 02:39:57 INFO - Cleaning up... 02:39:57 INFO - Return code: 0 02:39:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1575570>, '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 0x1576470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1576900>, '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': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', '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 02:39:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:39:57 INFO - Using env: {'DISPLAY': ':0', 02:39:57 INFO - 'HOME': '/home/cltbld', 02:39:57 INFO - 'LANG': 'en_US.UTF-8', 02:39:57 INFO - 'LANGUAGE': 'en_US:en', 02:39:57 INFO - 'LOGNAME': 'cltbld', 02:39:57 INFO - 'MAIL': '/var/mail/cltbld', 02:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:57 INFO - 'MOZ_NO_REMOTE': '1', 02:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:57 INFO - 'NO_EM_RESTART': '1', 02:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:57 INFO - 'PWD': '/builds/slave/test', 02:39:57 INFO - 'SHELL': '/bin/bash', 02:39:57 INFO - 'SHLVL': '1', 02:39:57 INFO - 'TERM': 'linux', 02:39:57 INFO - 'TMOUT': '86400', 02:39:57 INFO - 'USER': 'cltbld', 02:39:57 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', 02:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:57 INFO - '_': '/tools/buildbot/bin/python'} 02:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:39:59 INFO - Installing collected packages: mozsystemmonitor 02:39:59 INFO - Running setup.py install for mozsystemmonitor 02:39:59 INFO - Successfully installed mozsystemmonitor 02:39:59 INFO - Cleaning up... 02:39:59 INFO - Return code: 0 02:39:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:39: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')]} 02:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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')]} 02:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:59 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 0x12b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1575570>, '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 0x1576470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1576900>, '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': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', '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 02:39:59 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 02:39:59 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 02:39:59 INFO - Using env: {'DISPLAY': ':0', 02:39:59 INFO - 'HOME': '/home/cltbld', 02:39:59 INFO - 'LANG': 'en_US.UTF-8', 02:39:59 INFO - 'LANGUAGE': 'en_US:en', 02:39:59 INFO - 'LOGNAME': 'cltbld', 02:39:59 INFO - 'MAIL': '/var/mail/cltbld', 02:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:59 INFO - 'MOZ_NO_REMOTE': '1', 02:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:59 INFO - 'NO_EM_RESTART': '1', 02:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:59 INFO - 'PWD': '/builds/slave/test', 02:39:59 INFO - 'SHELL': '/bin/bash', 02:39:59 INFO - 'SHLVL': '1', 02:39:59 INFO - 'TERM': 'linux', 02:39:59 INFO - 'TMOUT': '86400', 02:39:59 INFO - 'USER': 'cltbld', 02:39:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', 02:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:59 INFO - '_': '/tools/buildbot/bin/python'} 02:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:59 INFO - Downloading/unpacking jsonschema==2.5.1 02:39:59 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 02:39:59 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 02:39:59 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 02:39:59 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 02:39:59 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 02:39:59 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 02:40:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:40:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:40:01 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 02:40:01 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 02:40:01 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 02:40:01 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 02:40:01 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 02:40:01 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 02:40:01 INFO - Downloading functools32-3.2.3-2.tar.gz 02:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:40:01 INFO - warning: no files found matching '*.txt' 02:40:01 INFO - no previously-included directories found matching 'build' 02:40:01 INFO - no previously-included directories found matching 'dist' 02:40:01 INFO - no previously-included directories found matching '.git*' 02:40:01 INFO - Installing collected packages: jsonschema, functools32 02:40:01 INFO - Running setup.py install for functools32 02:40:02 INFO - warning: no files found matching '*.txt' 02:40:02 INFO - no previously-included directories found matching 'build' 02:40:02 INFO - no previously-included directories found matching 'dist' 02:40:02 INFO - no previously-included directories found matching '.git*' 02:40:02 INFO - Successfully installed jsonschema functools32 02:40:02 INFO - Cleaning up... 02:40:02 INFO - Return code: 0 02:40:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1575570>, '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 0x1576470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1576900>, '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': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', '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 02:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:40:02 INFO - Using env: {'DISPLAY': ':0', 02:40:02 INFO - 'HOME': '/home/cltbld', 02:40:02 INFO - 'LANG': 'en_US.UTF-8', 02:40:02 INFO - 'LANGUAGE': 'en_US:en', 02:40:02 INFO - 'LOGNAME': 'cltbld', 02:40:02 INFO - 'MAIL': '/var/mail/cltbld', 02:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:02 INFO - 'MOZ_NO_REMOTE': '1', 02:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:02 INFO - 'NO_EM_RESTART': '1', 02:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:02 INFO - 'PWD': '/builds/slave/test', 02:40:02 INFO - 'SHELL': '/bin/bash', 02:40:02 INFO - 'SHLVL': '1', 02:40:02 INFO - 'TERM': 'linux', 02:40:02 INFO - 'TMOUT': '86400', 02:40:02 INFO - 'USER': 'cltbld', 02:40:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', 02:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:02 INFO - '_': '/tools/buildbot/bin/python'} 02:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:40:02 INFO - Cleaning up... 02:40:02 INFO - Return code: 0 02:40:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1575570>, '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 0x1576470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1576900>, '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': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', '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 02:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:40:02 INFO - Using env: {'DISPLAY': ':0', 02:40:02 INFO - 'HOME': '/home/cltbld', 02:40:02 INFO - 'LANG': 'en_US.UTF-8', 02:40:02 INFO - 'LANGUAGE': 'en_US:en', 02:40:02 INFO - 'LOGNAME': 'cltbld', 02:40:02 INFO - 'MAIL': '/var/mail/cltbld', 02:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:02 INFO - 'MOZ_NO_REMOTE': '1', 02:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:02 INFO - 'NO_EM_RESTART': '1', 02:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:02 INFO - 'PWD': '/builds/slave/test', 02:40:02 INFO - 'SHELL': '/bin/bash', 02:40:02 INFO - 'SHLVL': '1', 02:40:02 INFO - 'TERM': 'linux', 02:40:02 INFO - 'TMOUT': '86400', 02:40:02 INFO - 'USER': 'cltbld', 02:40:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', 02:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:02 INFO - '_': '/tools/buildbot/bin/python'} 02:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:02 INFO - Downloading/unpacking blobuploader==1.2.4 02:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:04 INFO - Downloading blobuploader-1.2.4.tar.gz 02:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:40:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:40:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:40:05 INFO - Downloading docopt-0.6.1.tar.gz 02:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:40:05 INFO - Installing collected packages: blobuploader, requests, docopt 02:40:05 INFO - Running setup.py install for blobuploader 02:40:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:40:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:40:05 INFO - Running setup.py install for requests 02:40:05 INFO - Running setup.py install for docopt 02:40:05 INFO - Successfully installed blobuploader requests docopt 02:40:05 INFO - Cleaning up... 02:40:05 INFO - Return code: 0 02:40:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:05 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 0x12b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1575570>, '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 0x1576470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1576900>, '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': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', '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 02:40:05 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 02:40:05 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 02:40:05 INFO - Using env: {'DISPLAY': ':0', 02:40:05 INFO - 'HOME': '/home/cltbld', 02:40:05 INFO - 'LANG': 'en_US.UTF-8', 02:40:05 INFO - 'LANGUAGE': 'en_US:en', 02:40:05 INFO - 'LOGNAME': 'cltbld', 02:40:05 INFO - 'MAIL': '/var/mail/cltbld', 02:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:05 INFO - 'MOZ_NO_REMOTE': '1', 02:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:05 INFO - 'NO_EM_RESTART': '1', 02:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:05 INFO - 'PWD': '/builds/slave/test', 02:40:05 INFO - 'SHELL': '/bin/bash', 02:40:05 INFO - 'SHLVL': '1', 02:40:05 INFO - 'TERM': 'linux', 02:40:05 INFO - 'TMOUT': '86400', 02:40:05 INFO - 'USER': 'cltbld', 02:40:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', 02:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:05 INFO - '_': '/tools/buildbot/bin/python'} 02:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:40:06 INFO - Running setup.py (path:/tmp/pip-i71j_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:40:06 INFO - Running setup.py (path:/tmp/pip-d0DCui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:40:06 INFO - Running setup.py (path:/tmp/pip-Mkd0mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:40:06 INFO - Running setup.py (path:/tmp/pip-fcVoNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:40:06 INFO - Running setup.py (path:/tmp/pip-4o_HnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:40:06 INFO - Running setup.py (path:/tmp/pip-fuuDhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:40:06 INFO - Running setup.py (path:/tmp/pip-jD0YTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:40:06 INFO - Running setup.py (path:/tmp/pip-cXqOXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:40:06 INFO - Running setup.py (path:/tmp/pip-ydL9Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:40:06 INFO - Running setup.py (path:/tmp/pip-nEIltj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:40:06 INFO - Running setup.py (path:/tmp/pip-C9tYJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:40:06 INFO - Running setup.py (path:/tmp/pip-M64_GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:40:06 INFO - Running setup.py (path:/tmp/pip-b4BkFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:40:06 INFO - Running setup.py (path:/tmp/pip-UudRQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:07 INFO - Running setup.py (path:/tmp/pip-o5Bn1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:40:07 INFO - Running setup.py (path:/tmp/pip-9DSlVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:40:07 INFO - Running setup.py (path:/tmp/pip-yUQALE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:40:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:40:07 INFO - Running setup.py install for manifestparser 02:40:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:40:07 INFO - Running setup.py install for mozcrash 02:40:07 INFO - Running setup.py install for mozdebug 02:40:07 INFO - Running setup.py install for mozdevice 02:40:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:40:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:40:07 INFO - Running setup.py install for mozfile 02:40:07 INFO - Running setup.py install for mozhttpd 02:40:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:40:07 INFO - Running setup.py install for mozinfo 02:40:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:40:07 INFO - Running setup.py install for mozInstall 02:40:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:40:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:40:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:40:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:40:08 INFO - Running setup.py install for mozleak 02:40:08 INFO - Running setup.py install for mozlog 02:40:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:40:08 INFO - Running setup.py install for moznetwork 02:40:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:40:08 INFO - Running setup.py install for mozprocess 02:40:08 INFO - Running setup.py install for mozprofile 02:40:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:40:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:40:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:40:08 INFO - Running setup.py install for mozrunner 02:40:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:40:08 INFO - Running setup.py install for mozscreenshot 02:40:08 INFO - Running setup.py install for moztest 02:40:08 INFO - Running setup.py install for mozversion 02:40:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:40:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:40:09 INFO - Cleaning up... 02:40:09 INFO - Return code: 0 02:40:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:09 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')]} 02:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:09 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')]} 02:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:09 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 0x12b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1575570>, '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 0x1576470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1576900>, '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': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', '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 02:40:09 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 02:40:09 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 02:40:09 INFO - Using env: {'DISPLAY': ':0', 02:40:09 INFO - 'HOME': '/home/cltbld', 02:40:09 INFO - 'LANG': 'en_US.UTF-8', 02:40:09 INFO - 'LANGUAGE': 'en_US:en', 02:40:09 INFO - 'LOGNAME': 'cltbld', 02:40:09 INFO - 'MAIL': '/var/mail/cltbld', 02:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:09 INFO - 'MOZ_NO_REMOTE': '1', 02:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:09 INFO - 'NO_EM_RESTART': '1', 02:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:09 INFO - 'PWD': '/builds/slave/test', 02:40:09 INFO - 'SHELL': '/bin/bash', 02:40:09 INFO - 'SHLVL': '1', 02:40:09 INFO - 'TERM': 'linux', 02:40:09 INFO - 'TMOUT': '86400', 02:40:09 INFO - 'USER': 'cltbld', 02:40:09 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', 02:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:09 INFO - '_': '/tools/buildbot/bin/python'} 02:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:40:09 INFO - Running setup.py (path:/tmp/pip-P5zdG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:40:09 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)) 02:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:40:09 INFO - Running setup.py (path:/tmp/pip-1ldhQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:40:09 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)) 02:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:40:09 INFO - Running setup.py (path:/tmp/pip-LnJH5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:40:09 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)) 02:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:40:09 INFO - Running setup.py (path:/tmp/pip-ZX3z92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:40:09 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)) 02:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:40:09 INFO - Running setup.py (path:/tmp/pip-EiJZtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:40:09 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)) 02:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:40:09 INFO - Running setup.py (path:/tmp/pip-UPHyIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:40:09 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)) 02:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:40:09 INFO - Running setup.py (path:/tmp/pip-LVmWdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:40:09 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)) 02:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:40:09 INFO - Running setup.py (path:/tmp/pip-DAD55s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:40:09 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)) 02:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:40:09 INFO - Running setup.py (path:/tmp/pip-TKkzLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:40:09 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)) 02:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:40:09 INFO - Running setup.py (path:/tmp/pip-PvShXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:40:10 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)) 02:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:40:10 INFO - Running setup.py (path:/tmp/pip-WAJ6n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:40:10 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)) 02:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:40:10 INFO - Running setup.py (path:/tmp/pip-qlGc4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:40:10 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)) 02:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:40:10 INFO - Running setup.py (path:/tmp/pip-UH4E91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:40:10 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)) 02:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:40:10 INFO - Running setup.py (path:/tmp/pip-CdnhDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:40:10 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)) 02:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:10 INFO - Running setup.py (path:/tmp/pip-dYN967-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:40:10 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)) 02:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:40:10 INFO - Running setup.py (path:/tmp/pip-f_rzwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:40:10 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)) 02:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:40:10 INFO - Running setup.py (path:/tmp/pip-Ta60Y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:40:10 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)) 02:40:10 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)) 02:40:10 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)) 02:40:10 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)) 02:40:10 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)) 02:40:10 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)) 02:40:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:40:10 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 02:40:10 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 02:40:10 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 02:40:10 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 02:40:10 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 02:40:10 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 02:40:12 INFO - Downloading blessings-1.6.tar.gz 02:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:40:12 INFO - Installing collected packages: blessings 02:40:12 INFO - Running setup.py install for blessings 02:40:12 INFO - Successfully installed blessings 02:40:12 INFO - Cleaning up... 02:40:12 INFO - Return code: 0 02:40:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:40:12 INFO - Reading from file tmpfile_stdout 02:40:12 INFO - Current package versions: 02:40:12 INFO - argparse == 1.2.1 02:40:12 INFO - blessings == 1.6 02:40:12 INFO - blobuploader == 1.2.4 02:40:12 INFO - docopt == 0.6.1 02:40:12 INFO - functools32 == 3.2.3-2 02:40:12 INFO - jsonschema == 2.5.1 02:40:12 INFO - manifestparser == 1.1 02:40:12 INFO - mozInstall == 1.12 02:40:12 INFO - mozcrash == 0.17 02:40:12 INFO - mozdebug == 0.1 02:40:12 INFO - mozdevice == 0.48 02:40:12 INFO - mozfile == 1.2 02:40:12 INFO - mozhttpd == 0.7 02:40:12 INFO - mozinfo == 0.9 02:40:12 INFO - mozleak == 0.1 02:40:12 INFO - mozlog == 3.3 02:40:12 INFO - moznetwork == 0.27 02:40:12 INFO - mozprocess == 0.23 02:40:12 INFO - mozprofile == 0.28 02:40:12 INFO - mozrunner == 6.12 02:40:12 INFO - mozscreenshot == 0.1 02:40:12 INFO - mozsystemmonitor == 0.3 02:40:12 INFO - moztest == 0.7 02:40:12 INFO - mozversion == 1.4 02:40:12 INFO - psutil == 3.1.1 02:40:12 INFO - requests == 1.2.3 02:40:12 INFO - wsgiref == 0.1.2 02:40:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:12 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 0x12b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1575570>, '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 0x1576470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1576900>, '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': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', '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 02:40:12 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 02:40:12 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 02:40:12 INFO - Using env: {'DISPLAY': ':0', 02:40:12 INFO - 'HOME': '/home/cltbld', 02:40:12 INFO - 'LANG': 'en_US.UTF-8', 02:40:12 INFO - 'LANGUAGE': 'en_US:en', 02:40:12 INFO - 'LOGNAME': 'cltbld', 02:40:12 INFO - 'MAIL': '/var/mail/cltbld', 02:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:12 INFO - 'MOZ_NO_REMOTE': '1', 02:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:12 INFO - 'NO_EM_RESTART': '1', 02:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:12 INFO - 'PWD': '/builds/slave/test', 02:40:12 INFO - 'SHELL': '/bin/bash', 02:40:12 INFO - 'SHLVL': '1', 02:40:12 INFO - 'TERM': 'linux', 02:40:12 INFO - 'TMOUT': '86400', 02:40:12 INFO - 'USER': 'cltbld', 02:40:12 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', 02:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:12 INFO - '_': '/tools/buildbot/bin/python'} 02:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:13 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)) 02:40:13 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)) 02:40:13 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)) 02:40:13 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)) 02:40:13 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)) 02:40:13 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)) 02:40:13 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)) 02:40:13 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)) 02:40:13 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)) 02:40:13 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)) 02:40:13 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)) 02:40:13 INFO - Cleaning up... 02:40:13 INFO - Return code: 0 02:40:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:40:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:40:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:40:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:40:13 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 0x12b7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e6400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1575570>, '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 0x1576470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1576900>, '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': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', '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 02:40:13 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 02:40:13 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 02:40:13 INFO - Using env: {'DISPLAY': ':0', 02:40:13 INFO - 'HOME': '/home/cltbld', 02:40:13 INFO - 'LANG': 'en_US.UTF-8', 02:40:13 INFO - 'LANGUAGE': 'en_US:en', 02:40:13 INFO - 'LOGNAME': 'cltbld', 02:40:13 INFO - 'MAIL': '/var/mail/cltbld', 02:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:13 INFO - 'MOZ_NO_REMOTE': '1', 02:40:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:13 INFO - 'NO_EM_RESTART': '1', 02:40:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:13 INFO - 'PWD': '/builds/slave/test', 02:40:13 INFO - 'SHELL': '/bin/bash', 02:40:13 INFO - 'SHLVL': '1', 02:40:13 INFO - 'TERM': 'linux', 02:40:13 INFO - 'TMOUT': '86400', 02:40:13 INFO - 'USER': 'cltbld', 02:40:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', 02:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:13 INFO - '_': '/tools/buildbot/bin/python'} 02:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:40:13 INFO - Cleaning up... 02:40:13 INFO - Return code: 0 02:40:13 INFO - Running post-action listener: _resource_record_post_action 02:40:13 INFO - Running post-action listener: _start_resource_monitoring 02:40:13 INFO - Starting resource monitoring. 02:40:13 INFO - [mozharness: 2016-08-16 09:40:13.349072Z] Finished create-virtualenv step (success) 02:40:13 INFO - [mozharness: 2016-08-16 09:40:13.349503Z] Running install step. 02:40:13 INFO - Running pre-action listener: _resource_record_pre_action 02:40:13 INFO - Running main action method: install 02:40:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:40:13 INFO - Reading from file tmpfile_stdout 02:40:13 INFO - Detecting whether we're running mozinstall >=1.0... 02:40:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:40:13 INFO - Reading from file tmpfile_stdout 02:40:13 INFO - Output received: 02:40:13 INFO - Usage: mozinstall [options] installer 02:40:13 INFO - Options: 02:40:13 INFO - -h, --help show this help message and exit 02:40:13 INFO - -d DEST, --destination=DEST 02:40:13 INFO - Directory to install application into. [default: 02:40:13 INFO - "/builds/slave/test"] 02:40:13 INFO - --app=APP Application being installed. [default: firefox] 02:40:13 INFO - mkdir: /builds/slave/test/build/application 02:40:13 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'] 02:40:13 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 02:40:29 INFO - Reading from file tmpfile_stdout 02:40:29 INFO - Output received: 02:40:29 INFO - /builds/slave/test/build/application/firefox/firefox 02:40:29 INFO - Running post-action listener: _resource_record_post_action 02:40:29 INFO - [mozharness: 2016-08-16 09:40:29.663776Z] Finished install step (success) 02:40:29 INFO - [mozharness: 2016-08-16 09:40:29.664114Z] Running run-tests step. 02:40:29 INFO - Running pre-action listener: _resource_record_pre_action 02:40:29 INFO - Running main action method: run_tests 02:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:40:29 INFO - Python 2.7.3 02:40:29 INFO - Return code: 0 02:40:29 INFO - grabbing minidump binary from tooltool 02:40:29 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')]} 02:40:29 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 0x1575570>, '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 0x1576470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1576900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:40:29 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 02:40:29 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 02:40:29 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 02:40:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:40:29 INFO - Return code: 0 02:40:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:40:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:40:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:40:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:40:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:40:29 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/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 02:40:29 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/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 02:40:29 INFO - Using env: {'DISPLAY': ':0', 02:40:29 INFO - 'HOME': '/home/cltbld', 02:40:29 INFO - 'LANG': 'en_US.UTF-8', 02:40:29 INFO - 'LANGUAGE': 'en_US:en', 02:40:29 INFO - 'LOGNAME': 'cltbld', 02:40:29 INFO - 'MAIL': '/var/mail/cltbld', 02:40:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:40:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:40:29 INFO - 'MOZ_NO_REMOTE': '1', 02:40:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:40:29 INFO - 'NO_EM_RESTART': '1', 02:40:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:40:29 INFO - 'PWD': '/builds/slave/test', 02:40:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:40:29 INFO - 'SHELL': '/bin/bash', 02:40:29 INFO - 'SHLVL': '1', 02:40:29 INFO - 'TERM': 'linux', 02:40:29 INFO - 'TMOUT': '86400', 02:40:29 INFO - 'USER': 'cltbld', 02:40:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857', 02:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:40:29 INFO - '_': '/tools/buildbot/bin/python'} 02:40:29 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/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 02:40:29 INFO - mozversion application_buildid: 20160816004012 02:40:29 INFO - mozversion application_changeset: c16b845d20803e1d4e785b144ffd63e9545eb16b 02:40:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:40:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:40:29 INFO - mozversion application_name: Firefox 02:40:29 INFO - mozversion application_remotingname: firefox-dev 02:40:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:40:29 INFO - mozversion application_vendor: Mozilla 02:40:29 INFO - mozversion application_version: 50.0a2 02:40:29 INFO - mozversion platform_buildid: 20160816004012 02:40:29 INFO - mozversion platform_changeset: c16b845d20803e1d4e785b144ffd63e9545eb16b 02:40:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:40:29 INFO - mozversion platform_version: 50.0a2 02:40:29 INFO - using testdate: 1471340429 02:40:29 INFO - actual date: 1471340429 02:40:29 INFO - starting webserver on 'localhost:35331' 02:40:29 INFO - SUITE-START | Running 2 tests 02:40:29 INFO - TEST-START | dromaeo_css 02:40:29 INFO - operating with platform_type : linux_ 02:40:29 INFO - Initialising browser for dromaeo_css test... 02:40:29 INFO - TEST-INFO | started process 8931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOwUxIY/profile http://localhost:35331/getInfo.html) 02:40:34 INFO - PROCESS | 8931 | __metrics Screen width/height:1600/1200 02:40:34 INFO - PROCESS | 8931 | colorDepth:24 02:40:34 INFO - PROCESS | 8931 | Browser inner width/height: 1024/697 02:40:34 INFO - PROCESS | 8931 | __metrics 02:40:34 ERROR - PROCESS | 8931 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:40:35 INFO - TEST-INFO | 8931: exit 0 02:40:35 INFO - Browser initialized. 02:40:35 INFO - Running cycle 1/1 for dromaeo_css test... 02:40:35 INFO - TEST-INFO | started process 9061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOwUxIY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:47 INFO - PROCESS | 9061 | RSS: Main: 152576000 02:40:47 INFO - PROCESS | 9061 | 02:41:36 INFO - PROCESS | 9061 | 1471340496922 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] 02:43:45 INFO - PROCESS | 9061 | Cycle 1(1): loaded http://localhost:35331/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35331/tests/dromaeo/cssquery-ext.html) 02:43:46 INFO - PROCESS | 9061 | RSS: Main: 157712384 02:43:46 INFO - PROCESS | 9061 | 02:46:48 INFO - PROCESS | 9061 | Cycle 1(1): loaded http://localhost:35331/tests/dromaeo/cssquery-ext.html (next: http://localhost:35331/tests/dromaeo/cssquery-jquery.html) 02:46:49 INFO - PROCESS | 9061 | RSS: Main: 153690112 02:46:49 INFO - PROCESS | 9061 | 02:49:50 INFO - PROCESS | 9061 | Cycle 1(1): loaded http://localhost:35331/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35331/tests/dromaeo/cssquery-mootools.html) 02:49:51 INFO - PROCESS | 9061 | RSS: Main: 154988544 02:49:51 INFO - PROCESS | 9061 | 02:52:53 INFO - PROCESS | 9061 | Cycle 1(1): loaded http://localhost:35331/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35331/tests/dromaeo/cssquery-prototype.html) 02:52:53 INFO - PROCESS | 9061 | RSS: Main: 152555520 02:52:53 INFO - PROCESS | 9061 | 02:55:56 INFO - PROCESS | 9061 | Cycle 1(1): loaded http://localhost:35331/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35331/tests/dromaeo/cssquery-yui.html) 02:55:56 INFO - PROCESS | 9061 | RSS: Main: 155090944 02:55:56 INFO - PROCESS | 9061 | 02:58:59 INFO - PROCESS | 9061 | Cycle 1(1): loaded http://localhost:35331/tests/dromaeo/cssquery-yui.html (next: http://localhost:35331/tests/dromaeo/cssquery-dojo.html) 02:58:59 INFO - PROCESS | 9061 | RSS: Main: 155967488 02:58:59 INFO - PROCESS | 9061 | 02:58:59 INFO - PROCESS | 9061 | __start_tp_report 02:58:59 INFO - PROCESS | 9061 | _x_x_mozilla_page_load 02:58:59 INFO - PROCESS | 9061 | _x_x_mozilla_page_load_details 02:58:59 INFO - PROCESS | 9061 | |i|pagename|runs| 02:58:59 INFO - PROCESS | 9061 | |0;dojo.html;3267.232200432898;3288.6053673559177;3300.9504857427137;3309.933801323972;3312.039508542523;5723.170140329655;5788.450097240766;5793.826185214451;5820.6507609543405;5824.3010838699365;5770.971145144268;5835.533157347402;5835.562332825045;5888.528917686585;5888.941110588893;5330.866728331794;5332.386775520807;5362.51737343639;5392.379876314215;5393.487618676219;5210.739463026853;5213.973930130344;5260.763265653036;5273.34083239595;5293.126634105368;5275.393329767087;5311.787528498875;5317.042932272189;5378.569714422837;5393.083175860093;5351.598630102758;5358.33020872391;5366.114591092465;5366.570674346082;5381.569474442035;5097.7960881564695;5192.792288308463;5238.947610523884;5271.630985830993;5327.46725327468;5833.387494313079;5848.41515848416;5861.472467477947;5873.324567674729;5890.116482527612;6271.43557079865;6301.905471417932;6310.274318453391;6316.74733010679;6323.14637523933;5971;6145.231846019247;6311.779087731953;6345.904811427832;6349.555531112824;5785.681787501686;5850.736716847752;5860.824175274749;5873.676947767871;5886.764529418818;6377.808665740035;6403.231612206565;6407.711652975628;6427;6443.387878151568;5957.493613042853;5986.191864098378;6166.136740856284;6172.969135154385;6185.8144255672405;6119.5104391648565;6174.38256174388;6221.06683997404;6234.064890266496;6250.218722659668;6172.135900973867;6174.44430001302;6182.227221597301;6183.103449999725;6203.8138855833495;5959.314678811992;6077.1491991121275;6174.38256174388;6176.073588961602;6193.194884664965;4701.130290896195;4774.212254977959;4777.474477807438;4781.043791241766;4802.567768900815;4233.1956928183545;4242.745435273831;4247.830086796494;4266.06146647737;4271.402003719481;5831.650100993869;5871.4715675589405;6008.849778755566;6064.4541991221;6072.332043475214;6134.570580059442;6278.874422511524;6280.874382512324;6300.59046161998;6306.148669929593;5971.367700057791;6015.488683461867;6041.033434650522;6047.183630209865;6055.424734650202;5242;5299.655522391032;5354.866128346823;5361.222622719683;5413.242146099549;6360.459360954371;6528.673566321665;6540.640264785482;6545.149130613085;6553.049807777846;6251.906221406592;6277.623342599459;6286.811395658137;6294.590851594632;6318.652474113968;6256.812295631138;6281.277653069956;6456.580322279225;6477.190351206099;6530.346965303432;5991.430814072831;6104.633721976696;6107;6107.114468401968;6131.693415329127;6135.305123203715;6158.04550294705;6193.535484838565;6194.194754681863;6212.223472065992;5926.348101708722;5986.521078313812;6021.142409156093;6043.184170136975;6086.087086936818;6045.214122164267;6126.540509461719;6129.267100814889;6137.862137862138;6141.946315431794;6023.3073196582955;6076.605020673642;6077.604955677867;6080.756769729338;6097;5936.376680448663;6123.601965872204;6141.477974372228;6171.56799024064;6181.041938499539;6001.189839371629;6092.573519853568;6097.268327800515;6110.052941794029;6130.969345153246 02:58:59 INFO - PROCESS | 9061 | |1;ext.html;579.9304083509979;642.1844257792603;651.1047309948821;666.1473314157878;691.7475121580625;41913.79043104784;46174;46201.53798462015;46205.53794462054;46347.53652463474;45679;45938.77030614851;46239.76880115603;46260;46269.76865115669;8978.86531702025;9075.36472446929;9142.314326425512;9156.954215228914;9197.49413782245;9112.726618201465;9164.725058248263;9194.448333100036;9235.168834804866;9250.259979201648;9267.304952128583;9270.953645231764;9273.814523709521;9279.72160835176;9282.164605185531;9153.588088536031;9225.215856652192;9235.538223088819;9255.167034966818;9265.212456941168;9069.818603627957;9117.225035871892;9173.128552787475;9181.540922953825;9187.586558604879;44037.11925761499;44610.33084503735;44671;44679.776601116784;44691.329630055574;4131.731437456556;4168.7707176105305;4323.2218200723855;4407.823687052514;4635.980084381431;34678.47982280268;34844;35019.1245218869;35326.646733532594;36579;4749.833755818564;4764.475907650156;4790.305405716152;4791.9520804791855;4837.7339246341435;358280;358777;360226.1988690066;362088;362239;62879;63415;63487;63506.36493635097;63515.364846350945;40016.19967600632;40728.796356018625;40849.591504085176;43131;67163.66418167877;18784;19127.426177214707;19130.617387652168;19159.233630654617;19228;15068.095914245181;15105.697886042437;15111.31999060045;15197.468088616846;15226.238688065774;20857.374278771662;20946;20963.895180524;21049.158033678483;21076.89461552713;7863.213678632091;7878.960605196938;7886.171951944963;7925.247101525346;8007.6796928123385;1031.7730099378125;1127.5940661361903;1129.9661010169707;1142.3203194099497;1173.3546549397797;35627.768394094775;35837.46243806345;35989.46015809765;36019;36101.27797444037;1138.362516990488;1160.3096157786104;1192.1237890150733;1197.9101567382306;1216.5681183179843;18691.71962420565;18832.34086806955;18877.528061798566;18897.24411023571;18900.905495472434;674158;689886;699795;707561;709432;65525;66056;66199.66900165565;66222.66888665622;66282;1395.2465668538875;1429.0996672096721;1446.3708286895235;1484.2652886820877;1487.3901700302824;33676.49485257674;34975.12562185965;35246.47130292996;35792.82103589465;35940.101497462776;56934;56985.43014569967;57045.714771425875;57137.42862571321;57267.713661433096;503300;503698;507623;507770;511832;31673;31705.5244171333;32438.513422298212;32533.511997319587;32553;54226.72886635541;54769.5797516717;54837;54883.902321954134;55331.72334138465;45970.31044534402;46571;46998.29502557396;47240.527594723615;48204.758976204896;46225.76887115543;46272.48329526786;46420;47310.52689473061;47722;46243.306350405444;47000;47607.28589071236;48200.75899620479;49629;37751.81124094362;40437.59562404338;40737.59262407338;41065;41833.163336733705;31560;31747.52378714275;31830.363392732477;32167.195820104684;32357.838210809736 02:58:59 INFO - PROCESS | 9061 | |2;jquery.html;389.771983389717;398.551629416906;430.5801843202877;430.72864095619764;436.8078045659909;19850.106745196485;20077.698834517494;20758.48103797406;21205.469863253427;21227.57544849102;20046.1981520739;20350;20436.8978155109;20703;21161.788382116174;5819.039858423365;6008.1888944992525;6036.577439579231;6047.183630209931;6060.909086363708;5897.675627840467;5906.37983011784;5920.4671579557835;5926;5955.315138759055;5753.424657534255;5874.5594080443925;5920.792772252972;5928.02187639039;5931.110333449996;5901.232839730829;5923.407659234085;5939.1388248704125;5980;5983.042713165873;5342.572594192456;5356.009138309386;5358.4641535846495;5364.6512976656395;5392.487713667196;22241.332760017227;23053;23999;24989.87505062463;25140;2402.243293362585;2514.5222407742654;2545.300042488312;2584.043903755604;3113.315070684446;10997.505112269968;11044.779104417867;11099.72250693739;11302.491387887565;11364.94317528407;2081.5004398944143;2091.8117369436823;2104.326615483046;2112.176251262009;2120.4062862398555;79761;88040;89157;89666;89811.55094224552;11575.710607234718;11671.941640291745;11798.882011179778;11828.645140645795;11943.163978521594;16931.576710582332;16934.83065169357;16974.236159372856;16996.57508562271;17004.57488562771;8889.866652000224;9132.3150763693;9140.360174787702;9175.44947303164;9201.90798092024;8711.738647840575;8727.432716873383;8802.471851688919;8980;8998.14517620825;4950.63123249992;5064.18972964324;5094.872628184325;5126.641135120506;5189.6886186828915;1998.520355114762;2036.725042119295;2063.8452116091353;2074.3984244569206;2128.968065479019;975.853621956698;1084.159776173456;1089.9782004359868;1111.1666250312267;1126.1385040444068;20954.685679714818;21034.053467593996;21049.158033678483;21074.578508429746;21438.03528841206;1061.2836335473523;1089.3899416326883;1091.5633746501305;1093.2128867215592;1114.1755101225035;11385.14611404148;11586.942065289619;11622;11693.123015773852;11776.941115294369;501520;523122;523449;546178;546990;88906.55546722225;90947;91680.54159729158;97698;100294.49852750689;1028.1774580335702;1043.6138628707274;1046.199657262195;1064.5741703318579;1066.935983840972;17525;17965.550861228574;18425.170867310735;18433.815661843746;18468.261269549606;40690.59309406868;41242;41333.37999930064;41886.79056604698;42589.36115958201;60169.69915150396;60449;61510.38489615046;61510.69244653748;61930;8440.113788052411;8567.700130495403;8686.913130868863;9063.68277110298;9114.40756350835;12167.574134905235;13556.72886542244;13557.118787278796;13571.660708482366;13631.25028123423;11829.82255266189;12191.085668574715;12651.177673451564;12673;12897.226166430044;11380.54477820911;11804;12437;12557.309347985949;12565.057620678303;11890.46492907804;11923.224990375598;12117.394130293625;12173;12588.559400420942;7838.137804841349;8223.753287401387;8249.340052795882;8670.26302764272;8779.385443018928;8866.911330886609;11736.471858766205;11986.76026479483;12097.697557561132;12660.683482913 02:58:59 INFO - PROCESS | 9061 | |3;mootools.html;1506.1941861104308;1552.0299812617113;1712.691715491211;1792.301002608982;1815.3555487801839;8015.559144247064;8899.510526921016;9199.31005174613;9576.47329396883;9596.712098637052;9292.349535532516;9591.616335346578;9597.424154550732;9607.183389411892;9612.279079069063;2532.9620055699133;2563.3976015636313;2567.7303883092286;2572.254046326563;2575.987120064397;2438.0735320578156;2441.377448750575;2441.4628781668093;2443.584590619599;2443.6334549817493;2476.170482888235;2485.5774518331928;2489.2283392148493;2508.648789169518;2512.309114993373;2429.720582133051;2432.2946345559676;2443.6701045358827;2500.5374005808985;2513.7360577139502;2423.648570957219;2428.854268743881;2440.6583078369044;2453.251758213744;2468.4075821802817;9316.161545460942;9361.62553497866;9627.085426884434;9698.51507424626;9724.902750972471;5599.944000559983;5778.104393818965;5779.566532510036;5780.046292361755;5789.913151302734;3422.8973130806116;3527.664871837171;3535.7878527288444;3585.515955346047;3626.564812222524;1261.396524985921;1305.8498272698666;1316.1773891317926;1322.5106710517075;1338.1168428837018;13338.13302135358;13368.465261389532;13380.598582042554;13390.129641573267;13391;4822.9758851206225;5009.5491405773655;5019.347484826949;5074.543291103819;5088.847334579968;11472.88527114718;11495.827562586568;11505.194636375374;11558.075353971662;11559.133065020158;5621.325440947113;5623.971880140655;5624.831255062355;5626.1842032905;5643.040683083886;4522.479914809774;5206.219067139959;5230.08473517133;5272.92090618641;5306.310179676694;4354.9564504355185;4386.561343865652;4390.934135987963;4412.933805992912;4469.173202957463;1396.6508372906774;1411.5765270418833;1423.3168079321983;1437.475321507642;1443.2855736410545;1073.4042606353394;1085.9945700271605;1086.3101930274333;1089.6948854320804;1103.7295862513574;6393.9360606394275;6585.604863708193;6691.364320389653;6791.898121528181;6844;478.2491488363236;487.33817681705216;490.619769678502;493.1714719271586;497.27149725652095;4326.718763280377;4377.562243775597;4411.316245981878;4565.748883811422;4589.609883159902;11423.200375973769;11905.761884762429;11975.46110425033;12090.609579898248;12105.87894121065;11897.34564598938;11919.106067045006;11983.041356691443;12005.87994120065;12033.097517686034;8447.070822209553;8878.911210887938;8895.377323587287;8999.640014399612;9057.094290571022;6791.388775010273;6838.487113466411;6886.69009894566;6991.161060672548;7058.964705176647;10852.403117828595;10971.615993440191;11054.557817687202;11204.943975280397;11273.71815704614;11133.387663678575;11186.720331991766;11286.435678215892;11290.15323850698;11373.943130284295;8074.071481779436;8267.669293228204;8301.792455188668;8590.78523036929;8726.69456569017;9473.384230025027;9573.2820038496;9599.616015359308;9624.855627165458;9637.614495420105;8037.517748935083;8151.1441298662785;8199.385046121684;8270.545120018456;8377.45546539473;7979.48133371329;7994.200579941959;8008.879866801886;8065.233802788725;8219.671213151407;7547.358474529727;7576.431767617561;7600.049993750781;7603.20166382544;7674.155842857393;5786.074228123648;5865.501432378295;5940.61386009908;5941.287045554561;6047.455728984412;5837.270341207349;5878.764849406147;5941.702914854326;5966.134910437875;5974.1636170935235 02:58:59 INFO - PROCESS | 9061 | |4;prototype.html;357.59055881016235;359.1022443890274;365.0763568172523;367.28929521376125;368.20651496026073;5856.8242952711435;5865.765369385224;5872.9119063213975;5891.351951285361;5966.8806623867495;5502.486816125567;5816.796412125576;5830.970845145779;5836.970815145929;5840.474357307841;4482.955170448295;4505.414296141514;4508.098380323932;4515.977420112895;4523.434570678665;4503.0318481526465;4526.841560545382;4540.364348991144;4550.863474095782;4567.520410356915;4381.3208952612395;4539.841105561306;4553.4535855697195;4557.658175636824;4569.29175977724;4463.598276155145;4484.654603618901;4494.1910456117885;4498.797554110073;4509.30105833593;3955.149642826806;3958.366661334173;3962.702797290186;3970.6029397060065;4004.1391100913443;5581.274434323512;5645.576581756343;5646.604737668365;5691.065037887097;5695.658260504383;5168.862850172956;5191.688498690053;5231.424543300234;5252.896891652719;5275.446078161776;6093.573449858512;6128.988716861712;6130.417610327012;6154;6211.751529938842;4286.485621725382;4353.194658988097;4367.71609845359;4370.2789039808395;4401.383806267125;6162.352952939967;6331.55679102463;6361.236651601837;6373.490120790326;6381.4575761059905;4468.32975053738;4494.1461122386645;4531.410916580823;4539.182947069493;4540.364348991144;4575.17646823575;4575.9084818303445;4588.426446694163;4594.356790049395;4596.770161491912;5128.307678463434;5210.973945130326;5233.764480598382;5245.291885595396;5269.392835185306;6106.786262480792;6119.969400152971;6145.8156255312415;6147.72335244915;6194.566380353423;1549.9922500387427;1571.591386239563;1578.5185518416993;1579.8499142581436;1580.1072394097298;1005.2460654509118;1008.1531513528524;1011.7318910488726;1025.2310766924807;1030.1192480429274;5248.795505887537;5296.225764368903;5337.343919415213;5339.46605339463;5350.592233494943;5513.511351935035;5540.866766295006;5574.16387541872;5581.720913954286;5600.355959064678;4992.600591952635;5227.215917612389;5289.709066001406;5301.708406037705;5304.9841060397575;2961.718636729507;2964.4663960486887;2975.747061499797;2984.850757462118;2986.2982199183175;5708.600397972102;5757.251557297524;5780.855478613068;5798.739056742456;6089.421504957022;6466.547341686037;6481.902771458432;6510.934890651128;6556.18047744032;6587.473002159912;6621.569597976116;6658.83352916181;6662.735259722798;6676.232233293136;6709.161354830646;6179;6349.428551430394;6350.301466838551;6403.29563747978;6416.807495775134;6304.84237894038;6325.588836725598;6328.968355158195;6346.936530634634;6385.169927909342;6307.779227727191;6438.714256438897;6512.6092434454085;6561.639109848813;6567.835804104744;4456.5766252205985;4473.664475164311;4499.865004049884;4506.301523263899;4519.254323036662;6210.192674952227;6275.560710750204;6355.428011478989;6428.553575445674;6458.741650333934;6147.754089836357;6171.382861713792;6175.783847565313;6196.349383314687;6207.503399727921;5906.438888305604;6168.272883592601;6255.937440625536;6273.843153921006;6290.874182516415;6071.423214794588;6075.30134034574;6075.756969721162;6094.013933172625;6169.413905678954;6257.374262573706;6290.528210384148;6299.937000629935;6312.2740884796995;6342.748324344791;5846.473817356458;6022.337542870193;6049.909251361145;6074.42292982166;6090.543209259412 02:58:59 INFO - PROCESS | 9061 | |5;yui.html;813.7355359508161;820.5035953248284;821.5317269156582;852.8507511185541;915.1534830281992;15502.534923952286;16951.321947122116;17045.659086818257;17072.573185670335;17155.399561015365;15358.846411535882;16686.332546698148;16790.32838686454;16864.241109150087;16906.15469226537;869.8173383589437;897.4211633496391;900.2707806676581;901.3555307954811;901.5266984832982;893.3880291999968;895.4537731983485;900.75679566517;902.3412908576743;902.5893218585561;943.4150826487553;946.7633091727068;947.1854205383365;947.7725345916999;948.6584829461389;941.0683423410808;941.9717408477757;943.1181844974902;944.9952750236273;945.121037435185;681.6489507903434;688.8518968421813;689.7275576147443;690.1649004704313;691.5919607431589;16466.42367517131;16851.494455166365;16971.151442427952;17000.3199872005;17056.317747290093;16493.34026638933;17287.481375558753;17446.389376371768;17666;17772.28910843565;13474.326283685776;13502.729945401037;13506.864931350758;13588.116772409761;13604.591862244148;4167.371006393755;4186.246475634384;4221.197972385267;4240.851570195028;4292.034292284242;70037.64981175061;73437;74807.62596187039;83619.5819020901;87536;12785.424655890507;12896.161749486253;12904.290264035568;13004.414801333962;13130;23183.652245216334;23255.767442325698;23257.651135232984;23323.883380583327;23341;9198.402103863227;9564.18704410119;9697.515124243759;9732.07545283197;9790.5594248259;5291.867703307371;5369.946300537023;5428.348598168166;5435.402105768362;5521.475459831309;3821.9426708599394;3937.6062393760394;3964.980175099106;3969.503812023497;3971.2057588481844;647.1263793878321;656.2354856592112;659.1496968910149;667.5327270910382;680.0933889172552;723.3742812467178;756.9969790028234;758.5789886612872;791.5488171742167;795.562440657636;10264.846027309597;10482.213833962483;10719.767226769021;10739.570417183382;10742.73143171427;725.5139056831936;765.8698021336386;822.4284122534781;829.7469271872017;834.2866848844151;5074.2895994560795;5265.420803711589;5289.973550132302;5348.893022139613;5371.811986580451;78328;109305;130201;134125.32937335447;136565.31717341547;55525.16712249319;115163;116190.47619047618;117240;119972;70118.64940675366;88516;91654;91779.54110229407;94687.99999999862;10525.368657835541;10969.177311701495;11069.728534724927;11242.66272011841;11367.658970230907;54958;55028.72485637546;55453.554849013046;57327;58722.4127758734;73443.63278183575;80918.19081809343;83108.58445707733;83195;84531.5773421129;13835;14250.786238206643;14617.561473155822;14631.487897923522;14701.33843977045;15125.092494450368;15200.139313879321;15301;15410.768838467657;15817;13743.862561374259;13751.312434378442;14240.430382784572;14251.429942802586;14433.7834932474;14856.480023199136;15159.848401516285;15672;16186.109763962624;16281.75577366364;12712.6821829455;13024.609261722164;13316.201027938354;13659.317034148451;13931.58205253844;12258.387080646111;12377.814332784836;12920.418581163682;12945.54690585825;13434.529791457253;13178.868211317764;13380.665483362995;13454.192748435125;13458.663533411744;13515.662108446973 02:58:59 INFO - PROCESS | 9061 | __end_tp_report 02:58:59 INFO - PROCESS | 9061 | __start_cc_report 02:58:59 INFO - PROCESS | 9061 | _x_x_mozilla_cycle_collect,322 02:58:59 INFO - PROCESS | 9061 | __end_cc_report 02:58:59 INFO - PROCESS | 9061 | __startTimestamp1471341539619__endTimestamp 02:58:59 INFO - PROCESS | 9061 | 02:58:59 INFO - PROCESS | 9061 | ------- Summary: start ------- 02:58:59 INFO - PROCESS | 9061 | Number of tests: 6 02:58:59 INFO - PROCESS | 9061 | 02:58:59 INFO - PROCESS | 9061 | [#0] dojo.html Cycles:165 Average:5793.36 Median:6043.18 stddev:667.45 (11.0%) stddev-sans-first:639.40 02:58:59 INFO - PROCESS | 9061 | Values: 3267.2 3288.6 3301.0 3309.9 3312.0 5723.2 5788.5 5793.8 5820.7 5824.3 5771.0 5835.5 5835.6 5888.5 5888.9 5330.9 5332.4 5362.5 5392.4 5393.5 5210.7 5214.0 5260.8 5273.3 5293.1 5275.4 5311.8 5317.0 5378.6 5393.1 5351.6 5358.3 5366.1 5366.6 5381.6 5097.8 5192.8 5238.9 5271.6 5327.5 5833.4 5848.4 5861.5 5873.3 5890.1 6271.4 6301.9 6310.3 6316.7 6323.1 5971.0 6145.2 6311.8 6345.9 6349.6 5785.7 5850.7 5860.8 5873.7 5886.8 6377.8 6403.2 6407.7 6427.0 6443.4 5957.5 5986.2 6166.1 6173.0 6185.8 6119.5 6174.4 6221.1 6234.1 6250.2 6172.1 6174.4 6182.2 6183.1 6203.8 5959.3 6077.1 6174.4 6176.1 6193.2 4701.1 4774.2 4777.5 4781.0 4802.6 4233.2 4242.7 4247.8 4266.1 4271.4 5831.7 5871.5 6008.8 6064.5 6072.3 6134.6 6278.9 6280.9 6300.6 6306.1 5971.4 6015.5 6041.0 6047.2 6055.4 5242.0 5299.7 5354.9 5361.2 5413.2 6360.5 6528.7 6540.6 6545.1 6553.0 6251.9 6277.6 6286.8 6294.6 6318.7 6256.8 6281.3 6456.6 6477.2 6530.3 5991.4 6104.6 6107.0 6107.1 6131.7 6135.3 6158.0 6193.5 6194.2 6212.2 5926.3 5986.5 6021.1 6043.2 6086.1 6045.2 6126.5 6129.3 6137.9 6141.9 6023.3 6076.6 6077.6 6080.8 6097.0 5936.4 6123.6 6141.5 6171.6 6181.0 6001.2 6092.6 6097.3 6110.1 6131.0 02:58:59 INFO - PROCESS | 9061 | 02:58:59 INFO - PROCESS | 9061 | [#1] ext.html Cycles:180 Average:68909.81 Median:46232.77 stddev:143745.62 (310.9%) stddev-sans-first:144057.32 02:58:59 INFO - PROCESS | 9061 | Values: 579.9 642.2 651.1 666.1 691.7 41913.8 46174.0 46201.5 46205.5 46347.5 45679.0 45938.8 46239.8 46260.0 46269.8 8978.9 9075.4 9142.3 9157.0 9197.5 9112.7 9164.7 9194.4 9235.2 9250.3 9267.3 9271.0 9273.8 9279.7 9282.2 9153.6 9225.2 9235.5 9255.2 9265.2 9069.8 9117.2 9173.1 9181.5 9187.6 44037.1 44610.3 44671.0 44679.8 44691.3 4131.7 4168.8 4323.2 4407.8 4636.0 34678.5 34844.0 35019.1 35326.6 36579.0 4749.8 4764.5 4790.3 4792.0 4837.7 358280.0 358777.0 360226.2 362088.0 362239.0 62879.0 63415.0 63487.0 63506.4 63515.4 40016.2 40728.8 40849.6 43131.0 67163.7 18784.0 19127.4 19130.6 19159.2 19228.0 15068.1 15105.7 15111.3 15197.5 15226.2 20857.4 20946.0 20963.9 21049.2 21076.9 7863.2 7879.0 7886.2 7925.2 8007.7 1031.8 1127.6 1130.0 1142.3 1173.4 35627.8 35837.5 35989.5 36019.0 36101.3 1138.4 1160.3 1192.1 1197.9 1216.6 18691.7 18832.3 18877.5 18897.2 18900.9 674158.0 689886.0 699795.0 707561.0 709432.0 65525.0 66056.0 66199.7 66222.7 66282.0 1395.2 1429.1 1446.4 1484.3 1487.4 33676.5 34975.1 35246.5 35792.8 35940.1 56934.0 56985.4 57045.7 57137.4 57267.7 503300.0 503698.0 507623.0 507770.0 511832.0 31673.0 31705.5 32438.5 32533.5 32553.0 54226.7 54769.6 54837.0 54883.9 55331.7 45970.3 46571.0 46998.3 47240.5 48204.8 46225.8 46272.5 46420.0 47310.5 47722.0 46243.3 47000.0 47607.3 48200.8 49629.0 37751.8 40437.6 40737.6 41065.0 41833.2 31560.0 31747.5 31830.4 32167.2 32357.8 02:58:59 INFO - PROCESS | 9061 | 02:58:59 INFO - PROCESS | 9061 | [#2] jquery.html Cycles:180 Average:30809.32 Median:23526.00 stddev:87046.98 (370.0%) stddev-sans-first:87261.20 02:58:59 INFO - PROCESS | 9061 | Values: 389.8 398.6 430.6 430.7 436.8 19850.1 20077.7 20758.5 21205.5 21227.6 20046.2 20350.0 20436.9 20703.0 21161.8 5819.0 6008.2 6036.6 6047.2 6060.9 5897.7 5906.4 5920.5 5926.0 5955.3 5753.4 5874.6 5920.8 5928.0 5931.1 5901.2 5923.4 5939.1 5980.0 5983.0 5342.6 5356.0 5358.5 5364.7 5392.5 22241.3 23053.0 23999.0 24989.9 25140.0 2402.2 2514.5 2545.3 2584.0 3113.3 10997.5 11044.8 11099.7 11302.5 11364.9 2081.5 2091.8 2104.3 2112.2 2120.4 79761.0 88040.0 89157.0 89666.0 89811.6 11575.7 11671.9 11798.9 11828.6 11943.2 16931.6 16934.8 16974.2 16996.6 17004.6 8889.9 9132.3 9140.4 9175.4 9201.9 8711.7 8727.4 8802.5 8980.0 8998.1 4950.6 5064.2 5094.9 5126.6 5189.7 1998.5 2036.7 2063.8 2074.4 2129.0 975.9 1084.2 1090.0 1111.2 1126.1 20954.7 21034.1 21049.2 21074.6 21438.0 1061.3 1089.4 1091.6 1093.2 1114.2 11385.1 11586.9 11622.0 11693.1 11776.9 501520.0 523122.0 523449.0 546178.0 546990.0 88906.6 90947.0 91680.5 97698.0 100294.5 1028.2 1043.6 1046.2 1064.6 1066.9 17525.0 17965.6 18425.2 18433.8 18468.3 40690.6 41242.0 41333.4 41886.8 42589.4 60169.7 60449.0 61510.4 61510.7 61930.0 8440.1 8567.7 8686.9 9063.7 9114.4 12167.6 13556.7 13557.1 13571.7 13631.3 11829.8 12191.1 12651.2 12673.0 12897.2 11380.5 11804.0 12437.0 12557.3 12565.1 11890.5 11923.2 12117.4 12173.0 12588.6 7838.1 8223.8 8249.3 8670.3 8779.4 8866.9 11736.5 11986.8 12097.7 12660.7 02:58:59 INFO - PROCESS | 9061 | 02:58:59 INFO - PROCESS | 9061 | [#3] mootools.html Cycles:180 Average:6322.22 Median:2533.93 stddev:3626.36 (143.1%) stddev-sans-first:3618.47 02:58:59 INFO - PROCESS | 9061 | Values: 1506.2 1552.0 1712.7 1792.3 1815.4 8015.6 8899.5 9199.3 9576.5 9596.7 9292.3 9591.6 9597.4 9607.2 9612.3 2533.0 2563.4 2567.7 2572.3 2576.0 2438.1 2441.4 2441.5 2443.6 2443.6 2476.2 2485.6 2489.2 2508.6 2512.3 2429.7 2432.3 2443.7 2500.5 2513.7 2423.6 2428.9 2440.7 2453.3 2468.4 9316.2 9361.6 9627.1 9698.5 9724.9 5599.9 5778.1 5779.6 5780.0 5789.9 3422.9 3527.7 3535.8 3585.5 3626.6 1261.4 1305.8 1316.2 1322.5 1338.1 13338.1 13368.5 13380.6 13390.1 13391.0 4823.0 5009.5 5019.3 5074.5 5088.8 11472.9 11495.8 11505.2 11558.1 11559.1 5621.3 5624.0 5624.8 5626.2 5643.0 4522.5 5206.2 5230.1 5272.9 5306.3 4355.0 4386.6 4390.9 4412.9 4469.2 1396.7 1411.6 1423.3 1437.5 1443.3 1073.4 1086.0 1086.3 1089.7 1103.7 6393.9 6585.6 6691.4 6791.9 6844.0 478.2 487.3 490.6 493.2 497.3 4326.7 4377.6 4411.3 4565.7 4589.6 11423.2 11905.8 11975.5 12090.6 12105.9 11897.3 11919.1 11983.0 12005.9 12033.1 8447.1 8878.9 8895.4 8999.6 9057.1 6791.4 6838.5 6886.7 6991.2 7059.0 10852.4 10971.6 11054.6 11204.9 11273.7 11133.4 11186.7 11286.4 11290.2 11373.9 8074.1 8267.7 8301.8 8590.8 8726.7 9473.4 9573.3 9599.6 9624.9 9637.6 8037.5 8151.1 8199.4 8270.5 8377.5 7979.5 7994.2 8008.9 8065.2 8219.7 7547.4 7576.4 7600.0 7603.2 7674.2 5786.1 5865.5 5940.6 5941.3 6047.5 5837.3 5878.8 5941.7 5966.1 5974.2 02:58:59 INFO - PROCESS | 9061 | 02:58:59 INFO - PROCESS | 9061 | [#4] prototype.html Cycles:180 Average:5101.28 Median:5591.04 stddev:1521.44 (27.2%) stddev-sans-first:1483.47 02:58:59 INFO - PROCESS | 9061 | Values: 357.6 359.1 365.1 367.3 368.2 5856.8 5865.8 5872.9 5891.4 5966.9 5502.5 5816.8 5831.0 5837.0 5840.5 4483.0 4505.4 4508.1 4516.0 4523.4 4503.0 4526.8 4540.4 4550.9 4567.5 4381.3 4539.8 4553.5 4557.7 4569.3 4463.6 4484.7 4494.2 4498.8 4509.3 3955.1 3958.4 3962.7 3970.6 4004.1 5581.3 5645.6 5646.6 5691.1 5695.7 5168.9 5191.7 5231.4 5252.9 5275.4 6093.6 6129.0 6130.4 6154.0 6211.8 4286.5 4353.2 4367.7 4370.3 4401.4 6162.4 6331.6 6361.2 6373.5 6381.5 4468.3 4494.1 4531.4 4539.2 4540.4 4575.2 4575.9 4588.4 4594.4 4596.8 5128.3 5211.0 5233.8 5245.3 5269.4 6106.8 6120.0 6145.8 6147.7 6194.6 1550.0 1571.6 1578.5 1579.8 1580.1 1005.2 1008.2 1011.7 1025.2 1030.1 5248.8 5296.2 5337.3 5339.5 5350.6 5513.5 5540.9 5574.2 5581.7 5600.4 4992.6 5227.2 5289.7 5301.7 5305.0 2961.7 2964.5 2975.7 2984.9 2986.3 5708.6 5757.3 5780.9 5798.7 6089.4 6466.5 6481.9 6510.9 6556.2 6587.5 6621.6 6658.8 6662.7 6676.2 6709.2 6179.0 6349.4 6350.3 6403.3 6416.8 6304.8 6325.6 6329.0 6346.9 6385.2 6307.8 6438.7 6512.6 6561.6 6567.8 4456.6 4473.7 4499.9 4506.3 4519.3 6210.2 6275.6 6355.4 6428.6 6458.7 6147.8 6171.4 6175.8 6196.3 6207.5 5906.4 6168.3 6255.9 6273.8 6290.9 6071.4 6075.3 6075.8 6094.0 6169.4 6257.4 6290.5 6299.9 6312.3 6342.7 5846.5 6022.3 6049.9 6074.4 6090.5 02:58:59 INFO - PROCESS | 9061 | 02:58:59 INFO - PROCESS | 9061 | [#5] yui.html Cycles:180 Average:22189.49 Median:3967.24 stddev:31552.91 (795.3%) stddev-sans-first:31600.60 02:58:59 INFO - PROCESS | 9061 | Values: 813.7 820.5 821.5 852.9 915.2 15502.5 16951.3 17045.7 17072.6 17155.4 15358.8 16686.3 16790.3 16864.2 16906.2 869.8 897.4 900.3 901.4 901.5 893.4 895.5 900.8 902.3 902.6 943.4 946.8 947.2 947.8 948.7 941.1 942.0 943.1 945.0 945.1 681.6 688.9 689.7 690.2 691.6 16466.4 16851.5 16971.2 17000.3 17056.3 16493.3 17287.5 17446.4 17666.0 17772.3 13474.3 13502.7 13506.9 13588.1 13604.6 4167.4 4186.2 4221.2 4240.9 4292.0 70037.6 73437.0 74807.6 83619.6 87536.0 12785.4 12896.2 12904.3 13004.4 13130.0 23183.7 23255.8 23257.7 23323.9 23341.0 9198.4 9564.2 9697.5 9732.1 9790.6 5291.9 5369.9 5428.3 5435.4 5521.5 3821.9 3937.6 3965.0 3969.5 3971.2 647.1 656.2 659.1 667.5 680.1 723.4 757.0 758.6 791.5 795.6 10264.8 10482.2 10719.8 10739.6 10742.7 725.5 765.9 822.4 829.7 834.3 5074.3 5265.4 5290.0 5348.9 5371.8 78328.0 109305.0 130201.0 134125.3 136565.3 55525.2 115163.0 116190.5 117240.0 119972.0 70118.6 88516.0 91654.0 91779.5 94688.0 10525.4 10969.2 11069.7 11242.7 11367.7 54958.0 55028.7 55453.6 57327.0 58722.4 73443.6 80918.2 83108.6 83195.0 84531.6 13835.0 14250.8 14617.6 14631.5 14701.3 15125.1 15200.1 15301.0 15410.8 15817.0 13743.9 13751.3 14240.4 14251.4 14433.8 14856.5 15159.8 15672.0 16186.1 16281.8 12712.7 13024.6 13316.2 13659.3 13931.6 12258.4 12377.8 12920.4 12945.5 13434.5 13178.9 13380.7 13454.2 13458.7 13515.7 02:58:59 INFO - PROCESS | 9061 | -------- Summary: end -------- 02:58:59 INFO - PROCESS | 9061 | 02:59:00 INFO - TEST-INFO | 9061: exit 0 02:59:00 INFO - TEST-OK | dromaeo_css | took 1110427ms 02:59:00 INFO - TEST-START | kraken 02:59:00 INFO - operating with platform_type : linux_ 02:59:00 INFO - Initialising browser for kraken test... 02:59:00 INFO - TEST-INFO | started process 9321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmOJTDr/profile http://localhost:35331/getInfo.html) 02:59:04 INFO - PROCESS | 9321 | __metrics Screen width/height:1600/1200 02:59:04 INFO - PROCESS | 9321 | colorDepth:24 02:59:04 INFO - PROCESS | 9321 | Browser inner width/height: 1024/697 02:59:04 INFO - PROCESS | 9321 | __metrics 02:59:05 ERROR - PROCESS | 9321 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:59:05 INFO - TEST-INFO | 9321: exit 0 02:59:05 INFO - Browser initialized. 02:59:05 INFO - Running cycle 1/1 for kraken test... 02:59:05 INFO - TEST-INFO | started process 9445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmOJTDr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:59:17 INFO - PROCESS | 9445 | RSS: Main: 152571904 02:59:17 INFO - PROCESS | 9445 | 02:59:20 INFO - PROCESS | 9445 | Cycle 1(1): loaded http://localhost:35331/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35331/tests/kraken/driver.html?testName=audio-beat-detection) 02:59:20 INFO - PROCESS | 9445 | RSS: Main: 158035968 02:59:20 INFO - PROCESS | 9445 | 02:59:23 INFO - PROCESS | 9445 | Cycle 1(1): loaded http://localhost:35331/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35331/tests/kraken/driver.html?testName=audio-dft) 02:59:24 INFO - PROCESS | 9445 | RSS: Main: 156557312 02:59:24 INFO - PROCESS | 9445 | 02:59:27 INFO - PROCESS | 9445 | Cycle 1(1): loaded http://localhost:35331/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35331/tests/kraken/driver.html?testName=audio-fft) 02:59:27 INFO - PROCESS | 9445 | RSS: Main: 157130752 02:59:27 INFO - PROCESS | 9445 | 02:59:29 INFO - PROCESS | 9445 | Cycle 1(1): loaded http://localhost:35331/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35331/tests/kraken/driver.html?testName=audio-oscillator) 02:59:30 INFO - PROCESS | 9445 | RSS: Main: 157011968 02:59:30 INFO - PROCESS | 9445 | 02:59:32 INFO - PROCESS | 9445 | Cycle 1(1): loaded http://localhost:35331/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35331/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:59:33 INFO - PROCESS | 9445 | RSS: Main: 156831744 02:59:33 INFO - PROCESS | 9445 | 02:59:36 INFO - PROCESS | 9445 | Cycle 1(1): loaded http://localhost:35331/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35331/tests/kraken/driver.html?testName=imaging-darkroom) 02:59:36 INFO - PROCESS | 9445 | RSS: Main: 156286976 02:59:36 INFO - PROCESS | 9445 | 02:59:40 INFO - PROCESS | 9445 | Cycle 1(1): loaded http://localhost:35331/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35331/tests/kraken/driver.html?testName=imaging-desaturate) 02:59:40 INFO - PROCESS | 9445 | RSS: Main: 155074560 02:59:40 INFO - PROCESS | 9445 | 02:59:43 INFO - PROCESS | 9445 | Cycle 1(1): loaded http://localhost:35331/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35331/tests/kraken/driver.html?testName=json-parse-financial) 02:59:44 INFO - PROCESS | 9445 | RSS: Main: 156753920 02:59:44 INFO - PROCESS | 9445 | 02:59:45 INFO - PROCESS | 9445 | Cycle 1(1): loaded http://localhost:35331/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35331/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:59:46 INFO - PROCESS | 9445 | RSS: Main: 156413952 02:59:46 INFO - PROCESS | 9445 | 02:59:48 INFO - PROCESS | 9445 | Cycle 1(1): loaded http://localhost:35331/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35331/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:59:48 INFO - PROCESS | 9445 | RSS: Main: 156651520 02:59:48 INFO - PROCESS | 9445 | 02:59:50 INFO - PROCESS | 9445 | Cycle 1(1): loaded http://localhost:35331/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35331/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:59:51 INFO - PROCESS | 9445 | RSS: Main: 157261824 02:59:51 INFO - PROCESS | 9445 | 02:59:54 INFO - PROCESS | 9445 | Cycle 1(1): loaded http://localhost:35331/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:59:54 INFO - PROCESS | 9445 | RSS: Main: 157548544 02:59:54 INFO - PROCESS | 9445 | 02:59:57 INFO - PROCESS | 9445 | Cycle 1(1): loaded http://localhost:35331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:59:58 INFO - PROCESS | 9445 | RSS: Main: 157528064 02:59:58 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | Cycle 1(1): loaded http://localhost:35331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35331/tests/kraken/driver.html?testName=ai-astar) 02:59:59 INFO - PROCESS | 9445 | RSS: Main: 158470144 02:59:59 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | __start_tp_report 02:59:59 INFO - PROCESS | 9445 | _x_x_mozilla_page_load 02:59:59 INFO - PROCESS | 9445 | _x_x_mozilla_page_load_details 02:59:59 INFO - PROCESS | 9445 | |i|pagename|runs| 02:59:59 INFO - PROCESS | 9445 | |0;ai-astar;100;111;105;109;110;110;110;108;110;112 02:59:59 INFO - PROCESS | 9445 | |1;audio-beat-detection;141;116;153;168;121;149;140;117;186;118 02:59:59 INFO - PROCESS | 9445 | |2;audio-dft;161;163;163;161;161;162;161;163;162;162 02:59:59 INFO - PROCESS | 9445 | |3;audio-fft;74;79;76;184;75;77;75;76;183;76 02:59:59 INFO - PROCESS | 9445 | |4;audio-oscillator;84;85;152;84;83;84;144;84;84;145 02:59:59 INFO - PROCESS | 9445 | |5;imaging-gaussian-blur;117;118;117;118;117;118;117;118;117;117 02:59:59 INFO - PROCESS | 9445 | |6;imaging-darkroom;147;148;146;150;147;146;146;147;146;146 02:59:59 INFO - PROCESS | 9445 | |7;imaging-desaturate;95;96;97;96;95;95;95;96;95;96 02:59:59 INFO - PROCESS | 9445 | |8;json-parse-financial;51;50;51;54;52;53;49;54;52;54 02:59:59 INFO - PROCESS | 9445 | |9;json-stringify-tinderbox;61;61;62;61;60;61;61;62;60;61 02:59:59 INFO - PROCESS | 9445 | |10;stanford-crypto-aes;72;73;73;72;72;73;71;72;72;73 02:59:59 INFO - PROCESS | 9445 | |11;stanford-crypto-ccm;130;119;125;127;128;126;124;124;153;123 02:59:59 INFO - PROCESS | 9445 | |12;stanford-crypto-pbkdf2;154;170;156;155;152;151;156;158;153;161 02:59:59 INFO - PROCESS | 9445 | |13;stanford-crypto-sha256-iterative;62;63;71;61;64;61;62;63;60;65 02:59:59 INFO - PROCESS | 9445 | __end_tp_report 02:59:59 INFO - PROCESS | 9445 | __start_cc_report 02:59:59 INFO - PROCESS | 9445 | _x_x_mozilla_cycle_collect,848 02:59:59 INFO - PROCESS | 9445 | __end_cc_report 02:59:59 INFO - PROCESS | 9445 | __startTimestamp1471341599968__endTimestamp 02:59:59 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | ------- Summary: start ------- 02:59:59 INFO - PROCESS | 9445 | Number of tests: 14 02:59:59 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:3.54 (3.2%) stddev-sans-first:2.01 02:59:59 INFO - PROCESS | 9445 | Values: 100.0 111.0 105.0 109.0 110.0 110.0 110.0 108.0 110.0 112.0 02:59:59 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:145.00 stddev:23.79 (16.4%) stddev-sans-first:25.23 02:59:59 INFO - PROCESS | 9445 | Values: 141.0 116.0 153.0 168.0 121.0 149.0 140.0 117.0 186.0 118.0 02:59:59 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 02:59:59 INFO - PROCESS | 9445 | Values: 161.0 163.0 163.0 161.0 161.0 162.0 161.0 163.0 162.0 162.0 02:59:59 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | [#3] audio-fft Cycles:10 Average:97.50 Median:76.00 stddev:45.35 (59.7%) stddev-sans-first:47.29 02:59:59 INFO - PROCESS | 9445 | Values: 74.0 79.0 76.0 184.0 75.0 77.0 75.0 76.0 183.0 76.0 02:59:59 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:84.00 stddev:30.50 (36.3%) stddev-sans-first:31.58 02:59:59 INFO - PROCESS | 9445 | Values: 84.0 85.0 152.0 84.0 83.0 84.0 144.0 84.0 84.0 145.0 02:59:59 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:59:59 INFO - PROCESS | 9445 | Values: 117.0 118.0 117.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 02:59:59 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.29 (0.9%) stddev-sans-first:1.36 02:59:59 INFO - PROCESS | 9445 | Values: 147.0 148.0 146.0 150.0 147.0 146.0 146.0 147.0 146.0 146.0 02:59:59 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 02:59:59 INFO - PROCESS | 9445 | Values: 95.0 96.0 97.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 02:59:59 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.50 stddev:1.76 (3.4%) stddev-sans-first:1.83 02:59:59 INFO - PROCESS | 9445 | Values: 51.0 50.0 51.0 54.0 52.0 53.0 49.0 54.0 52.0 54.0 02:59:59 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 02:59:59 INFO - PROCESS | 9445 | Values: 61.0 61.0 62.0 61.0 60.0 61.0 61.0 62.0 60.0 61.0 02:59:59 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | [#10] stanford-crypto-aes Cycles:10 Average:72.30 Median:72.50 stddev:0.67 (0.9%) stddev-sans-first:0.71 02:59:59 INFO - PROCESS | 9445 | Values: 72.0 73.0 73.0 72.0 72.0 73.0 71.0 72.0 72.0 73.0 02:59:59 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:126.50 stddev:9.31 (7.4%) stddev-sans-first:9.85 02:59:59 INFO - PROCESS | 9445 | Values: 130.0 119.0 125.0 127.0 128.0 126.0 124.0 124.0 153.0 123.0 02:59:59 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.60 Median:156.00 stddev:5.54 (3.6%) stddev-sans-first:5.80 02:59:59 INFO - PROCESS | 9445 | Values: 154.0 170.0 156.0 155.0 152.0 151.0 156.0 158.0 153.0 161.0 02:59:59 INFO - PROCESS | 9445 | 02:59:59 INFO - PROCESS | 9445 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:3.12 (5.0%) stddev-sans-first:3.28 02:59:59 INFO - PROCESS | 9445 | Values: 62.0 63.0 71.0 61.0 64.0 61.0 62.0 63.0 60.0 65.0 02:59:59 INFO - PROCESS | 9445 | -------- Summary: end -------- 02:59:59 INFO - PROCESS | 9445 | 03:00:00 INFO - TEST-INFO | 9445: exit 0 03:00:00 INFO - TEST-OK | kraken | took 60517ms 03:00:00 INFO - SUITE-END | took 1170s 03:00:01 INFO - Completed test suite (00:19:31) 03:00:01 INFO - javascript benchmark 03:00:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7852.074889290913, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3267.232200432898, 3288.6053673559177, 3300.9504857427137, 3309.933801323972, 3312.039508542523, 5723.170140329655, 5788.450097240766, 5793.826185214451, 5820.6507609543405, 5824.3010838699365, 5770.971145144268, 5835.533157347402, 5835.562332825045, 5888.528917686585, 5888.941110588893, 5330.866728331794, 5332.386775520807, 5362.51737343639, 5392.379876314215, 5393.487618676219, 5210.739463026853, 5213.973930130344, 5260.763265653036, 5273.34083239595, 5293.126634105368, 5275.393329767087, 5311.787528498875, 5317.042932272189, 5378.569714422837, 5393.083175860093, 5351.598630102758, 5358.33020872391, 5366.114591092465, 5366.570674346082, 5381.569474442035, 5097.7960881564695, 5192.792288308463, 5238.947610523884, 5271.630985830993, 5327.46725327468, 5833.387494313079, 5848.41515848416, 5861.472467477947, 5873.324567674729, 5890.116482527612, 6271.43557079865, 6301.905471417932, 6310.274318453391, 6316.74733010679, 6323.14637523933, 5971.0, 6145.231846019247, 6311.779087731953, 6345.904811427832, 6349.555531112824, 5785.681787501686, 5850.736716847752, 5860.824175274749, 5873.676947767871, 5886.764529418818, 6377.808665740035, 6403.231612206565, 6407.711652975628, 6427.0, 6443.387878151568, 5957.493613042853, 5986.191864098378, 6166.136740856284, 6172.969135154385, 6185.8144255672405, 6119.5104391648565, 6174.38256174388, 6221.06683997404, 6234.064890266496, 6250.218722659668, 6172.135900973867, 6174.44430001302, 6182.227221597301, 6183.103449999725, 6203.8138855833495, 5959.314678811992, 6077.1491991121275, 6174.38256174388, 6176.073588961602, 6193.194884664965, 4701.130290896195, 4774.212254977959, 4777.474477807438, 4781.043791241766, 4802.567768900815, 4233.1956928183545, 4242.745435273831, 4247.830086796494, 4266.06146647737, 4271.402003719481, 5831.650100993869, 5871.4715675589405, 6008.849778755566, 6064.4541991221, 6072.332043475214, 6134.570580059442, 6278.874422511524, 6280.874382512324, 6300.59046161998, 6306.148669929593, 5971.367700057791, 6015.488683461867, 6041.033434650522, 6047.183630209865, 6055.424734650202, 5242.0, 5299.655522391032, 5354.866128346823, 5361.222622719683, 5413.242146099549, 6360.459360954371, 6528.673566321665, 6540.640264785482, 6545.149130613085, 6553.049807777846, 6251.906221406592, 6277.623342599459, 6286.811395658137, 6294.590851594632, 6318.652474113968, 6256.812295631138, 6281.277653069956, 6456.580322279225, 6477.190351206099, 6530.346965303432, 5991.430814072831, 6104.633721976696, 6107.0, 6107.114468401968, 6131.693415329127, 6135.305123203715, 6158.04550294705, 6193.535484838565, 6194.194754681863, 6212.223472065992, 5926.348101708722, 5986.521078313812, 6021.142409156093, 6043.184170136975, 6086.087086936818, 6045.214122164267, 6126.540509461719, 6129.267100814889, 6137.862137862138, 6141.946315431794, 6023.3073196582955, 6076.605020673642, 6077.604955677867, 6080.756769729338, 6097.0, 5936.376680448663, 6123.601965872204, 6141.477974372228, 6171.56799024064, 6181.041938499539, 6001.189839371629, 6092.573519853568, 6097.268327800515, 6110.052941794029, 6130.969345153246], "value": 5747.100333923389, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.9304083509979, 642.1844257792603, 651.1047309948821, 666.1473314157878, 691.7475121580625, 41913.79043104784, 46174.0, 46201.53798462015, 46205.53794462054, 46347.53652463474, 45679.0, 45938.77030614851, 46239.76880115603, 46260.0, 46269.76865115669, 8978.86531702025, 9075.36472446929, 9142.314326425512, 9156.954215228914, 9197.49413782245, 9112.726618201465, 9164.725058248263, 9194.448333100036, 9235.168834804866, 9250.259979201648, 9267.304952128583, 9270.953645231764, 9273.814523709521, 9279.72160835176, 9282.164605185531, 9153.588088536031, 9225.215856652192, 9235.538223088819, 9255.167034966818, 9265.212456941168, 9069.818603627957, 9117.225035871892, 9173.128552787475, 9181.540922953825, 9187.586558604879, 44037.11925761499, 44610.33084503735, 44671.0, 44679.776601116784, 44691.329630055574, 4131.731437456556, 4168.7707176105305, 4323.2218200723855, 4407.823687052514, 4635.980084381431, 34678.47982280268, 34844.0, 35019.1245218869, 35326.646733532594, 36579.0, 4749.833755818564, 4764.475907650156, 4790.305405716152, 4791.9520804791855, 4837.7339246341435, 358280.0, 358777.0, 360226.1988690066, 362088.0, 362239.0, 62879.0, 63415.0, 63487.0, 63506.36493635097, 63515.364846350945, 40016.19967600632, 40728.796356018625, 40849.591504085176, 43131.0, 67163.66418167877, 18784.0, 19127.426177214707, 19130.617387652168, 19159.233630654617, 19228.0, 15068.095914245181, 15105.697886042437, 15111.31999060045, 15197.468088616846, 15226.238688065774, 20857.374278771662, 20946.0, 20963.895180524, 21049.158033678483, 21076.89461552713, 7863.213678632091, 7878.960605196938, 7886.171951944963, 7925.247101525346, 8007.6796928123385, 1031.7730099378125, 1127.5940661361903, 1129.9661010169707, 1142.3203194099497, 1173.3546549397797, 35627.768394094775, 35837.46243806345, 35989.46015809765, 36019.0, 36101.27797444037, 1138.362516990488, 1160.3096157786104, 1192.1237890150733, 1197.9101567382306, 1216.5681183179843, 18691.71962420565, 18832.34086806955, 18877.528061798566, 18897.24411023571, 18900.905495472434, 674158.0, 689886.0, 699795.0, 707561.0, 709432.0, 65525.0, 66056.0, 66199.66900165565, 66222.66888665622, 66282.0, 1395.2465668538875, 1429.0996672096721, 1446.3708286895235, 1484.2652886820877, 1487.3901700302824, 33676.49485257674, 34975.12562185965, 35246.47130292996, 35792.82103589465, 35940.101497462776, 56934.0, 56985.43014569967, 57045.714771425875, 57137.42862571321, 57267.713661433096, 503300.0, 503698.0, 507623.0, 507770.0, 511832.0, 31673.0, 31705.5244171333, 32438.513422298212, 32533.511997319587, 32553.0, 54226.72886635541, 54769.5797516717, 54837.0, 54883.902321954134, 55331.72334138465, 45970.31044534402, 46571.0, 46998.29502557396, 47240.527594723615, 48204.758976204896, 46225.76887115543, 46272.48329526786, 46420.0, 47310.52689473061, 47722.0, 46243.306350405444, 47000.0, 47607.28589071236, 48200.75899620479, 49629.0, 37751.81124094362, 40437.59562404338, 40737.59262407338, 41065.0, 41833.163336733705, 31560.0, 31747.52378714275, 31830.363392732477, 32167.195820104684, 32357.838210809736], "value": 22001.699818288336, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.771983389717, 398.551629416906, 430.5801843202877, 430.72864095619764, 436.8078045659909, 19850.106745196485, 20077.698834517494, 20758.48103797406, 21205.469863253427, 21227.57544849102, 20046.1981520739, 20350.0, 20436.8978155109, 20703.0, 21161.788382116174, 5819.039858423365, 6008.1888944992525, 6036.577439579231, 6047.183630209931, 6060.909086363708, 5897.675627840467, 5906.37983011784, 5920.4671579557835, 5926.0, 5955.315138759055, 5753.424657534255, 5874.5594080443925, 5920.792772252972, 5928.02187639039, 5931.110333449996, 5901.232839730829, 5923.407659234085, 5939.1388248704125, 5980.0, 5983.042713165873, 5342.572594192456, 5356.009138309386, 5358.4641535846495, 5364.6512976656395, 5392.487713667196, 22241.332760017227, 23053.0, 23999.0, 24989.87505062463, 25140.0, 2402.243293362585, 2514.5222407742654, 2545.300042488312, 2584.043903755604, 3113.315070684446, 10997.505112269968, 11044.779104417867, 11099.72250693739, 11302.491387887565, 11364.94317528407, 2081.5004398944143, 2091.8117369436823, 2104.326615483046, 2112.176251262009, 2120.4062862398555, 79761.0, 88040.0, 89157.0, 89666.0, 89811.55094224552, 11575.710607234718, 11671.941640291745, 11798.882011179778, 11828.645140645795, 11943.163978521594, 16931.576710582332, 16934.83065169357, 16974.236159372856, 16996.57508562271, 17004.57488562771, 8889.866652000224, 9132.3150763693, 9140.360174787702, 9175.44947303164, 9201.90798092024, 8711.738647840575, 8727.432716873383, 8802.471851688919, 8980.0, 8998.14517620825, 4950.63123249992, 5064.18972964324, 5094.872628184325, 5126.641135120506, 5189.6886186828915, 1998.520355114762, 2036.725042119295, 2063.8452116091353, 2074.3984244569206, 2128.968065479019, 975.853621956698, 1084.159776173456, 1089.9782004359868, 1111.1666250312267, 1126.1385040444068, 20954.685679714818, 21034.053467593996, 21049.158033678483, 21074.578508429746, 21438.03528841206, 1061.2836335473523, 1089.3899416326883, 1091.5633746501305, 1093.2128867215592, 1114.1755101225035, 11385.14611404148, 11586.942065289619, 11622.0, 11693.123015773852, 11776.941115294369, 501520.0, 523122.0, 523449.0, 546178.0, 546990.0, 88906.55546722225, 90947.0, 91680.54159729158, 97698.0, 100294.49852750689, 1028.1774580335702, 1043.6138628707274, 1046.199657262195, 1064.5741703318579, 1066.935983840972, 17525.0, 17965.550861228574, 18425.170867310735, 18433.815661843746, 18468.261269549606, 40690.59309406868, 41242.0, 41333.37999930064, 41886.79056604698, 42589.36115958201, 60169.69915150396, 60449.0, 61510.38489615046, 61510.69244653748, 61930.0, 8440.113788052411, 8567.700130495403, 8686.913130868863, 9063.68277110298, 9114.40756350835, 12167.574134905235, 13556.72886542244, 13557.118787278796, 13571.660708482366, 13631.25028123423, 11829.82255266189, 12191.085668574715, 12651.177673451564, 12673.0, 12897.226166430044, 11380.54477820911, 11804.0, 12437.0, 12557.309347985949, 12565.057620678303, 11890.46492907804, 11923.224990375598, 12117.394130293625, 12173.0, 12588.559400420942, 7838.137804841349, 8223.753287401387, 8249.340052795882, 8670.26302764272, 8779.385443018928, 8866.911330886609, 11736.471858766205, 11986.76026479483, 12097.697557561132, 12660.683482913], "value": 9723.204365578085, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.1941861104308, 1552.0299812617113, 1712.691715491211, 1792.301002608982, 1815.3555487801839, 8015.559144247064, 8899.510526921016, 9199.31005174613, 9576.47329396883, 9596.712098637052, 9292.349535532516, 9591.616335346578, 9597.424154550732, 9607.183389411892, 9612.279079069063, 2532.9620055699133, 2563.3976015636313, 2567.7303883092286, 2572.254046326563, 2575.987120064397, 2438.0735320578156, 2441.377448750575, 2441.4628781668093, 2443.584590619599, 2443.6334549817493, 2476.170482888235, 2485.5774518331928, 2489.2283392148493, 2508.648789169518, 2512.309114993373, 2429.720582133051, 2432.2946345559676, 2443.6701045358827, 2500.5374005808985, 2513.7360577139502, 2423.648570957219, 2428.854268743881, 2440.6583078369044, 2453.251758213744, 2468.4075821802817, 9316.161545460942, 9361.62553497866, 9627.085426884434, 9698.51507424626, 9724.902750972471, 5599.944000559983, 5778.104393818965, 5779.566532510036, 5780.046292361755, 5789.913151302734, 3422.8973130806116, 3527.664871837171, 3535.7878527288444, 3585.515955346047, 3626.564812222524, 1261.396524985921, 1305.8498272698666, 1316.1773891317926, 1322.5106710517075, 1338.1168428837018, 13338.13302135358, 13368.465261389532, 13380.598582042554, 13390.129641573267, 13391.0, 4822.9758851206225, 5009.5491405773655, 5019.347484826949, 5074.543291103819, 5088.847334579968, 11472.88527114718, 11495.827562586568, 11505.194636375374, 11558.075353971662, 11559.133065020158, 5621.325440947113, 5623.971880140655, 5624.831255062355, 5626.1842032905, 5643.040683083886, 4522.479914809774, 5206.219067139959, 5230.08473517133, 5272.92090618641, 5306.310179676694, 4354.9564504355185, 4386.561343865652, 4390.934135987963, 4412.933805992912, 4469.173202957463, 1396.6508372906774, 1411.5765270418833, 1423.3168079321983, 1437.475321507642, 1443.2855736410545, 1073.4042606353394, 1085.9945700271605, 1086.3101930274333, 1089.6948854320804, 1103.7295862513574, 6393.9360606394275, 6585.604863708193, 6691.364320389653, 6791.898121528181, 6844.0, 478.2491488363236, 487.33817681705216, 490.619769678502, 493.1714719271586, 497.27149725652095, 4326.718763280377, 4377.562243775597, 4411.316245981878, 4565.748883811422, 4589.609883159902, 11423.200375973769, 11905.761884762429, 11975.46110425033, 12090.609579898248, 12105.87894121065, 11897.34564598938, 11919.106067045006, 11983.041356691443, 12005.87994120065, 12033.097517686034, 8447.070822209553, 8878.911210887938, 8895.377323587287, 8999.640014399612, 9057.094290571022, 6791.388775010273, 6838.487113466411, 6886.69009894566, 6991.161060672548, 7058.964705176647, 10852.403117828595, 10971.615993440191, 11054.557817687202, 11204.943975280397, 11273.71815704614, 11133.387663678575, 11186.720331991766, 11286.435678215892, 11290.15323850698, 11373.943130284295, 8074.071481779436, 8267.669293228204, 8301.792455188668, 8590.78523036929, 8726.69456569017, 9473.384230025027, 9573.2820038496, 9599.616015359308, 9624.855627165458, 9637.614495420105, 8037.517748935083, 8151.1441298662785, 8199.385046121684, 8270.545120018456, 8377.45546539473, 7979.48133371329, 7994.200579941959, 8008.879866801886, 8065.233802788725, 8219.671213151407, 7547.358474529727, 7576.431767617561, 7600.049993750781, 7603.20166382544, 7674.155842857393, 5786.074228123648, 5865.501432378295, 5940.61386009908, 5941.287045554561, 6047.455728984412, 5837.270341207349, 5878.764849406147, 5941.702914854326, 5966.134910437875, 5974.1636170935235], "value": 4969.5625496649845, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.59055881016235, 359.1022443890274, 365.0763568172523, 367.28929521376125, 368.20651496026073, 5856.8242952711435, 5865.765369385224, 5872.9119063213975, 5891.351951285361, 5966.8806623867495, 5502.486816125567, 5816.796412125576, 5830.970845145779, 5836.970815145929, 5840.474357307841, 4482.955170448295, 4505.414296141514, 4508.098380323932, 4515.977420112895, 4523.434570678665, 4503.0318481526465, 4526.841560545382, 4540.364348991144, 4550.863474095782, 4567.520410356915, 4381.3208952612395, 4539.841105561306, 4553.4535855697195, 4557.658175636824, 4569.29175977724, 4463.598276155145, 4484.654603618901, 4494.1910456117885, 4498.797554110073, 4509.30105833593, 3955.149642826806, 3958.366661334173, 3962.702797290186, 3970.6029397060065, 4004.1391100913443, 5581.274434323512, 5645.576581756343, 5646.604737668365, 5691.065037887097, 5695.658260504383, 5168.862850172956, 5191.688498690053, 5231.424543300234, 5252.896891652719, 5275.446078161776, 6093.573449858512, 6128.988716861712, 6130.417610327012, 6154.0, 6211.751529938842, 4286.485621725382, 4353.194658988097, 4367.71609845359, 4370.2789039808395, 4401.383806267125, 6162.352952939967, 6331.55679102463, 6361.236651601837, 6373.490120790326, 6381.4575761059905, 4468.32975053738, 4494.1461122386645, 4531.410916580823, 4539.182947069493, 4540.364348991144, 4575.17646823575, 4575.9084818303445, 4588.426446694163, 4594.356790049395, 4596.770161491912, 5128.307678463434, 5210.973945130326, 5233.764480598382, 5245.291885595396, 5269.392835185306, 6106.786262480792, 6119.969400152971, 6145.8156255312415, 6147.72335244915, 6194.566380353423, 1549.9922500387427, 1571.591386239563, 1578.5185518416993, 1579.8499142581436, 1580.1072394097298, 1005.2460654509118, 1008.1531513528524, 1011.7318910488726, 1025.2310766924807, 1030.1192480429274, 5248.795505887537, 5296.225764368903, 5337.343919415213, 5339.46605339463, 5350.592233494943, 5513.511351935035, 5540.866766295006, 5574.16387541872, 5581.720913954286, 5600.355959064678, 4992.600591952635, 5227.215917612389, 5289.709066001406, 5301.708406037705, 5304.9841060397575, 2961.718636729507, 2964.4663960486887, 2975.747061499797, 2984.850757462118, 2986.2982199183175, 5708.600397972102, 5757.251557297524, 5780.855478613068, 5798.739056742456, 6089.421504957022, 6466.547341686037, 6481.902771458432, 6510.934890651128, 6556.18047744032, 6587.473002159912, 6621.569597976116, 6658.83352916181, 6662.735259722798, 6676.232233293136, 6709.161354830646, 6179.0, 6349.428551430394, 6350.301466838551, 6403.29563747978, 6416.807495775134, 6304.84237894038, 6325.588836725598, 6328.968355158195, 6346.936530634634, 6385.169927909342, 6307.779227727191, 6438.714256438897, 6512.6092434454085, 6561.639109848813, 6567.835804104744, 4456.5766252205985, 4473.664475164311, 4499.865004049884, 4506.301523263899, 4519.254323036662, 6210.192674952227, 6275.560710750204, 6355.428011478989, 6428.553575445674, 6458.741650333934, 6147.754089836357, 6171.382861713792, 6175.783847565313, 6196.349383314687, 6207.503399727921, 5906.438888305604, 6168.272883592601, 6255.937440625536, 6273.843153921006, 6290.874182516415, 6071.423214794588, 6075.30134034574, 6075.756969721162, 6094.013933172625, 6169.413905678954, 6257.374262573706, 6290.528210384148, 6299.937000629935, 6312.2740884796995, 6342.748324344791, 5846.473817356458, 6022.337542870193, 6049.909251361145, 6074.42292982166, 6090.543209259412], "value": 4616.496910165338, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.7355359508161, 820.5035953248284, 821.5317269156582, 852.8507511185541, 915.1534830281992, 15502.534923952286, 16951.321947122116, 17045.659086818257, 17072.573185670335, 17155.399561015365, 15358.846411535882, 16686.332546698148, 16790.32838686454, 16864.241109150087, 16906.15469226537, 869.8173383589437, 897.4211633496391, 900.2707806676581, 901.3555307954811, 901.5266984832982, 893.3880291999968, 895.4537731983485, 900.75679566517, 902.3412908576743, 902.5893218585561, 943.4150826487553, 946.7633091727068, 947.1854205383365, 947.7725345916999, 948.6584829461389, 941.0683423410808, 941.9717408477757, 943.1181844974902, 944.9952750236273, 945.121037435185, 681.6489507903434, 688.8518968421813, 689.7275576147443, 690.1649004704313, 691.5919607431589, 16466.42367517131, 16851.494455166365, 16971.151442427952, 17000.3199872005, 17056.317747290093, 16493.34026638933, 17287.481375558753, 17446.389376371768, 17666.0, 17772.28910843565, 13474.326283685776, 13502.729945401037, 13506.864931350758, 13588.116772409761, 13604.591862244148, 4167.371006393755, 4186.246475634384, 4221.197972385267, 4240.851570195028, 4292.034292284242, 70037.64981175061, 73437.0, 74807.62596187039, 83619.5819020901, 87536.0, 12785.424655890507, 12896.161749486253, 12904.290264035568, 13004.414801333962, 13130.0, 23183.652245216334, 23255.767442325698, 23257.651135232984, 23323.883380583327, 23341.0, 9198.402103863227, 9564.18704410119, 9697.515124243759, 9732.07545283197, 9790.5594248259, 5291.867703307371, 5369.946300537023, 5428.348598168166, 5435.402105768362, 5521.475459831309, 3821.9426708599394, 3937.6062393760394, 3964.980175099106, 3969.503812023497, 3971.2057588481844, 647.1263793878321, 656.2354856592112, 659.1496968910149, 667.5327270910382, 680.0933889172552, 723.3742812467178, 756.9969790028234, 758.5789886612872, 791.5488171742167, 795.562440657636, 10264.846027309597, 10482.213833962483, 10719.767226769021, 10739.570417183382, 10742.73143171427, 725.5139056831936, 765.8698021336386, 822.4284122534781, 829.7469271872017, 834.2866848844151, 5074.2895994560795, 5265.420803711589, 5289.973550132302, 5348.893022139613, 5371.811986580451, 78328.0, 109305.0, 130201.0, 134125.32937335447, 136565.31717341547, 55525.16712249319, 115163.0, 116190.47619047618, 117240.0, 119972.0, 70118.64940675366, 88516.0, 91654.0, 91779.54110229407, 94687.99999999862, 10525.368657835541, 10969.177311701495, 11069.728534724927, 11242.66272011841, 11367.658970230907, 54958.0, 55028.72485637546, 55453.554849013046, 57327.0, 58722.4127758734, 73443.63278183575, 80918.19081809343, 83108.58445707733, 83195.0, 84531.5773421129, 13835.0, 14250.786238206643, 14617.561473155822, 14631.487897923522, 14701.33843977045, 15125.092494450368, 15200.139313879321, 15301.0, 15410.768838467657, 15817.0, 13743.862561374259, 13751.312434378442, 14240.430382784572, 14251.429942802586, 14433.7834932474, 14856.480023199136, 15159.848401516285, 15672.0, 16186.109763962624, 16281.75577366364, 12712.6821829455, 13024.609261722164, 13316.201027938354, 13659.317034148451, 13931.58205253844, 12258.387080646111, 12377.814332784836, 12920.418581163682, 12945.54690585825, 13434.529791457253, 13178.868211317764, 13380.665483362995, 13454.192748435125, 13458.663533411744, 13515.662108446973], "value": 8308.442481376003, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1504.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 105.0, 109.0, 110.0, 110.0, 110.0, 108.0, 110.0, 112.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 153.0, 168.0, 121.0, 149.0, 140.0, 117.0, 186.0, 118.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 161.0, 161.0, 162.0, 161.0, 163.0, 162.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 79.0, 76.0, 184.0, 75.0, 77.0, 75.0, 76.0, 183.0, 76.0], "value": 97.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 152.0, 84.0, 83.0, 84.0, 144.0, 84.0, 84.0, 145.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 150.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 54.0, 52.0, 53.0, 49.0, 54.0, 52.0, 54.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 60.0, 61.0, 61.0, 62.0, 60.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 72.0, 72.0, 73.0, 71.0, 72.0, 72.0, 73.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 119.0, 125.0, 127.0, 128.0, 126.0, 124.0, 124.0, 153.0, 123.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 170.0, 156.0, 155.0, 152.0, 151.0, 156.0, 158.0, 153.0, 161.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 71.0, 61.0, 64.0, 61.0, 62.0, 63.0, 60.0, 65.0], "value": 63.2, "unit": "score"}]}]} 03:00:01 INFO - Return code: 0 03:00:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:00:01 ERROR - # TBPL SUCCESS # 03:00:01 INFO - Running post-action listener: _resource_record_post_action 03:00:01 INFO - [mozharness: 2016-08-16 10:00:01.291519Z] Finished run-tests step (success) 03:00:01 INFO - Running post-run listener: _resource_record_post_run 03:00:01 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 266240; Write bytes: 329285632; Read time: 20; Write time: 255464 03:00:01 INFO - TinderboxPrint: CPU usage
13.2% 03:00:01 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 20 03:00:01 INFO - TinderboxPrint: I/O write bytes / time
329,285,632 / 255,464 03:00:01 INFO - TinderboxPrint: CPU idle
8,215.5 (86.7%) 03:00:01 INFO - TinderboxPrint: CPU user
1,199.3 (12.7%) 03:00:01 INFO - TinderboxPrint: Swap in / out
0 / 0 03:00:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 79126528; Read time: 0; Write time: 88512 03:00:01 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 262144; Write bytes: 250159104; Read time: 12; Write time: 166952 03:00:01 INFO - Running post-run listener: _upload_blobber_files 03:00:01 INFO - Blob upload gear active. 03:00:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:00:01 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 03:00:01 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'] 03:00:01 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 03:00:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:00:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:00:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:00:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:00:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:00:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:00:07 INFO - (blobuploader) - INFO - Done attempting. 03:00:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:00:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:00:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:00:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:00:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:00:10 INFO - (blobuploader) - INFO - Done attempting. 03:00:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:00:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:00:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:00:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:00:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:00:11 INFO - (blobuploader) - INFO - Done attempting. 03:00:11 INFO - (blobuploader) - INFO - Iteration through files over. 03:00:11 INFO - Return code: 0 03:00:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:00:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:00:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7da09e422e5a58819dafc32f097aedf476ea9228696d9a56269b67c1ba608dd33e6e120033d33db98ac8b5dad42dff00acbcc82fe063cd1d1bd11cedebfb5409", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b3090ed57f79a22275bdb387c909c183d46a6cd66f6d6031b169fc562b069318061ab76bb324c2b8691af0a3295458e9cb11fcb51427d16daccb608f0afa68c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de49dfded65a6449fe3bbbfeae53bb3d570fb7d27ed1eb2c6d5114e29934e021a4862a53797a4f09e70ffaf58aac727c68244bc71546c4dcfa593c2f8126756a"} 03:00:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:00:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:00:11 INFO - Contents: 03:00:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7da09e422e5a58819dafc32f097aedf476ea9228696d9a56269b67c1ba608dd33e6e120033d33db98ac8b5dad42dff00acbcc82fe063cd1d1bd11cedebfb5409", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b3090ed57f79a22275bdb387c909c183d46a6cd66f6d6031b169fc562b069318061ab76bb324c2b8691af0a3295458e9cb11fcb51427d16daccb608f0afa68c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de49dfded65a6449fe3bbbfeae53bb3d570fb7d27ed1eb2c6d5114e29934e021a4862a53797a4f09e70ffaf58aac727c68244bc71546c4dcfa593c2f8126756a"} 03:00:11 INFO - Running post-run listener: copy_logs_to_upload_dir 03:00:11 INFO - Copying logs to upload dir... 03:00:11 INFO - mkdir: /builds/slave/test/build/upload/logs 03:00:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1680.404765 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 0 secs) (at 2016-08-16 03:00:11.159680) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 03:00:11.162878) ========= 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=ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857 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/7da09e422e5a58819dafc32f097aedf476ea9228696d9a56269b67c1ba608dd33e6e120033d33db98ac8b5dad42dff00acbcc82fe063cd1d1bd11cedebfb5409", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b3090ed57f79a22275bdb387c909c183d46a6cd66f6d6031b169fc562b069318061ab76bb324c2b8691af0a3295458e9cb11fcb51427d16daccb608f0afa68c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de49dfded65a6449fe3bbbfeae53bb3d570fb7d27ed1eb2c6d5114e29934e021a4862a53797a4f09e70ffaf58aac727c68244bc71546c4dcfa593c2f8126756a"} build_url:https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011444 build_url: 'https://queue.taskcluster.net/v1/task/FFbudK1FRnyeFqh_BSQqlA/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/7da09e422e5a58819dafc32f097aedf476ea9228696d9a56269b67c1ba608dd33e6e120033d33db98ac8b5dad42dff00acbcc82fe063cd1d1bd11cedebfb5409", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b3090ed57f79a22275bdb387c909c183d46a6cd66f6d6031b169fc562b069318061ab76bb324c2b8691af0a3295458e9cb11fcb51427d16daccb608f0afa68c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de49dfded65a6449fe3bbbfeae53bb3d570fb7d27ed1eb2c6d5114e29934e021a4862a53797a4f09e70ffaf58aac727c68244bc71546c4dcfa593c2f8126756a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 03:00:11.188373) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 03:00:11.188727) ========= 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=ed14279e38b05397cf4aa391000001a4-1471339468.625282-1179295857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 03:00:11.274251) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 03:00:11.274575) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 03:00:11.274871) ========= ========= Total master_lag: 0.15 =========