builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1474650286.11 results: success (0) buildid: 20160923070600 builduid: d3a4345ffe5243efac999edc13dcd065 revision: bc1c04505a77efd394e1c0e633dd6ecd447ce522 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 10:04:46.107315) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 10:04:46.107723) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 10:04:46.107996) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 10:04:46.123904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 10:04:46.124180) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-23 10:04:47-- 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% 215M=0s 2016-09-23 10:04:47 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.068982 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 10:04:46.208650) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 10:04:46.208954) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018768 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 10:04:46.258230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 10:04:46.258611) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bc1c04505a77efd394e1c0e633dd6ecd447ce522 --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-beta --rev bc1c04505a77efd394e1c0e633dd6ecd447ce522 --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=516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-23 10:04:47,325 truncating revision to first 12 chars 2016-09-23 10:04:47,325 Setting DEBUG logging. 2016-09-23 10:04:47,325 attempt 1/10 2016-09-23 10:04:47,325 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bc1c04505a77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 10:04:47,995 unpacking tar archive at: mozilla-beta-bc1c04505a77/testing/mozharness/ program finished with exit code 0 elapsedTime=1.052636 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 10:04:47.329787) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 10:04:47.330108) ========= script_repo_revision: bc1c04505a77efd394e1c0e633dd6ecd447ce522 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 10:04:47.330494) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 10:04:47.330834) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 10:04:47.341655) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-09-23 10:04:47.341932) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:04:48 INFO - MultiFileLogger online at 20160923 10:04:48 in /builds/slave/test 10:04:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:04:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:04:48 INFO - {'append_to_log': False, 10:04:48 INFO - 'base_work_dir': '/builds/slave/test', 10:04:48 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:04:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:04:48 INFO - 'branch': 'Mozilla-Beta', 10:04:48 INFO - 'buildbot_json_path': 'buildprops.json', 10:04:48 INFO - 'config_files': ('talos/linux_config.py',), 10:04:48 INFO - 'default_actions': ('clobber', 10:04:48 INFO - 'read-buildbot-config', 10:04:48 INFO - 'download-and-extract', 10:04:48 INFO - 'populate-webroot', 10:04:48 INFO - 'create-virtualenv', 10:04:48 INFO - 'install', 10:04:48 INFO - 'run-tests'), 10:04:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:04:48 INFO - 'download_minidump_stackwalk': True, 10:04:48 INFO - 'download_symbols': 'ondemand', 10:04:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:04:48 INFO - 'tooltool.py': '/tools/tooltool.py', 10:04:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:04:48 INFO - '/tools/misc-python/virtualenv.py')}, 10:04:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:04:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:04:48 INFO - 'installer_path': 'installer.exe', 10:04:48 INFO - 'log_level': 'info', 10:04:48 INFO - 'log_name': 'talos', 10:04:48 INFO - 'log_to_console': True, 10:04:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:04:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:04:48 INFO - 'opt_config_files': (), 10:04:48 INFO - 'pip_index': False, 10:04:48 INFO - 'sps_profile': False, 10:04:48 INFO - 'sps_profile_interval': 0, 10:04:48 INFO - 'suite': 'dromaeojs-e10s', 10:04:48 INFO - 'system_bits': '32', 10:04:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:04:48 INFO - 'title': 'talos-linux64-ix-061', 10:04:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:04:48 INFO - 'use_talos_json': True, 10:04:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:04:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:04:48 INFO - 'work_dir': 'build'} 10:04:48 INFO - [mozharness: 2016-09-23 17:04:48.500760Z] Running clobber step. 10:04:48 INFO - Running pre-action listener: _resource_record_pre_action 10:04:48 INFO - Running main action method: clobber 10:04:48 INFO - rmtree: /builds/slave/test/build 10:04:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:04:49 INFO - Running post-action listener: _resource_record_post_action 10:04:49 INFO - [mozharness: 2016-09-23 17:04:49.476191Z] Finished clobber step (success) 10:04:49 INFO - [mozharness: 2016-09-23 17:04:49.476292Z] Running read-buildbot-config step. 10:04:49 INFO - Running pre-action listener: _resource_record_pre_action 10:04:49 INFO - Running main action method: read_buildbot_config 10:04:49 INFO - Using buildbot properties: 10:04:49 INFO - { 10:04:49 INFO - "project": "", 10:04:49 INFO - "product": "firefox", 10:04:49 INFO - "script_repo_revision": "production", 10:04:49 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 10:04:49 INFO - "repository": "", 10:04:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 10:04:49 INFO - "buildid": "20160923070600", 10:04:49 INFO - "pgo_build": "True", 10:04:49 INFO - "basedir": "/builds/slave/test", 10:04:49 INFO - "buildnumber": 259, 10:04:49 INFO - "slavename": "talos-linux64-ix-061", 10:04:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:04:49 INFO - "platform": "ubuntu64_hw", 10:04:49 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:04:49 INFO - "branch": "mozilla-beta", 10:04:49 INFO - "repo_path": "releases/mozilla-beta", 10:04:49 INFO - "revision": "bc1c04505a77efd394e1c0e633dd6ecd447ce522", 10:04:49 INFO - "stage_platform": "linux64-pgo", 10:04:49 INFO - "builduid": "d3a4345ffe5243efac999edc13dcd065", 10:04:49 INFO - "slavebuilddir": "test" 10:04:49 INFO - } 10:04:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 10:04:49 INFO - Running post-action listener: _resource_record_post_action 10:04:49 INFO - [mozharness: 2016-09-23 17:04:49.478728Z] Finished read-buildbot-config step (success) 10:04:49 INFO - [mozharness: 2016-09-23 17:04:49.478816Z] Running download-and-extract step. 10:04:49 INFO - Running pre-action listener: _resource_record_pre_action 10:04:49 INFO - Running main action method: download_and_extract 10:04:49 INFO - mkdir: /builds/slave/test/build/tests 10:04:49 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')]} 10:04:49 INFO - https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:04:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:04:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:04:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:04:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:04:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:04:49 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:04:49 INFO - retry: Failed, sleeping 30 seconds before retrying 10:05:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 10:05:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:05:19 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:05:19 INFO - retry: Failed, sleeping 60 seconds before retrying 10:06:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 10:06:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:06:19 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:06:19 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 10:06:19 INFO - Caught exception: HTTP Error 404: Not Found 10:06:19 INFO - Caught exception: HTTP Error 404: Not Found 10:06:19 INFO - Caught exception: HTTP Error 404: Not Found 10:06:19 INFO - trying https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:06:19 INFO - Downloading https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:06:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:06:20 INFO - Downloaded 1327 bytes. 10:06:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 10:06:20 INFO - Using the following test package requirements: 10:06:20 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 10:06:20 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:06:20 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:06:20 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:06:20 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 10:06:20 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:06:20 INFO - u'jsshell-linux-x86_64.zip'], 10:06:20 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:06:20 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:06:20 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 10:06:20 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:06:20 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 10:06:20 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:06:20 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 10:06:20 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:06:20 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:06:20 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 10:06:20 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:06:20 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:20 INFO - https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:06:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:06:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:06:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:06:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:06:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:06:20 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:06:20 INFO - retry: Failed, sleeping 30 seconds before retrying 10:06:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 10:06:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:06:50 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:06:50 INFO - retry: Failed, sleeping 60 seconds before retrying 10:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 10:07:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:07:50 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:07:50 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 10:07:50 INFO - Caught exception: HTTP Error 404: Not Found 10:07:50 INFO - Caught exception: HTTP Error 404: Not Found 10:07:50 INFO - Caught exception: HTTP Error 404: Not Found 10:07:50 INFO - trying https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:07:50 INFO - Downloading https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:07:51 INFO - Downloaded 21771304 bytes. 10:07:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:07:52 INFO - Return code: 0 10:07:52 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:52 INFO - https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:07:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:07:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:07:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:07:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:07:52 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:07:52 INFO - retry: Failed, sleeping 30 seconds before retrying 10:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 10:08:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:08:22 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:08:22 INFO - retry: Failed, sleeping 60 seconds before retrying 10:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 10:09:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:09:22 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:09:22 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 10:09:22 INFO - Caught exception: HTTP Error 404: Not Found 10:09:22 INFO - Caught exception: HTTP Error 404: Not Found 10:09:22 INFO - Caught exception: HTTP Error 404: Not Found 10:09:22 INFO - trying https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:09:22 INFO - Downloading https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 10:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:09:24 INFO - Downloaded 21771304 bytes. 10:09:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:09:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:09:25 INFO - Return code: 0 10:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:25 INFO - https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:09:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:09:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:09:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:09:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:09:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:09:25 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:09:25 INFO - retry: Failed, sleeping 30 seconds before retrying 10:09:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 10:09:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:09:55 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:09:55 INFO - retry: Failed, sleeping 60 seconds before retrying 10:10:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 10:10:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:10:55 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:10:55 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 10:10:55 INFO - Caught exception: HTTP Error 404: Not Found 10:10:55 INFO - Caught exception: HTTP Error 404: Not Found 10:10:55 INFO - Caught exception: HTTP Error 404: Not Found 10:10:55 INFO - trying https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:10:55 INFO - Downloading https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 10:10:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:10:56 INFO - Downloaded 14413740 bytes. 10:10:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:10:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:10:56 INFO - Return code: 0 10:10:56 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')]} 10:10:56 INFO - https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:10:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:10:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:10:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:10:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:10:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:10:56 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:10:56 INFO - retry: Failed, sleeping 30 seconds before retrying 10:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 10:11:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:11:26 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:11:26 INFO - retry: Failed, sleeping 60 seconds before retrying 10:12:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 10:12:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:12:26 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:12:26 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 10:12:26 INFO - Caught exception: HTTP Error 404: Not Found 10:12:26 INFO - Caught exception: HTTP Error 404: Not Found 10:12:26 INFO - Caught exception: HTTP Error 404: Not Found 10:12:26 INFO - trying https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:12:26 INFO - Downloading https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:12:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:12:27 INFO - Downloaded 56799560 bytes. 10:12:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:12:27 INFO - mkdir: /builds/slave/test/properties 10:12:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:12:27 INFO - Writing to file /builds/slave/test/properties/build_url 10:12:27 INFO - Contents: 10:12:27 INFO - build_url:https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 10:12:28 INFO - Running post-action listener: _resource_record_post_action 10:12:28 INFO - Running post-action listener: set_extra_try_arguments 10:12:28 INFO - [mozharness: 2016-09-23 17:12:28.673511Z] Finished download-and-extract step (success) 10:12:28 INFO - [mozharness: 2016-09-23 17:12:28.673742Z] Running populate-webroot step. 10:12:28 INFO - Running pre-action listener: _resource_record_pre_action 10:12:28 INFO - Running main action method: populate_webroot 10:12:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:12:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:12:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:12:28 INFO - '--tppagecycles', 10:12:28 INFO - '7'], 10:12:28 INFO - 'tests': ['tsvgm']}}, 10:12:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:12:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:12:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:12:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:12:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:12:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:12:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:28 INFO - 'talos_options': ['--disable-e10s'], 10:12:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:28 INFO - 'talos_options': ['--disable-e10s'], 10:12:28 INFO - 'tests': ['damp', 'tps']}, 10:12:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:28 INFO - 'tests': ['damp', 'tps']}, 10:12:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:12:28 INFO - 'tests': ['dromaeo_dom']}, 10:12:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:12:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:12:28 INFO - 'tests': ['basic_compositor_video']}, 10:12:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:12:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:12:28 INFO - 'tests': ['a11yr', 10:12:28 INFO - 'ts_paint', 10:12:28 INFO - 'tpaint', 10:12:28 INFO - 'sessionrestore', 10:12:28 INFO - 'sessionrestore_no_auto_restore', 10:12:28 INFO - 'tabpaint']}, 10:12:28 INFO - 'other-e10s': {'tests': ['a11yr', 10:12:28 INFO - 'ts_paint', 10:12:28 INFO - 'tpaint', 10:12:28 INFO - 'sessionrestore', 10:12:28 INFO - 'sessionrestore_no_auto_restore', 10:12:28 INFO - 'tabpaint']}, 10:12:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:12:28 INFO - 'ts_paint', 10:12:28 INFO - 'tpaint', 10:12:28 INFO - 'sessionrestore', 10:12:28 INFO - 'sessionrestore_no_auto_restore', 10:12:28 INFO - 'tabpaint']}, 10:12:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:12:28 INFO - 'ts_paint', 10:12:28 INFO - 'tpaint', 10:12:28 INFO - 'sessionrestore', 10:12:28 INFO - 'sessionrestore_no_auto_restore', 10:12:28 INFO - 'tabpaint']}, 10:12:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:12:28 INFO - 'tests': ['a11yr', 10:12:28 INFO - 'ts_paint', 10:12:28 INFO - 'tpaint', 10:12:28 INFO - 'sessionrestore', 10:12:28 INFO - 'sessionrestore_no_auto_restore', 10:12:28 INFO - 'tabpaint']}, 10:12:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:12:28 INFO - 'tests': ['a11yr', 10:12:28 INFO - 'ts_paint', 10:12:28 INFO - 'tpaint', 10:12:28 INFO - 'sessionrestore', 10:12:28 INFO - 'sessionrestore_no_auto_restore', 10:12:28 INFO - 'tabpaint']}, 10:12:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:12:28 INFO - 'tests': ['tsvgx', 10:12:28 INFO - 'tsvgr_opacity', 10:12:28 INFO - 'tart', 10:12:28 INFO - 'tscrollx', 10:12:28 INFO - 'cart']}, 10:12:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:12:28 INFO - 'tsvgr_opacity', 10:12:28 INFO - 'tart', 10:12:28 INFO - 'tscrollx', 10:12:28 INFO - 'cart']}, 10:12:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:28 INFO - 'talos_options': ['--disable-e10s'], 10:12:28 INFO - 'tests': ['tp5o']}, 10:12:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:28 INFO - 'tests': ['tp5o']}, 10:12:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:28 INFO - 'talos_options': ['--disable-e10s', 10:12:28 INFO - '--xperf_path', 10:12:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:28 INFO - 'tests': ['tp5n']}, 10:12:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:28 INFO - 'talos_options': ['--xperf_path', 10:12:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:28 INFO - 'tests': ['tp5n']}}, 10:12:28 INFO - 'talos.zip': {'path': '', 10:12:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:12:28 INFO - Running post-action listener: _resource_record_post_action 10:12:28 INFO - [mozharness: 2016-09-23 17:12:28.692904Z] Finished populate-webroot step (success) 10:12:28 INFO - [mozharness: 2016-09-23 17:12:28.692993Z] Running create-virtualenv step. 10:12:28 INFO - Running pre-action listener: _resource_record_pre_action 10:12:28 INFO - Running main action method: create_virtualenv 10:12:28 INFO - Creating virtualenv /builds/slave/test/build/venv 10:12:28 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 10:12:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:12:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:12:28 INFO - Using real prefix '/usr' 10:12:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:12:29 INFO - Installing distribute.............................................................................................................................................................................................done. 10:12:31 INFO - Installing pip.................done. 10:12:31 INFO - Return code: 0 10:12:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063570>, '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 0x2064470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2064900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', '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 10:12:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:12:31 INFO - Using env: {'DISPLAY': ':0', 10:12:31 INFO - 'HOME': '/home/cltbld', 10:12:31 INFO - 'LANG': 'en_US.UTF-8', 10:12:31 INFO - 'LANGUAGE': 'en_US:en', 10:12:31 INFO - 'LOGNAME': 'cltbld', 10:12:31 INFO - 'MAIL': '/var/mail/cltbld', 10:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:31 INFO - 'MOZ_NO_REMOTE': '1', 10:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:31 INFO - 'NO_EM_RESTART': '1', 10:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:31 INFO - 'PWD': '/builds/slave/test', 10:12:31 INFO - 'SHELL': '/bin/bash', 10:12:31 INFO - 'SHLVL': '1', 10:12:31 INFO - 'TERM': 'linux', 10:12:31 INFO - 'TMOUT': '86400', 10:12:31 INFO - 'USER': 'cltbld', 10:12:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', 10:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:31 INFO - '_': '/tools/buildbot/bin/python'} 10:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:31 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 10:12:31 INFO - Cleaning up... 10:12:31 INFO - Return code: 0 10:12:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1da5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063570>, '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 0x2064470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2064900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', '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 10:12:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:12:31 INFO - Using env: {'DISPLAY': ':0', 10:12:31 INFO - 'HOME': '/home/cltbld', 10:12:31 INFO - 'LANG': 'en_US.UTF-8', 10:12:31 INFO - 'LANGUAGE': 'en_US:en', 10:12:31 INFO - 'LOGNAME': 'cltbld', 10:12:31 INFO - 'MAIL': '/var/mail/cltbld', 10:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:31 INFO - 'MOZ_NO_REMOTE': '1', 10:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:31 INFO - 'NO_EM_RESTART': '1', 10:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:31 INFO - 'PWD': '/builds/slave/test', 10:12:31 INFO - 'SHELL': '/bin/bash', 10:12:31 INFO - 'SHLVL': '1', 10:12:31 INFO - 'TERM': 'linux', 10:12:31 INFO - 'TMOUT': '86400', 10:12:31 INFO - 'USER': 'cltbld', 10:12:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', 10:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:31 INFO - '_': '/tools/buildbot/bin/python'} 10:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:31 INFO - Downloading/unpacking psutil>=3.1.1 10:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:12:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:33 INFO - Installing collected packages: psutil 10:12:33 INFO - Running setup.py install for psutil 10:12:33 INFO - building 'psutil._psutil_linux' extension 10:12:33 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 10:12:33 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 10:12:33 INFO - building 'psutil._psutil_posix' extension 10:12:33 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 10:12:34 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 10:12:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:34 INFO - Successfully installed psutil 10:12:34 INFO - Cleaning up... 10:12:34 INFO - Return code: 0 10:12:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063570>, '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 0x2064470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2064900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', '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 10:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:12:34 INFO - Using env: {'DISPLAY': ':0', 10:12:34 INFO - 'HOME': '/home/cltbld', 10:12:34 INFO - 'LANG': 'en_US.UTF-8', 10:12:34 INFO - 'LANGUAGE': 'en_US:en', 10:12:34 INFO - 'LOGNAME': 'cltbld', 10:12:34 INFO - 'MAIL': '/var/mail/cltbld', 10:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:34 INFO - 'MOZ_NO_REMOTE': '1', 10:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:34 INFO - 'NO_EM_RESTART': '1', 10:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:34 INFO - 'PWD': '/builds/slave/test', 10:12:34 INFO - 'SHELL': '/bin/bash', 10:12:34 INFO - 'SHLVL': '1', 10:12:34 INFO - 'TERM': 'linux', 10:12:34 INFO - 'TMOUT': '86400', 10:12:34 INFO - 'USER': 'cltbld', 10:12:34 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', 10:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:34 INFO - '_': '/tools/buildbot/bin/python'} 10:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:12:36 INFO - Installing collected packages: mozsystemmonitor 10:12:36 INFO - Running setup.py install for mozsystemmonitor 10:12:36 INFO - Successfully installed mozsystemmonitor 10:12:36 INFO - Cleaning up... 10:12:36 INFO - Return code: 0 10:12:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063570>, '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 0x2064470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2064900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', '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 10:12:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:12:36 INFO - Using env: {'DISPLAY': ':0', 10:12:36 INFO - 'HOME': '/home/cltbld', 10:12:36 INFO - 'LANG': 'en_US.UTF-8', 10:12:36 INFO - 'LANGUAGE': 'en_US:en', 10:12:36 INFO - 'LOGNAME': 'cltbld', 10:12:36 INFO - 'MAIL': '/var/mail/cltbld', 10:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:36 INFO - 'MOZ_NO_REMOTE': '1', 10:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:36 INFO - 'NO_EM_RESTART': '1', 10:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:36 INFO - 'PWD': '/builds/slave/test', 10:12:36 INFO - 'SHELL': '/bin/bash', 10:12:36 INFO - 'SHLVL': '1', 10:12:36 INFO - 'TERM': 'linux', 10:12:36 INFO - 'TMOUT': '86400', 10:12:36 INFO - 'USER': 'cltbld', 10:12:36 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', 10:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:36 INFO - '_': '/tools/buildbot/bin/python'} 10:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:36 INFO - Downloading/unpacking jsonschema==2.5.1 10:12:36 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 10:12:36 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 10:12:36 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 10:12:36 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 10:12:36 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 10:12:36 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 10:12:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:12:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:12:38 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 10:12:38 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 10:12:38 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 10:12:38 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 10:12:38 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 10:12:38 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 10:12:38 INFO - Downloading functools32-3.2.3-2.tar.gz 10:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:12:38 INFO - warning: no files found matching '*.txt' 10:12:38 INFO - no previously-included directories found matching 'build' 10:12:38 INFO - no previously-included directories found matching 'dist' 10:12:38 INFO - no previously-included directories found matching '.git*' 10:12:38 INFO - Installing collected packages: jsonschema, functools32 10:12:38 INFO - Running setup.py install for functools32 10:12:39 INFO - warning: no files found matching '*.txt' 10:12:39 INFO - no previously-included directories found matching 'build' 10:12:39 INFO - no previously-included directories found matching 'dist' 10:12:39 INFO - no previously-included directories found matching '.git*' 10:12:39 INFO - Successfully installed jsonschema functools32 10:12:39 INFO - Cleaning up... 10:12:39 INFO - Return code: 0 10:12:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1da5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063570>, '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 0x2064470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2064900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', '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 10:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:12:39 INFO - Using env: {'DISPLAY': ':0', 10:12:39 INFO - 'HOME': '/home/cltbld', 10:12:39 INFO - 'LANG': 'en_US.UTF-8', 10:12:39 INFO - 'LANGUAGE': 'en_US:en', 10:12:39 INFO - 'LOGNAME': 'cltbld', 10:12:39 INFO - 'MAIL': '/var/mail/cltbld', 10:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:39 INFO - 'MOZ_NO_REMOTE': '1', 10:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:39 INFO - 'NO_EM_RESTART': '1', 10:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:39 INFO - 'PWD': '/builds/slave/test', 10:12:39 INFO - 'SHELL': '/bin/bash', 10:12:39 INFO - 'SHLVL': '1', 10:12:39 INFO - 'TERM': 'linux', 10:12:39 INFO - 'TMOUT': '86400', 10:12:39 INFO - 'USER': 'cltbld', 10:12:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', 10:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:39 INFO - '_': '/tools/buildbot/bin/python'} 10:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:12:39 INFO - Cleaning up... 10:12:39 INFO - Return code: 0 10:12:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1da5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063570>, '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 0x2064470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2064900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', '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 10:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:12:39 INFO - Using env: {'DISPLAY': ':0', 10:12:39 INFO - 'HOME': '/home/cltbld', 10:12:39 INFO - 'LANG': 'en_US.UTF-8', 10:12:39 INFO - 'LANGUAGE': 'en_US:en', 10:12:39 INFO - 'LOGNAME': 'cltbld', 10:12:39 INFO - 'MAIL': '/var/mail/cltbld', 10:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:39 INFO - 'MOZ_NO_REMOTE': '1', 10:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:39 INFO - 'NO_EM_RESTART': '1', 10:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:39 INFO - 'PWD': '/builds/slave/test', 10:12:39 INFO - 'SHELL': '/bin/bash', 10:12:39 INFO - 'SHLVL': '1', 10:12:39 INFO - 'TERM': 'linux', 10:12:39 INFO - 'TMOUT': '86400', 10:12:39 INFO - 'USER': 'cltbld', 10:12:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', 10:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:39 INFO - '_': '/tools/buildbot/bin/python'} 10:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:39 INFO - Downloading/unpacking blobuploader==1.2.4 10:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:41 INFO - Downloading blobuploader-1.2.4.tar.gz 10:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:12:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:12:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:42 INFO - Downloading docopt-0.6.1.tar.gz 10:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:12:42 INFO - Installing collected packages: blobuploader, requests, docopt 10:12:42 INFO - Running setup.py install for blobuploader 10:12:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:12:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:12:42 INFO - Running setup.py install for requests 10:12:42 INFO - Running setup.py install for docopt 10:12:42 INFO - Successfully installed blobuploader requests docopt 10:12:42 INFO - Cleaning up... 10:12:42 INFO - Return code: 0 10:12:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:42 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 0x1da5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063570>, '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 0x2064470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2064900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', '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 10:12:42 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 10:12:42 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 10:12:42 INFO - Using env: {'DISPLAY': ':0', 10:12:42 INFO - 'HOME': '/home/cltbld', 10:12:42 INFO - 'LANG': 'en_US.UTF-8', 10:12:42 INFO - 'LANGUAGE': 'en_US:en', 10:12:42 INFO - 'LOGNAME': 'cltbld', 10:12:42 INFO - 'MAIL': '/var/mail/cltbld', 10:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:42 INFO - 'MOZ_NO_REMOTE': '1', 10:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:42 INFO - 'NO_EM_RESTART': '1', 10:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:42 INFO - 'PWD': '/builds/slave/test', 10:12:42 INFO - 'SHELL': '/bin/bash', 10:12:42 INFO - 'SHLVL': '1', 10:12:42 INFO - 'TERM': 'linux', 10:12:42 INFO - 'TMOUT': '86400', 10:12:42 INFO - 'USER': 'cltbld', 10:12:42 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', 10:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:42 INFO - '_': '/tools/buildbot/bin/python'} 10:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:43 INFO - Running setup.py (path:/tmp/pip-NdBlyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:43 INFO - Running setup.py (path:/tmp/pip-uYw2rE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:43 INFO - Running setup.py (path:/tmp/pip-whKDFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:43 INFO - Running setup.py (path:/tmp/pip-gJwmjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:43 INFO - Running setup.py (path:/tmp/pip-3UIjwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:43 INFO - Running setup.py (path:/tmp/pip-GiXaZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:43 INFO - Running setup.py (path:/tmp/pip-kkOjZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:43 INFO - Running setup.py (path:/tmp/pip-ljcOQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:43 INFO - Running setup.py (path:/tmp/pip-3ENy1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:43 INFO - Running setup.py (path:/tmp/pip-U07o6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:43 INFO - Running setup.py (path:/tmp/pip-SvFNDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:43 INFO - Running setup.py (path:/tmp/pip-ej9_qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:43 INFO - Running setup.py (path:/tmp/pip-04o08I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:43 INFO - Running setup.py (path:/tmp/pip-VYqB1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:44 INFO - Running setup.py (path:/tmp/pip-plWUoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:44 INFO - Running setup.py (path:/tmp/pip-hnpYgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:44 INFO - Running setup.py (path:/tmp/pip-yi09mR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:12:44 INFO - Running setup.py install for manifestparser 10:12:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Running setup.py install for mozcrash 10:12:44 INFO - Running setup.py install for mozdebug 10:12:44 INFO - Running setup.py install for mozdevice 10:12:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Running setup.py install for mozfile 10:12:44 INFO - Running setup.py install for mozhttpd 10:12:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Running setup.py install for mozinfo 10:12:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Running setup.py install for mozInstall 10:12:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Running setup.py install for mozleak 10:12:45 INFO - Running setup.py install for mozlog 10:12:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Running setup.py install for moznetwork 10:12:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Running setup.py install for mozprocess 10:12:45 INFO - Running setup.py install for mozprofile 10:12:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Running setup.py install for mozrunner 10:12:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Running setup.py install for mozscreenshot 10:12:45 INFO - Running setup.py install for moztest 10:12:45 INFO - Running setup.py install for mozversion 10:12:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:12:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:12:46 INFO - Cleaning up... 10:12:46 INFO - Return code: 0 10:12:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:46 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 0x1da5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063570>, '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 0x2064470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2064900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', '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 10:12:46 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 10:12:46 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 10:12:46 INFO - Using env: {'DISPLAY': ':0', 10:12:46 INFO - 'HOME': '/home/cltbld', 10:12:46 INFO - 'LANG': 'en_US.UTF-8', 10:12:46 INFO - 'LANGUAGE': 'en_US:en', 10:12:46 INFO - 'LOGNAME': 'cltbld', 10:12:46 INFO - 'MAIL': '/var/mail/cltbld', 10:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:46 INFO - 'MOZ_NO_REMOTE': '1', 10:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:46 INFO - 'NO_EM_RESTART': '1', 10:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:46 INFO - 'PWD': '/builds/slave/test', 10:12:46 INFO - 'SHELL': '/bin/bash', 10:12:46 INFO - 'SHLVL': '1', 10:12:46 INFO - 'TERM': 'linux', 10:12:46 INFO - 'TMOUT': '86400', 10:12:46 INFO - 'USER': 'cltbld', 10:12:46 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', 10:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:46 INFO - '_': '/tools/buildbot/bin/python'} 10:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:46 INFO - Running setup.py (path:/tmp/pip-UrdYfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:46 INFO - Running setup.py (path:/tmp/pip-VbPAAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:46 INFO - Running setup.py (path:/tmp/pip-68EaQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:46 INFO - Running setup.py (path:/tmp/pip-HM5joa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:46 INFO - Running setup.py (path:/tmp/pip-vLkSc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:46 INFO - Running setup.py (path:/tmp/pip-Rey3Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:46 INFO - Running setup.py (path:/tmp/pip-L5JBkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:46 INFO - Running setup.py (path:/tmp/pip-fJTaAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:46 INFO - Running setup.py (path:/tmp/pip-dLgcIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:46 INFO - Running setup.py (path:/tmp/pip-qNVONh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:46 INFO - Running setup.py (path:/tmp/pip-aW0giu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:47 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)) 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:47 INFO - Running setup.py (path:/tmp/pip-MHgnf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:47 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)) 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:47 INFO - Running setup.py (path:/tmp/pip-hZqsiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:47 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)) 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:47 INFO - Running setup.py (path:/tmp/pip-YNNryW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:47 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)) 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:47 INFO - Running setup.py (path:/tmp/pip-2u1FIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:47 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)) 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:47 INFO - Running setup.py (path:/tmp/pip-9tvEg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:47 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)) 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:47 INFO - Running setup.py (path:/tmp/pip-fixxoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:47 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)) 10:12:47 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)) 10:12:47 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)) 10:12:47 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)) 10:12:47 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)) 10:12:47 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)) 10:12:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:12:47 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 10:12:47 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 10:12:47 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 10:12:47 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 10:12:47 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 10:12:47 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 10:12:49 INFO - Downloading blessings-1.6.tar.gz 10:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:12:49 INFO - Installing collected packages: blessings 10:12:49 INFO - Running setup.py install for blessings 10:12:49 INFO - Successfully installed blessings 10:12:49 INFO - Cleaning up... 10:12:49 INFO - Return code: 0 10:12:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:12:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:49 INFO - Reading from file tmpfile_stdout 10:12:49 INFO - Current package versions: 10:12:49 INFO - argparse == 1.2.1 10:12:49 INFO - blessings == 1.6 10:12:49 INFO - blobuploader == 1.2.4 10:12:49 INFO - docopt == 0.6.1 10:12:49 INFO - functools32 == 3.2.3-2 10:12:49 INFO - jsonschema == 2.5.1 10:12:49 INFO - manifestparser == 1.1 10:12:49 INFO - mozInstall == 1.12 10:12:49 INFO - mozcrash == 0.17 10:12:49 INFO - mozdebug == 0.1 10:12:49 INFO - mozdevice == 0.48 10:12:49 INFO - mozfile == 1.2 10:12:49 INFO - mozhttpd == 0.7 10:12:49 INFO - mozinfo == 0.9 10:12:49 INFO - mozleak == 0.1 10:12:49 INFO - mozlog == 3.3 10:12:49 INFO - moznetwork == 0.27 10:12:49 INFO - mozprocess == 0.23 10:12:49 INFO - mozprofile == 0.28 10:12:49 INFO - mozrunner == 6.12 10:12:49 INFO - mozscreenshot == 0.1 10:12:49 INFO - mozsystemmonitor == 0.3 10:12:49 INFO - moztest == 0.7 10:12:49 INFO - mozversion == 1.4 10:12:49 INFO - psutil == 3.1.1 10:12:49 INFO - requests == 1.2.3 10:12:49 INFO - wsgiref == 0.1.2 10:12:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:49 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')]} 10:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:49 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')]} 10:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:49 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 0x1da5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063570>, '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 0x2064470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2064900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', '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 10:12:49 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 10:12:49 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 10:12:49 INFO - Using env: {'DISPLAY': ':0', 10:12:49 INFO - 'HOME': '/home/cltbld', 10:12:49 INFO - 'LANG': 'en_US.UTF-8', 10:12:49 INFO - 'LANGUAGE': 'en_US:en', 10:12:49 INFO - 'LOGNAME': 'cltbld', 10:12:49 INFO - 'MAIL': '/var/mail/cltbld', 10:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:49 INFO - 'MOZ_NO_REMOTE': '1', 10:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:49 INFO - 'NO_EM_RESTART': '1', 10:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:49 INFO - 'PWD': '/builds/slave/test', 10:12:49 INFO - 'SHELL': '/bin/bash', 10:12:49 INFO - 'SHLVL': '1', 10:12:49 INFO - 'TERM': 'linux', 10:12:49 INFO - 'TMOUT': '86400', 10:12:49 INFO - 'USER': 'cltbld', 10:12:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', 10:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:49 INFO - '_': '/tools/buildbot/bin/python'} 10:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:50 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)) 10:12:50 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)) 10:12:50 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)) 10:12:50 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)) 10:12:50 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)) 10:12:50 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)) 10:12:50 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)) 10:12:50 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)) 10:12:50 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)) 10:12:50 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)) 10:12:50 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)) 10:12:50 INFO - Cleaning up... 10:12:50 INFO - Return code: 0 10:12:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:12:50 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')]} 10:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:50 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')]} 10:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:50 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 0x1da5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063570>, '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 0x2064470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2064900>, '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': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', '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 10:12:50 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 10:12:50 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 10:12:50 INFO - Using env: {'DISPLAY': ':0', 10:12:50 INFO - 'HOME': '/home/cltbld', 10:12:50 INFO - 'LANG': 'en_US.UTF-8', 10:12:50 INFO - 'LANGUAGE': 'en_US:en', 10:12:50 INFO - 'LOGNAME': 'cltbld', 10:12:50 INFO - 'MAIL': '/var/mail/cltbld', 10:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:50 INFO - 'MOZ_NO_REMOTE': '1', 10:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:50 INFO - 'NO_EM_RESTART': '1', 10:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:50 INFO - 'PWD': '/builds/slave/test', 10:12:50 INFO - 'SHELL': '/bin/bash', 10:12:50 INFO - 'SHLVL': '1', 10:12:50 INFO - 'TERM': 'linux', 10:12:50 INFO - 'TMOUT': '86400', 10:12:50 INFO - 'USER': 'cltbld', 10:12:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', 10:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:50 INFO - '_': '/tools/buildbot/bin/python'} 10:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:12:50 INFO - Cleaning up... 10:12:50 INFO - Return code: 0 10:12:50 INFO - Running post-action listener: _resource_record_post_action 10:12:50 INFO - Running post-action listener: _start_resource_monitoring 10:12:50 INFO - Starting resource monitoring. 10:12:50 INFO - [mozharness: 2016-09-23 17:12:50.320964Z] Finished create-virtualenv step (success) 10:12:50 INFO - [mozharness: 2016-09-23 17:12:50.321392Z] Running install step. 10:12:50 INFO - Running pre-action listener: _resource_record_pre_action 10:12:50 INFO - Running main action method: install 10:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:50 INFO - Reading from file tmpfile_stdout 10:12:50 INFO - Detecting whether we're running mozinstall >=1.0... 10:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:12:50 INFO - Reading from file tmpfile_stdout 10:12:50 INFO - Output received: 10:12:50 INFO - Usage: mozinstall [options] installer 10:12:50 INFO - Options: 10:12:50 INFO - -h, --help show this help message and exit 10:12:50 INFO - -d DEST, --destination=DEST 10:12:50 INFO - Directory to install application into. [default: 10:12:50 INFO - "/builds/slave/test"] 10:12:50 INFO - --app=APP Application being installed. [default: firefox] 10:12:50 INFO - mkdir: /builds/slave/test/build/application 10:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:13:04 INFO - Reading from file tmpfile_stdout 10:13:04 INFO - Output received: 10:13:04 INFO - /builds/slave/test/build/application/firefox/firefox 10:13:04 INFO - Running post-action listener: _resource_record_post_action 10:13:04 INFO - [mozharness: 2016-09-23 17:13:04.849480Z] Finished install step (success) 10:13:04 INFO - [mozharness: 2016-09-23 17:13:04.849761Z] Running run-tests step. 10:13:04 INFO - Running pre-action listener: _resource_record_pre_action 10:13:04 INFO - Running main action method: run_tests 10:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:13:04 INFO - Python 2.7.3 10:13:04 INFO - Return code: 0 10:13:04 INFO - grabbing minidump binary from tooltool 10:13:04 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')]} 10:13:04 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 0x2063570>, '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 0x2064470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2064900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:13:04 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 10:13:04 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 10:13:04 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 10:13:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:13:04 INFO - Return code: 0 10:13:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:13:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:13:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:13:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:13:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 10:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 10:13:04 INFO - Using env: {'DISPLAY': ':0', 10:13:04 INFO - 'HOME': '/home/cltbld', 10:13:04 INFO - 'LANG': 'en_US.UTF-8', 10:13:04 INFO - 'LANGUAGE': 'en_US:en', 10:13:04 INFO - 'LOGNAME': 'cltbld', 10:13:04 INFO - 'MAIL': '/var/mail/cltbld', 10:13:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:13:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:04 INFO - 'MOZ_NO_REMOTE': '1', 10:13:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:04 INFO - 'NO_EM_RESTART': '1', 10:13:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:04 INFO - 'PWD': '/builds/slave/test', 10:13:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:13:04 INFO - 'SHELL': '/bin/bash', 10:13:04 INFO - 'SHLVL': '1', 10:13:04 INFO - 'TERM': 'linux', 10:13:04 INFO - 'TMOUT': '86400', 10:13:04 INFO - 'USER': 'cltbld', 10:13:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502', 10:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:04 INFO - '_': '/tools/buildbot/bin/python'} 10:13:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 10:13:05 INFO - mozversion application_buildid: 20160923070600 10:13:05 INFO - mozversion application_changeset: bc1c04505a77efd394e1c0e633dd6ecd447ce522 10:13:05 INFO - mozversion application_display_name: Firefox 10:13:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:13:05 INFO - mozversion application_name: Firefox 10:13:05 INFO - mozversion application_remotingname: firefox 10:13:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:13:05 INFO - mozversion application_vendor: Mozilla 10:13:05 INFO - mozversion application_version: 50.0 10:13:05 INFO - mozversion platform_buildid: 20160923070600 10:13:05 INFO - mozversion platform_changeset: bc1c04505a77efd394e1c0e633dd6ecd447ce522 10:13:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:13:05 INFO - mozversion platform_version: 50.0 10:13:05 INFO - using testdate: 1474650785 10:13:05 INFO - actual date: 1474650785 10:13:05 INFO - starting webserver on 'localhost:51588' 10:13:05 INFO - SUITE-START | Running 2 tests 10:13:05 INFO - TEST-START | dromaeo_css 10:13:05 INFO - operating with platform_type : linux_ 10:13:05 INFO - Initialising browser for dromaeo_css test... 10:13:05 INFO - TEST-INFO | started process 14003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQBOXUk/profile http://localhost:51588/getInfo.html) 10:13:09 INFO - PROCESS | 14003 | __metrics Screen width/height:1600/1200 10:13:09 INFO - PROCESS | 14003 | colorDepth:24 10:13:09 INFO - PROCESS | 14003 | Browser inner width/height: 1024/697 10:13:09 INFO - PROCESS | 14003 | __metrics 10:13:10 ERROR - PROCESS | 14003 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:13:11 INFO - TEST-INFO | 14003: exit 0 10:13:11 INFO - Browser initialized. 10:13:11 INFO - Running cycle 1/1 for dromaeo_css test... 10:13:11 INFO - TEST-INFO | started process 14126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQBOXUk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:23 INFO - PROCESS | 14126 | RSS: Main: 150196224 10:13:23 INFO - PROCESS | 14126 | 10:14:12 INFO - PROCESS | 14126 | 1474650852930 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] 10:16:21 INFO - PROCESS | 14126 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51588/tests/dromaeo/cssquery-ext.html) 10:16:22 INFO - PROCESS | 14126 | RSS: Main: 158871552 10:16:22 INFO - PROCESS | 14126 | 10:19:24 INFO - PROCESS | 14126 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-ext.html (next: http://localhost:51588/tests/dromaeo/cssquery-jquery.html) 10:19:24 INFO - PROCESS | 14126 | RSS: Main: 155398144 10:19:24 INFO - PROCESS | 14126 | 10:22:26 INFO - PROCESS | 14126 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51588/tests/dromaeo/cssquery-mootools.html) 10:22:27 INFO - PROCESS | 14126 | RSS: Main: 154877952 10:22:27 INFO - PROCESS | 14126 | 10:25:29 INFO - PROCESS | 14126 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51588/tests/dromaeo/cssquery-prototype.html) 10:25:29 INFO - PROCESS | 14126 | RSS: Main: 156717056 10:25:29 INFO - PROCESS | 14126 | 10:28:32 INFO - PROCESS | 14126 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51588/tests/dromaeo/cssquery-yui.html) 10:28:32 INFO - PROCESS | 14126 | RSS: Main: 157528064 10:28:32 INFO - PROCESS | 14126 | 10:31:35 INFO - PROCESS | 14126 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-yui.html (next: http://localhost:51588/tests/dromaeo/cssquery-dojo.html) 10:31:35 INFO - PROCESS | 14126 | RSS: Main: 156561408 10:31:35 INFO - PROCESS | 14126 | 10:31:35 INFO - PROCESS | 14126 | __start_tp_report 10:31:35 INFO - PROCESS | 14126 | _x_x_mozilla_page_load 10:31:35 INFO - PROCESS | 14126 | _x_x_mozilla_page_load_details 10:31:35 INFO - PROCESS | 14126 | |i|pagename|runs| 10:31:35 INFO - PROCESS | 14126 | |0;dojo.html;3279.2457734721015;3305.785123966942;3307.603087629485;3319.1038419626716;3321.76747627666;5677.943220567799;5712.628679135853;5743.396943320954;5745.712714364276;5761.107028410598;5693.202951586771;5721.399253078429;5727.742251598677;5730.05454100074;5733.913991290134;5188.0920838853235;5217.087009773274;5234.450382709818;5257.658252213613;5268.789248430058;5121.027004869082;5125.103106956286;5135.717535535544;5162.870928226786;5179.249008893708;5259.132243179871;5271.235670827747;5291.656042357254;5292.603054770908;5297.655652382602;5269.130593452076;5273.630845840793;5274.947250527484;5277.076511610453;5289.312389389354;4951.653384263103;4986.5761410280165;5178.896422071575;5187.662801917863;5242.895142097175;5494.395616482184;5591.8042868499815;5606.467385598362;5650.463205995424;5663.122216056518;6033.728482218311;6072.028475443952;6082.087686846964;6085.026395776655;6087.573869829113;5950.702464876739;6122.54080943931;6128.662923539204;6131.172291740602;6138;5602.663840169603;5615.747291371898;5616.5787565932305;5686.516646085046;5725.255716756837;6200.162977997912;6214.782482613087;6217.222847144107;6224.657643829632;6229.034499652561;5824.330202026821;5892.499137573269;5978.432048955342;5985.521158307325;5992.760289588455;5960.761569537257;5976.7908123215475;5998.790042348497;6056.788012419633;6100.542459315569;5984.760609575568;6026;6036.094585812076;6036.849078772978;6037.154798328237;5846.853828654318;6036.154938308552;6038.033914573647;6039.667818270037;6053.788117415869;4574.108048930427;4586.380838586815;4605.309203619417;4627.097715945426;4656.092062047868;4113.074558224375;4132.876013719593;4134.255833949918;4151.356539736285;4156.4388807510595;5601.80393686219;5776.5089967352405;5782.132680098019;5783.681897495678;5787.450192231731;6022.247219097613;6037.305709843425;6073.089036644538;6113.111460343324;6131.0708424985305;5746.511546518509;5799.014167591519;5808.3901190375245;5815.621984570989;5837.883242335214;4879.26810978349;5002.449730529639;5049.368828896388;5060.443351231362;5069.112905241568;6170.598911070766;6217;6219.502439804804;6343;6349.206349206349;6108.938910611015;6110.480609148272;6114;6124.234470691164;6137.877242455215;6097.298810636834;6167.753289868355;6315.115883776367;6337.2395312562785;6339.429451349401;5923.763049477972;5963.165156877953;6016.368281330398;6030.7286172121485;6035.305939816977;6106.969465152646;6124.14262003311;6126.356732543019;6128.295246046583;6145.078238264117;5792.710364481674;5873.882522349614;5875.471207591338;5922.082077278029;5960.731767070579;5887.911681324869;5990.31111422192;5994.220751302303;5999.610025348338;6003.099535069775;5879.147523609138;5889.411058894077;5904.468597826216;5909.349971503218;5924.496417804535;5783.681897495678;5856.063029915364;5947.256592925884;5954.07711804671;5979.4917432018765;5756.165356023437;5817.360090390139;5834.883302334015;5858.2677165354335;5870.354261031369 10:31:35 INFO - PROCESS | 14126 | |1;ext.html;581.2908251932644;632.0866348126956;660.3792435110994;679.320679320679;720.2005773591316;41031.17937641249;45551.77224113879;45715.542844571544;45777.7711111444;45849.541504584944;46833.531664683425;47116.76441617795;47385.52614473854;47427.76286118573;47468;9023.368364214492;9151.084891510862;9165.175134237918;9168.908310916871;9175.862362064574;8979.685711000116;9036.77408064797;9091.954540227289;9161.083891610819;9179.357444978821;9176.357654964155;9185.173334399902;9232.215261702764;9245.630174793001;9251.444913305224;9023.774405639846;9036.096390360977;9044.14080662336;9044.864327035068;9103.590338434786;9072.909270907272;9128.406653567497;9221.81556368869;9243.168114869693;9267.397619154734;43551.34672979908;43951.78024109891;44084.779576101915;44132;44139.77930110361;3721.832517536717;3757.530308711411;3843.4811300474357;3990.2817492851277;4217.852375166885;35748.28503429943;35800.462993055124;35894;36138.91583252507;37754.62245377539;4775.14047471455;4782.23484242523;4790.281457781326;4820.39745031871;4833.927491087637;401119;405548;405652;405829;407218.96390518156;38101.809490952364;63226;63662;63699.68150159312;63701.36298637047;38464.230715385536;40417.59582404197;40657.79671101626;40747.18505629871;40769.38845917313;17127.314907403812;17135.65728685419;17149.65700686004;17233.138343082795;17233.482995510156;14487.855121448862;14525.92737036308;14546;14571.125732456087;14594.854051459562;9204.907950920538;9213.90786092144;9252.953735231415;9311.580978855967;9357.625694972261;3469.8438570264398;3497.370473314828;3541.1501239702284;3545.3795585772386;3611.602723700391;1054;1102.1788767368362;1111.9944400277948;1124.0726400719439;1163.1276542593055;33559.49660755091;34539.654603454146;34673.47989780155;34710;34729.479057814155;1117.742919128605;1126.7802778458286;1138.7039369763756;1155.3241353808116;1224.9632511024683;17364.826351736574;17443.65112697739;17915.641687166182;18126;18223.271069157352;654879;664384;665014;666174;669567;65608.67195663991;65947;66284;66339.66830165914;66343.33656663468;1177.43483128099;1193.2065176657425;1221.2794451273792;1226.5032661771997;1352.0738294268458;32975.67024329726;33658.66341336555;33866.830665846515;33925;34332.485012724326;56314.43685563092;56658.43341566531;56660.43339566552;56712.14931775944;56741;490798;493362;493767;495365;496781;31644.5253321205;31670.683293166774;31706.04881853548;31746.206344841565;32070.35859282848;53073;53198.73400632972;53847.461525385814;53902.73048634732;54324;44009;44732;44918.7540622961;45487.77256113698;46043.539564605264;43604.34593481164;44590;45354;45732.77133614444;46877.76561117172;43517.56482435135;43885.12229755323;44014;44915.55084449114;47243;39290;39940.60059399369;40034.799826000686;40168.7991560052;40368.3944740835;29848.403031939673;29939.850300748356;31718.682813171574;32233.35533289368;32473.350532988734 10:31:35 INFO - PROCESS | 14126 | |2;jquery.html;401.67865707434044;407.32384242158025;426.6032589691587;435.09717336526705;439.30808975863005;19010.144543495542;20454.488637784045;20574.48563785906;21012.159513619437;21360.57278854422;19999.500012499695;20120.49698757532;20194.697079543817;20417.59164816703;20518;5700.173474846145;5976.581639285252;5977.462028417442;5981.162637230791;5987.730552125143;5785.710714464281;5897.911531327012;5916.3787802280785;5924.792632257871;6000.2199714037115;6072.544559158058;6106.603070800406;6111.877762444748;6117.388261173892;6213.440790328869;6516.967415162918;6635;6779.661016949182;6924.792256232321;6925;6102.237220347457;6150.876982460326;6153.230846144232;6157.076438534211;6157.507399408037;14980.400783968627;15115.395384184729;15198.772018419733;20361.77829330245;23994.7600523996;2570.5630042892753;2625.4092829113297;2630.5002049610703;2887.566864970271;2926.956095658567;10442.582296708122;10669.146468282597;10841.13270938331;14786.40854365824;14981.325840337211;1972.5364539333245;1996.3511858645998;2022.6662600670873;2043.1214577731719;2083.666613341873;90130.5493472535;90571;91401.54299228461;91603;94108.52945735295;11795.35125568102;11865.754095819988;11896.167268291136;12117.575884843987;12141.150119491727;16710;16721.581960451087;16766;16779.580510487336;16821.411250606416;8669.306455483546;8707.129287071242;8773.298136149093;8935.955320223356;9044.14080662336;8473.195046470575;8478.194571515696;8515.531645759544;8732.257758090507;8747.737567872973;4672.5327467253;4748.6913350632785;4960.107180707508;5154.407243167008;5156.381234251839;1937.8255956963942;2020.9191632334837;2060.2789023841538;2060.536379314642;2109.440998135495;925.4863550729275;994.8109859126743;1030.1810061001372;1044.3942513342242;1068.278911734576;19547.706784398244;20012.89993550023;20279;20433.591328173352;20552.794472055088;1042.4266653340633;1047.8323468245044;1052.2003277509148;1060.750723579958;1088.4394536813547;10770.838437423445;11644.24312419707;11662.650120496399;11673.474693638807;11681.357525336018;396316;396684;578854;586509;595909;60597.39402606006;74490.62754686191;99681;103257.48371258096;105804;1073;1086.0714089453404;1108.257467496779;1126.7633796902742;1130.37829193943;17355.47933561995;17981.280748769903;18271.36050238235;18281.17734701915;18611.06944652789;38960.80519597384;40513.39229911612;41142.58857411388;41506.79246603748;42186.78906605447;58313.4168658308;58362.416375835695;58757.41242587519;59052.11421828762;60397.396026039176;8780.385373024083;8891.555422228734;8947.239484643878;8976.775580610538;8990.910090899008;13704.862951370358;13714.86285137136;13850.792238116235;14121.929390352983;14161.433542658591;12174.208676436003;12237.632871013884;12306.200096993667;12399.690007749878;12436.751264974831;11766.823497647714;11849.407529623311;11999;12111.091668125102;12427.067969902475;12172.756544868877;12264.632061038183;12364.81452778227;12484.43820028119;12510.812337814757;8802.559872006503;8822.161894620001;8837.690680826141;8984;9043.728688139367;9142.49716265585;11484.655460336204;11760.88239117598;11992;12014.519419223134 10:31:35 INFO - PROCESS | 14126 | |3;mootools.html;1492.626843289177;1497.9850201497989;1537.6155961009747;1562.570293169379;1571.8428157184283;8468.06851246364;8861.291096712264;9039.90960090399;9793.461359625227;9799.608015679372;8910.153535414125;9210.125038121369;9243.075692430753;9272.490013049279;9325.253979681625;2282.6005449046393;2322.5703244899664;2329.324495896188;2332.6384410416413;2332.7783860533223;2327.0808030827898;2348.3776799148154;2382.904683812654;2386.7971222446026;2388.9283321500384;2359.398353419884;2365.727941286757;2374.9168779092647;2375.7743014413604;2396.7363590005084;2336.953260934789;2356.964645530318;2374.5725769361507;2382.154335211001;2389.940251493709;2318.8376813623054;2322.8141748660237;2323.674685544025;2324.9186278480342;2328.2549584133085;9232.399894006869;9260.536973151315;9261.490618016007;9272;9292.90707092934;5222.112240919053;5343.332083489564;5385.272988146628;5385.380681221671;5489.752961116759;3500.5449291592186;3514.3147086318177;3515.244222492151;3552.4493703476;3593.6406359364114;1077.3643550305278;1095.1129585036067;1121.7532142928542;1136.2387200575552;1148.5061423587854;13418.329083545783;13444.462221511129;13520.12119212248;13524.526641567498;13534.796978045337;4523.5024147343765;4745.596624286905;4796.616270698336;4838.491958344393;4876.195427754381;11387.658370248906;11392.088632909348;11407.714807129889;11428.0286175676;11429.485673144729;5471.316085489314;5546.944530554723;5557.749901254453;5569.582281328917;5571.9442805572235;4604;4956;5060.468650791614;5069.771860266297;5138.332016837787;4226.281532139544;4245.448091748053;4279.657627389802;4309.913801723948;4345.739255644671;1309.7642424363705;1329.3154025676783;1332.393760838816;1335.2656039178607;1343.583489118357;1076.364944682641;1081.4484612847348;1083.2904447586843;1097.067492631257;1102.7849569333903;6401.4238718514625;6602.075709400688;6671.933280667228;6714.227863795629;6810.216825065082;469.3358897160548;469.47418890842476;470.7763812189251;472.4708326674147;483.37161689803116;4467.798949047301;4498.977505112519;4725.10223057618;4801.879953001203;4958.925616115761;11944.104192185447;12307;12311.938440307742;12357.25856448598;12408.131430799758;11281.097512199005;11788.997935175435;11808.291502509877;12201.45093470796;12279.570215042431;8951.507667078373;9025.954870225738;9066.184043436122;9139.177474027369;9167.908320916838;6423.710933007932;6676.6995485202315;6745.392914637706;6757.3242675732035;6763.6618169092335;11075.169362298022;11107.666769996913;11166.832497512381;11287.887121128684;11288;11062.115030797679;11210.103191744804;11348.602798901999;11479.311241325548;11615;7653.579053151907;8116.878246826421;8271.54506502124;8329.541875196923;8438.324934005388;9193.218576420812;9220.262379009797;9310.162085412345;9317.6272949084;9318.813623727623;8170.468919520212;8322.625481853453;8372.539510326747;8380.20388063133;8529.616167272363;8051.919480805117;8056.355491560778;8114.269715725377;8131.552764598004;8304.418690691593;7467.589282589292;7510.361619262424;7517.285857843496;7527.510711803715;7589.241075892367;5468.9179662304305;5504.4770746778995;5574.777976896709;5584.553235741212;5689.800856969986;5593.412691667317;5647.576431767716;5662;5701.030824759718;5783.624064435799 10:31:35 INFO - PROCESS | 14126 | |4;prototype.html;327.07274875727313;338.56832538513396;340.75976436612183;352.0494664406103;364.25509832392754;5616.269884914956;5723.9713801430935;5818.487193329738;5956.85107872304;5958.374370691075;5762.703391736857;5801.303843538782;5804.984127777643;5806.912896306549;5822.767089316422;4490.169318676048;4501.932471012921;4507.549245075499;4514.435695538058;4518.1415531049;4429.911401771963;4467.575580319881;4479.216137175998;4481.753503557303;4482.439695038121;4442.933355999663;4446.666500012496;4448.866534003969;4456.821727130911;4494.438195225597;4462.977685111586;4468.910621787562;4487.506374298824;4508.413906192207;4510.8421205257655;3847;3870.9548421925924;3894.1432884765304;3966.6628336591425;3973.8078576427247;5578.804741834057;5581.190727344553;5587.55299576037;5655.604107712462;5679.971600142014;5145.6398052136365;5146.3824341078935;5155.922661160085;5206.427292997805;5206.9846379955925;5928.199693041427;6070.785842831451;6075.787347442818;6084.300305464884;6147.2930612979635;4317.179735850178;4335.869923902256;4342.30523116303;4363.410939523155;4370.978145109254;6226.750929962841;6384.489240860767;6404.167458230447;6414.679266036726;6418.711157997855;4345.9348109778375;4405.757683327448;4407.730019040197;4415.845445409395;4423.977880110579;4497.8425755098415;4512.774361281923;4517.186906356887;4520.118576877478;4522.140793249272;5170.870728231825;5188.870278242998;5203.8178663746585;5208.9739551302;5211.296474975906;5961.241433777046;5989.520838332923;6098.26820781509;6133.754649814046;6152.400375902208;1515.3181068519211;1542.9768553471483;1545.3200591739599;1546.615778877898;1552.74379727346;951.286535098676;962.4995002598749;972.747085757694;987.7036888933292;997.4962643864947;5157.942621762605;5177.747679759317;5211.765470553834;5231.142944254811;5246.317978662826;5472.2065300531995;5512.91730624033;5547.417521160301;5558.749856256478;5568.888622227532;5004.724740139327;5227.320448341691;5230.443298557017;5235.408472805985;5253;2901.6663083745216;2961.6001839751357;2977.196157037631;3001.5947847040807;3031.363413683107;5626.7339848534575;5704.914426283609;5712.2288491054005;5790.623609465371;5827.388124246893;5275.287836142148;5474.39781624021;5551.361593416728;5615.596100974756;5657.632253903483;5608.298962629671;5692.430756924275;5733.8566535836935;5743.396943320891;5787.65274083548;5162.561182299547;5454.263674404064;5528.695921724344;5532.751026203911;5536.947979883809;5405.297311349499;5438.755256013568;5448.264484294569;5481.75332110048;5520.723963801875;5644.435556444323;5655.095184770417;5695.117256825199;5710.400407957105;5715.799947002001;3839.4676897254035;3923.1761330119853;3932.9016774580864;3965.821538030738;3982.5021872265966;5444.782208711607;5536.307961504812;5572.136318870582;6154.78458253959;6312.400321969406;6105.297890742621;6126.908096378469;6176.536759742948;6228.128062071223;6258.687065646791;6033.215681961317;6123.540734445023;6156.78451254204;6176.3514830943905;6187.381261873777;6086.513078953584;6099.8780024398375;6112.510999120149;6114.908276375947;6131.294901086432;6240.126382306572;6240.781572644935;6264.373562643881;6264.68676566179;6284.780032698834;5860;5989.251343582052;6037.45662890342;6045.153678484928;6113.205283313141 10:31:35 INFO - PROCESS | 14126 | |5;yui.html;804.9718259860904;835.427732003578;839.2866063845731;904.0326850270211;918.228687902162;15160.545183644495;15759.290831912576;15828;15836.28736706848;15882.36470541177;15759.763603545927;15811.288492017859;15951.441699540519;15976.920115399436;16014.519564413056;847.0513025411548;858.3819649852112;868.9217970382664;872.8777971084053;881.9426737262057;878.2929741558044;882.3029806452895;885.8759773631697;887;887.6981826179098;923.833709932212;924.4407133684125;925.4678559828092;927.8979312275678;929.869818225449;914.1452741686478;915.5834095486604;916.7845556294233;918.6876462002917;918.8346097702411;665.9101021362103;674.1573033707865;676.3304328714586;676.705633049625;679.4598294355999;14960.177190254532;15008.924955375152;15057.397704091823;15057.623559411102;15072.773908391382;14251.71734543896;14605.48880789178;14802.703945921128;14924.62688432787;15098.698026039418;13253.150572626932;13272.73454530904;13275.46898124074;13326.466941322335;13749;4038.5355684096116;4109.383592461125;4119.958800411988;4127.545969943304;4183.016991007142;85113;85234;85597.57201214017;86734.56632716859;90002.54998725095;12256.264624122581;12337.691557711129;12392.132550721362;12393.256404615751;12695;23807.880960595085;23820.64269035966;23930.760692392854;23956.7604323958;23974.760252397253;9007.414518056305;9039.367244292967;9048.23090037341;9148.17666410013;9344.859827102599;4861.6596838220985;4991.50084991498;4993.226049962189;5163.277141200235;5184.662996905189;3427.365937301607;3500.5274287971306;3517.314123745845;3545.0428384336083;3554.608993010767;661.9437347825392;665.2981104934244;669.6618207805027;671.3890359772583;688.1776277348521;573.498189084551;632.5983000794529;718.3175982816346;755.7770457714877;760.6310939194486;9746.171575416027;10083.546240419051;10086.848697269546;10121.291509594404;10739.248252622398;634.1724050114644;638.1608185236399;644.2784081828382;646.3697894552868;647.6826355086068;4611.953880461219;4755.144074066632;4794.7842347093765;4819.108464933998;4855.732934688555;130674.34662826815;132716;133270;137861;141541.1691766159;117438;117982;118024;118752;122515.3874230641;60892;61311.693441533396;62167.68916155481;64617.35382646207;98708.50645746726;8949.149830766068;9059.36584439083;9131.726048218565;9521.666741664008;10646.148308135485;44148.33777493404;45596.08807823758;51494.485055148965;51865.22202166895;54246.45753542572;77491;78519.63640543075;79147.60426197833;82312.58843705982;84542.57728711318;13343.532976345781;13396.397162127532;14116.50592229267;14120.576382708536;14171.645708856948;14730.2634868254;14870.256487175382;15927;15935.12356820386;16213.837861621705;13592.252426116658;14322.856771432153;14525.128492290496;14767;16487.587810304838;14818.703625927637;15272;15353.462628807938;15641.687166256383;16442.917785410995;14537.418503260174;14584.85415145835;14734.410623574937;15554.222288885285;15565.14391708467;12075.27548347102;12187.695307617381;12531.436085376363;12881.35593220354;13088.411021503865;12679.175853569488;12683.239005659321;12717.427715752629;12755.426005829575;12938.223706577635 10:31:35 INFO - PROCESS | 14126 | __end_tp_report 10:31:35 INFO - PROCESS | 14126 | __start_cc_report 10:31:35 INFO - PROCESS | 14126 | _x_x_mozilla_cycle_collect,352 10:31:35 INFO - PROCESS | 14126 | __end_cc_report 10:31:35 INFO - PROCESS | 14126 | __startTimestamp1474651895283__endTimestamp 10:31:35 INFO - PROCESS | 14126 | 10:31:35 INFO - PROCESS | 14126 | ------- Summary: start ------- 10:31:35 INFO - PROCESS | 14126 | Number of tests: 6 10:31:35 INFO - PROCESS | 14126 | 10:31:35 INFO - PROCESS | 14126 | [#0] dojo.html Cycles:165 Average:5637.68 Median:5856.06 stddev:638.39 (10.9%) stddev-sans-first:612.95 10:31:35 INFO - PROCESS | 14126 | Values: 3279.2 3305.8 3307.6 3319.1 3321.8 5677.9 5712.6 5743.4 5745.7 5761.1 5693.2 5721.4 5727.7 5730.1 5733.9 5188.1 5217.1 5234.5 5257.7 5268.8 5121.0 5125.1 5135.7 5162.9 5179.2 5259.1 5271.2 5291.7 5292.6 5297.7 5269.1 5273.6 5274.9 5277.1 5289.3 4951.7 4986.6 5178.9 5187.7 5242.9 5494.4 5591.8 5606.5 5650.5 5663.1 6033.7 6072.0 6082.1 6085.0 6087.6 5950.7 6122.5 6128.7 6131.2 6138.0 5602.7 5615.7 5616.6 5686.5 5725.3 6200.2 6214.8 6217.2 6224.7 6229.0 5824.3 5892.5 5978.4 5985.5 5992.8 5960.8 5976.8 5998.8 6056.8 6100.5 5984.8 6026.0 6036.1 6036.8 6037.2 5846.9 6036.2 6038.0 6039.7 6053.8 4574.1 4586.4 4605.3 4627.1 4656.1 4113.1 4132.9 4134.3 4151.4 4156.4 5601.8 5776.5 5782.1 5783.7 5787.5 6022.2 6037.3 6073.1 6113.1 6131.1 5746.5 5799.0 5808.4 5815.6 5837.9 4879.3 5002.4 5049.4 5060.4 5069.1 6170.6 6217.0 6219.5 6343.0 6349.2 6108.9 6110.5 6114.0 6124.2 6137.9 6097.3 6167.8 6315.1 6337.2 6339.4 5923.8 5963.2 6016.4 6030.7 6035.3 6107.0 6124.1 6126.4 6128.3 6145.1 5792.7 5873.9 5875.5 5922.1 5960.7 5887.9 5990.3 5994.2 5999.6 6003.1 5879.1 5889.4 5904.5 5909.3 5924.5 5783.7 5856.1 5947.3 5954.1 5979.5 5756.2 5817.4 5834.9 5858.3 5870.4 10:31:35 INFO - PROCESS | 14126 | 10:31:35 INFO - PROCESS | 14126 | [#1] ext.html Cycles:180 Average:67707.52 Median:44135.89 stddev:141864.14 (321.4%) stddev-sans-first:142172.58 10:31:35 INFO - PROCESS | 14126 | Values: 581.3 632.1 660.4 679.3 720.2 41031.2 45551.8 45715.5 45777.8 45849.5 46833.5 47116.8 47385.5 47427.8 47468.0 9023.4 9151.1 9165.2 9168.9 9175.9 8979.7 9036.8 9092.0 9161.1 9179.4 9176.4 9185.2 9232.2 9245.6 9251.4 9023.8 9036.1 9044.1 9044.9 9103.6 9072.9 9128.4 9221.8 9243.2 9267.4 43551.3 43951.8 44084.8 44132.0 44139.8 3721.8 3757.5 3843.5 3990.3 4217.9 35748.3 35800.5 35894.0 36138.9 37754.6 4775.1 4782.2 4790.3 4820.4 4833.9 401119.0 405548.0 405652.0 405829.0 407219.0 38101.8 63226.0 63662.0 63699.7 63701.4 38464.2 40417.6 40657.8 40747.2 40769.4 17127.3 17135.7 17149.7 17233.1 17233.5 14487.9 14525.9 14546.0 14571.1 14594.9 9204.9 9213.9 9253.0 9311.6 9357.6 3469.8 3497.4 3541.2 3545.4 3611.6 1054.0 1102.2 1112.0 1124.1 1163.1 33559.5 34539.7 34673.5 34710.0 34729.5 1117.7 1126.8 1138.7 1155.3 1225.0 17364.8 17443.7 17915.6 18126.0 18223.3 654879.0 664384.0 665014.0 666174.0 669567.0 65608.7 65947.0 66284.0 66339.7 66343.3 1177.4 1193.2 1221.3 1226.5 1352.1 32975.7 33658.7 33866.8 33925.0 34332.5 56314.4 56658.4 56660.4 56712.1 56741.0 490798.0 493362.0 493767.0 495365.0 496781.0 31644.5 31670.7 31706.0 31746.2 32070.4 53073.0 53198.7 53847.5 53902.7 54324.0 44009.0 44732.0 44918.8 45487.8 46043.5 43604.3 44590.0 45354.0 45732.8 46877.8 43517.6 43885.1 44014.0 44915.6 47243.0 39290.0 39940.6 40034.8 40168.8 40368.4 29848.4 29939.9 31718.7 32233.4 32473.4 10:31:35 INFO - PROCESS | 14126 | 10:31:35 INFO - PROCESS | 14126 | [#2] jquery.html Cycles:180 Average:30105.71 Median:11560.80 stddev:85671.42 (741.1%) stddev-sans-first:85882.71 10:31:35 INFO - PROCESS | 14126 | Values: 401.7 407.3 426.6 435.1 439.3 19010.1 20454.5 20574.5 21012.2 21360.6 19999.5 20120.5 20194.7 20417.6 20518.0 5700.2 5976.6 5977.5 5981.2 5987.7 5785.7 5897.9 5916.4 5924.8 6000.2 6072.5 6106.6 6111.9 6117.4 6213.4 6517.0 6635.0 6779.7 6924.8 6925.0 6102.2 6150.9 6153.2 6157.1 6157.5 14980.4 15115.4 15198.8 20361.8 23994.8 2570.6 2625.4 2630.5 2887.6 2927.0 10442.6 10669.1 10841.1 14786.4 14981.3 1972.5 1996.4 2022.7 2043.1 2083.7 90130.5 90571.0 91401.5 91603.0 94108.5 11795.4 11865.8 11896.2 12117.6 12141.2 16710.0 16721.6 16766.0 16779.6 16821.4 8669.3 8707.1 8773.3 8936.0 9044.1 8473.2 8478.2 8515.5 8732.3 8747.7 4672.5 4748.7 4960.1 5154.4 5156.4 1937.8 2020.9 2060.3 2060.5 2109.4 925.5 994.8 1030.2 1044.4 1068.3 19547.7 20012.9 20279.0 20433.6 20552.8 1042.4 1047.8 1052.2 1060.8 1088.4 10770.8 11644.2 11662.7 11673.5 11681.4 396316.0 396684.0 578854.0 586509.0 595909.0 60597.4 74490.6 99681.0 103257.5 105804.0 1073.0 1086.1 1108.3 1126.8 1130.4 17355.5 17981.3 18271.4 18281.2 18611.1 38960.8 40513.4 41142.6 41506.8 42186.8 58313.4 58362.4 58757.4 59052.1 60397.4 8780.4 8891.6 8947.2 8976.8 8990.9 13704.9 13714.9 13850.8 14121.9 14161.4 12174.2 12237.6 12306.2 12399.7 12436.8 11766.8 11849.4 11999.0 12111.1 12427.1 12172.8 12264.6 12364.8 12484.4 12510.8 8802.6 8822.2 8837.7 8984.0 9043.7 9142.5 11484.7 11760.9 11992.0 12014.5 10:31:35 INFO - PROCESS | 14126 | 10:31:35 INFO - PROCESS | 14126 | [#3] mootools.html Cycles:180 Average:6241.97 Median:470.13 stddev:3674.68 (781.6%) stddev-sans-first:3667.66 10:31:35 INFO - PROCESS | 14126 | Values: 1492.6 1498.0 1537.6 1562.6 1571.8 8468.1 8861.3 9039.9 9793.5 9799.6 8910.2 9210.1 9243.1 9272.5 9325.3 2282.6 2322.6 2329.3 2332.6 2332.8 2327.1 2348.4 2382.9 2386.8 2388.9 2359.4 2365.7 2374.9 2375.8 2396.7 2337.0 2357.0 2374.6 2382.2 2389.9 2318.8 2322.8 2323.7 2324.9 2328.3 9232.4 9260.5 9261.5 9272.0 9292.9 5222.1 5343.3 5385.3 5385.4 5489.8 3500.5 3514.3 3515.2 3552.4 3593.6 1077.4 1095.1 1121.8 1136.2 1148.5 13418.3 13444.5 13520.1 13524.5 13534.8 4523.5 4745.6 4796.6 4838.5 4876.2 11387.7 11392.1 11407.7 11428.0 11429.5 5471.3 5546.9 5557.7 5569.6 5571.9 4604.0 4956.0 5060.5 5069.8 5138.3 4226.3 4245.4 4279.7 4309.9 4345.7 1309.8 1329.3 1332.4 1335.3 1343.6 1076.4 1081.4 1083.3 1097.1 1102.8 6401.4 6602.1 6671.9 6714.2 6810.2 469.3 469.5 470.8 472.5 483.4 4467.8 4499.0 4725.1 4801.9 4958.9 11944.1 12307.0 12311.9 12357.3 12408.1 11281.1 11789.0 11808.3 12201.5 12279.6 8951.5 9026.0 9066.2 9139.2 9167.9 6423.7 6676.7 6745.4 6757.3 6763.7 11075.2 11107.7 11166.8 11287.9 11288.0 11062.1 11210.1 11348.6 11479.3 11615.0 7653.6 8116.9 8271.5 8329.5 8438.3 9193.2 9220.3 9310.2 9317.6 9318.8 8170.5 8322.6 8372.5 8380.2 8529.6 8051.9 8056.4 8114.3 8131.6 8304.4 7467.6 7510.4 7517.3 7527.5 7589.2 5468.9 5504.5 5574.8 5584.6 5689.8 5593.4 5647.6 5662.0 5701.0 5783.6 10:31:35 INFO - PROCESS | 14126 | 10:31:35 INFO - PROCESS | 14126 | [#4] prototype.html Cycles:180 Average:4914.48 Median:5516.82 stddev:1437.47 (26.1%) stddev-sans-first:1399.66 10:31:35 INFO - PROCESS | 14126 | Values: 327.1 338.6 340.8 352.0 364.3 5616.3 5724.0 5818.5 5956.9 5958.4 5762.7 5801.3 5805.0 5806.9 5822.8 4490.2 4501.9 4507.5 4514.4 4518.1 4429.9 4467.6 4479.2 4481.8 4482.4 4442.9 4446.7 4448.9 4456.8 4494.4 4463.0 4468.9 4487.5 4508.4 4510.8 3847.0 3871.0 3894.1 3966.7 3973.8 5578.8 5581.2 5587.6 5655.6 5680.0 5145.6 5146.4 5155.9 5206.4 5207.0 5928.2 6070.8 6075.8 6084.3 6147.3 4317.2 4335.9 4342.3 4363.4 4371.0 6226.8 6384.5 6404.2 6414.7 6418.7 4345.9 4405.8 4407.7 4415.8 4424.0 4497.8 4512.8 4517.2 4520.1 4522.1 5170.9 5188.9 5203.8 5209.0 5211.3 5961.2 5989.5 6098.3 6133.8 6152.4 1515.3 1543.0 1545.3 1546.6 1552.7 951.3 962.5 972.7 987.7 997.5 5157.9 5177.7 5211.8 5231.1 5246.3 5472.2 5512.9 5547.4 5558.7 5568.9 5004.7 5227.3 5230.4 5235.4 5253.0 2901.7 2961.6 2977.2 3001.6 3031.4 5626.7 5704.9 5712.2 5790.6 5827.4 5275.3 5474.4 5551.4 5615.6 5657.6 5608.3 5692.4 5733.9 5743.4 5787.7 5162.6 5454.3 5528.7 5532.8 5536.9 5405.3 5438.8 5448.3 5481.8 5520.7 5644.4 5655.1 5695.1 5710.4 5715.8 3839.5 3923.2 3932.9 3965.8 3982.5 5444.8 5536.3 5572.1 6154.8 6312.4 6105.3 6126.9 6176.5 6228.1 6258.7 6033.2 6123.5 6156.8 6176.4 6187.4 6086.5 6099.9 6112.5 6114.9 6131.3 6240.1 6240.8 6264.4 6264.7 6284.8 5860.0 5989.3 6037.5 6045.2 6113.2 10:31:35 INFO - PROCESS | 14126 | 10:31:35 INFO - PROCESS | 14126 | [#5] yui.html Cycles:180 Average:22343.43 Median:4073.96 stddev:33257.04 (816.3%) stddev-sans-first:33311.01 10:31:35 INFO - PROCESS | 14126 | Values: 805.0 835.4 839.3 904.0 918.2 15160.5 15759.3 15828.0 15836.3 15882.4 15759.8 15811.3 15951.4 15976.9 16014.5 847.1 858.4 868.9 872.9 881.9 878.3 882.3 885.9 887.0 887.7 923.8 924.4 925.5 927.9 929.9 914.1 915.6 916.8 918.7 918.8 665.9 674.2 676.3 676.7 679.5 14960.2 15008.9 15057.4 15057.6 15072.8 14251.7 14605.5 14802.7 14924.6 15098.7 13253.2 13272.7 13275.5 13326.5 13749.0 4038.5 4109.4 4120.0 4127.5 4183.0 85113.0 85234.0 85597.6 86734.6 90002.5 12256.3 12337.7 12392.1 12393.3 12695.0 23807.9 23820.6 23930.8 23956.8 23974.8 9007.4 9039.4 9048.2 9148.2 9344.9 4861.7 4991.5 4993.2 5163.3 5184.7 3427.4 3500.5 3517.3 3545.0 3554.6 661.9 665.3 669.7 671.4 688.2 573.5 632.6 718.3 755.8 760.6 9746.2 10083.5 10086.8 10121.3 10739.2 634.2 638.2 644.3 646.4 647.7 4612.0 4755.1 4794.8 4819.1 4855.7 130674.3 132716.0 133270.0 137861.0 141541.2 117438.0 117982.0 118024.0 118752.0 122515.4 60892.0 61311.7 62167.7 64617.4 98708.5 8949.1 9059.4 9131.7 9521.7 10646.1 44148.3 45596.1 51494.5 51865.2 54246.5 77491.0 78519.6 79147.6 82312.6 84542.6 13343.5 13396.4 14116.5 14120.6 14171.6 14730.3 14870.3 15927.0 15935.1 16213.8 13592.3 14322.9 14525.1 14767.0 16487.6 14818.7 15272.0 15353.5 15641.7 16442.9 14537.4 14584.9 14734.4 15554.2 15565.1 12075.3 12187.7 12531.4 12881.4 13088.4 12679.2 12683.2 12717.4 12755.4 12938.2 10:31:35 INFO - PROCESS | 14126 | -------- Summary: end -------- 10:31:35 INFO - PROCESS | 14126 | 10:31:35 INFO - TEST-INFO | 14126: exit 0 10:31:35 INFO - TEST-OK | dromaeo_css | took 1110817ms 10:31:35 INFO - TEST-START | kraken 10:31:35 INFO - operating with platform_type : linux_ 10:31:35 INFO - Initialising browser for kraken test... 10:31:35 INFO - TEST-INFO | started process 14372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgR6Kha/profile http://localhost:51588/getInfo.html) 10:31:40 INFO - PROCESS | 14372 | __metrics Screen width/height:1600/1200 10:31:40 INFO - PROCESS | 14372 | colorDepth:24 10:31:40 INFO - PROCESS | 14372 | Browser inner width/height: 1024/697 10:31:40 INFO - PROCESS | 14372 | __metrics 10:31:41 ERROR - PROCESS | 14372 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:31:42 INFO - TEST-INFO | 14372: exit 0 10:31:42 INFO - Browser initialized. 10:31:42 INFO - Running cycle 1/1 for kraken test... 10:31:42 INFO - TEST-INFO | started process 14499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgR6Kha/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:31:53 INFO - PROCESS | 14499 | RSS: Main: 149995520 10:31:53 INFO - PROCESS | 14499 | 10:31:56 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51588/tests/kraken/driver.html?testName=audio-beat-detection) 10:31:57 INFO - PROCESS | 14499 | RSS: Main: 156258304 10:31:57 INFO - PROCESS | 14499 | 10:31:59 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51588/tests/kraken/driver.html?testName=audio-dft) 10:32:00 INFO - PROCESS | 14499 | RSS: Main: 155496448 10:32:00 INFO - PROCESS | 14499 | 10:32:03 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51588/tests/kraken/driver.html?testName=audio-fft) 10:32:03 INFO - PROCESS | 14499 | RSS: Main: 156344320 10:32:03 INFO - PROCESS | 14499 | 10:32:06 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51588/tests/kraken/driver.html?testName=audio-oscillator) 10:32:06 INFO - PROCESS | 14499 | RSS: Main: 156246016 10:32:06 INFO - PROCESS | 14499 | 10:32:08 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51588/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:32:09 INFO - PROCESS | 14499 | RSS: Main: 155774976 10:32:09 INFO - PROCESS | 14499 | 10:32:12 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51588/tests/kraken/driver.html?testName=imaging-darkroom) 10:32:13 INFO - PROCESS | 14499 | RSS: Main: 155389952 10:32:13 INFO - PROCESS | 14499 | 10:32:16 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51588/tests/kraken/driver.html?testName=imaging-desaturate) 10:32:17 INFO - PROCESS | 14499 | RSS: Main: 156033024 10:32:17 INFO - PROCESS | 14499 | 10:32:20 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51588/tests/kraken/driver.html?testName=json-parse-financial) 10:32:20 INFO - PROCESS | 14499 | RSS: Main: 155811840 10:32:20 INFO - PROCESS | 14499 | 10:32:22 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51588/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:32:22 INFO - PROCESS | 14499 | RSS: Main: 155590656 10:32:22 INFO - PROCESS | 14499 | 10:32:24 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:32:25 INFO - PROCESS | 14499 | RSS: Main: 155504640 10:32:25 INFO - PROCESS | 14499 | 10:32:27 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:32:27 INFO - PROCESS | 14499 | RSS: Main: 155602944 10:32:27 INFO - PROCESS | 14499 | 10:32:30 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:32:30 INFO - PROCESS | 14499 | RSS: Main: 156303360 10:32:30 INFO - PROCESS | 14499 | 10:32:33 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:32:34 INFO - PROCESS | 14499 | RSS: Main: 156147712 10:32:34 INFO - PROCESS | 14499 | 10:32:35 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51588/tests/kraken/driver.html?testName=ai-astar) 10:32:36 INFO - PROCESS | 14499 | RSS: Main: 158273536 10:32:36 INFO - PROCESS | 14499 | 10:32:36 INFO - PROCESS | 14499 | __start_tp_report 10:32:36 INFO - PROCESS | 14499 | _x_x_mozilla_page_load 10:32:36 INFO - PROCESS | 14499 | _x_x_mozilla_page_load_details 10:32:36 INFO - PROCESS | 14499 | |i|pagename|runs| 10:32:36 INFO - PROCESS | 14499 | |0;ai-astar;101;112;107;110;112;111;110;110;110;110 10:32:36 INFO - PROCESS | 14499 | |1;audio-beat-detection;145;121;139;160;121;143;151;117;175;116 10:32:36 INFO - PROCESS | 14499 | |2;audio-dft;163;163;165;164;163;165;163;162;163;162 10:32:36 INFO - PROCESS | 14499 | |3;audio-fft;76;76;75;167;76;75;79;76;165;74 10:32:36 INFO - PROCESS | 14499 | |4;audio-oscillator;85;83;159;84;85;83;150;83;84;144 10:32:36 INFO - PROCESS | 14499 | |5;imaging-gaussian-blur;118;118;118;117;119;117;118;118;117;117 10:32:36 INFO - PROCESS | 14499 | |6;imaging-darkroom;151;148;147;147;146;147;147;147;147;150 10:32:36 INFO - PROCESS | 14499 | |7;imaging-desaturate;95;95;96;95;95;95;95;96;95;95 10:32:36 INFO - PROCESS | 14499 | |8;json-parse-financial;55;53;51;51;50;51;51;51;51;52 10:32:36 INFO - PROCESS | 14499 | |9;json-stringify-tinderbox;63;60;59;61;60;59;60;60;63;60 10:32:36 INFO - PROCESS | 14499 | |10;stanford-crypto-aes;78;73;73;71;79;73;74;72;78;72 10:32:36 INFO - PROCESS | 14499 | |11;stanford-crypto-ccm;120;115;118;118;118;121;126;118;148;129 10:32:36 INFO - PROCESS | 14499 | |12;stanford-crypto-pbkdf2;161;153;153;155;152;153;152;158;155;157 10:32:36 INFO - PROCESS | 14499 | |13;stanford-crypto-sha256-iterative;64;68;62;62;64;62;62;61;60;61 10:32:36 INFO - PROCESS | 14499 | __end_tp_report 10:32:36 INFO - PROCESS | 14499 | __start_cc_report 10:32:36 INFO - PROCESS | 14499 | _x_x_mozilla_cycle_collect,935 10:32:36 INFO - PROCESS | 14499 | __end_cc_report 10:32:36 INFO - PROCESS | 14499 | __startTimestamp1474651956137__endTimestamp 10:32:36 INFO - PROCESS | 14499 | 10:32:36 INFO - PROCESS | 14499 | ------- Summary: start ------- 10:32:36 INFO - PROCESS | 14499 | Number of tests: 14 10:32:36 INFO - PROCESS | 14499 | 10:32:36 INFO - PROCESS | 14499 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:3.23 (2.9%) stddev-sans-first:1.48 10:32:36 INFO - PROCESS | 14499 | Values: 101.0 112.0 107.0 110.0 112.0 111.0 110.0 110.0 110.0 110.0 10:32:36 INFO - PROCESS | 14499 | 10:32:36 INFO - PROCESS | 14499 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:144.00 stddev:19.98 (13.9%) stddev-sans-first:21.07 10:32:36 INFO - PROCESS | 14499 | Values: 145.0 121.0 139.0 160.0 121.0 143.0 151.0 117.0 175.0 116.0 10:32:36 INFO - PROCESS | 14499 | 10:32:36 INFO - PROCESS | 14499 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:1.12 10:32:36 INFO - PROCESS | 14499 | Values: 163.0 163.0 165.0 164.0 163.0 165.0 163.0 162.0 163.0 162.0 10:32:36 INFO - PROCESS | 14499 | 10:32:36 INFO - PROCESS | 14499 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:38.02 (50.0%) stddev-sans-first:39.78 10:32:36 INFO - PROCESS | 14499 | Values: 76.0 76.0 75.0 167.0 76.0 75.0 79.0 76.0 165.0 74.0 10:32:36 INFO - PROCESS | 14499 | 10:32:36 INFO - PROCESS | 14499 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:83.50 stddev:32.64 (39.1%) stddev-sans-first:33.88 10:32:36 INFO - PROCESS | 14499 | Values: 85.0 83.0 159.0 84.0 85.0 83.0 150.0 83.0 84.0 144.0 10:32:36 INFO - PROCESS | 14499 | 10:32:36 INFO - PROCESS | 14499 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:32:36 INFO - PROCESS | 14499 | Values: 118.0 118.0 118.0 117.0 119.0 117.0 118.0 118.0 117.0 117.0 10:32:36 INFO - PROCESS | 14499 | 10:32:36 INFO - PROCESS | 14499 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.00 stddev:1.57 (1.1%) stddev-sans-first:1.12 10:32:36 INFO - PROCESS | 14499 | Values: 151.0 148.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 150.0 10:32:36 INFO - PROCESS | 14499 | 10:32:36 INFO - PROCESS | 14499 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:32:36 INFO - PROCESS | 14499 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 10:32:36 INFO - PROCESS | 14499 | 10:32:36 INFO - PROCESS | 14499 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:51.00 stddev:1.43 (2.8%) stddev-sans-first:0.83 10:32:36 INFO - PROCESS | 14499 | Values: 55.0 53.0 51.0 51.0 50.0 51.0 51.0 51.0 51.0 52.0 10:32:36 INFO - PROCESS | 14499 | 10:32:36 INFO - PROCESS | 14499 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.00 stddev:1.43 (2.4%) stddev-sans-first:1.20 10:32:36 INFO - PROCESS | 14499 | Values: 63.0 60.0 59.0 61.0 60.0 59.0 60.0 60.0 63.0 60.0 10:32:36 INFO - PROCESS | 14499 | 10:32:36 INFO - PROCESS | 14499 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:73.50 stddev:2.91 (4.0%) stddev-sans-first:2.76 10:32:36 INFO - PROCESS | 14499 | Values: 78.0 73.0 73.0 71.0 79.0 73.0 74.0 72.0 78.0 72.0 10:32:36 INFO - PROCESS | 14499 | 10:32:36 INFO - PROCESS | 14499 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:120.50 stddev:9.70 (8.1%) stddev-sans-first:10.22 10:32:36 INFO - PROCESS | 14499 | Values: 120.0 115.0 118.0 118.0 118.0 121.0 126.0 118.0 148.0 129.0 10:32:36 INFO - PROCESS | 14499 | 10:32:36 INFO - PROCESS | 14499 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:155.00 stddev:2.96 (1.9%) stddev-sans-first:2.17 10:32:36 INFO - PROCESS | 14499 | Values: 161.0 153.0 153.0 155.0 152.0 153.0 152.0 158.0 155.0 157.0 10:32:36 INFO - PROCESS | 14499 | 10:32:36 INFO - PROCESS | 14499 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.00 stddev:2.27 (3.7%) stddev-sans-first:2.35 10:32:36 INFO - PROCESS | 14499 | Values: 64.0 68.0 62.0 62.0 64.0 62.0 62.0 61.0 60.0 61.0 10:32:36 INFO - PROCESS | 14499 | -------- Summary: end -------- 10:32:36 INFO - PROCESS | 14499 | 10:32:37 INFO - TEST-INFO | 14499: exit 0 10:32:37 INFO - TEST-OK | kraken | took 61138ms 10:32:37 INFO - SUITE-END | took 1171s 10:32:37 INFO - Completed test suite (00:19:32) 10:32:37 INFO - javascript benchmark 10:32:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7595.4252549382045, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.2457734721015, 3305.785123966942, 3307.603087629485, 3319.1038419626716, 3321.76747627666, 5677.943220567799, 5712.628679135853, 5743.396943320954, 5745.712714364276, 5761.107028410598, 5693.202951586771, 5721.399253078429, 5727.742251598677, 5730.05454100074, 5733.913991290134, 5188.0920838853235, 5217.087009773274, 5234.450382709818, 5257.658252213613, 5268.789248430058, 5121.027004869082, 5125.103106956286, 5135.717535535544, 5162.870928226786, 5179.249008893708, 5259.132243179871, 5271.235670827747, 5291.656042357254, 5292.603054770908, 5297.655652382602, 5269.130593452076, 5273.630845840793, 5274.947250527484, 5277.076511610453, 5289.312389389354, 4951.653384263103, 4986.5761410280165, 5178.896422071575, 5187.662801917863, 5242.895142097175, 5494.395616482184, 5591.8042868499815, 5606.467385598362, 5650.463205995424, 5663.122216056518, 6033.728482218311, 6072.028475443952, 6082.087686846964, 6085.026395776655, 6087.573869829113, 5950.702464876739, 6122.54080943931, 6128.662923539204, 6131.172291740602, 6138.0, 5602.663840169603, 5615.747291371898, 5616.5787565932305, 5686.516646085046, 5725.255716756837, 6200.162977997912, 6214.782482613087, 6217.222847144107, 6224.657643829632, 6229.034499652561, 5824.330202026821, 5892.499137573269, 5978.432048955342, 5985.521158307325, 5992.760289588455, 5960.761569537257, 5976.7908123215475, 5998.790042348497, 6056.788012419633, 6100.542459315569, 5984.760609575568, 6026.0, 6036.094585812076, 6036.849078772978, 6037.154798328237, 5846.853828654318, 6036.154938308552, 6038.033914573647, 6039.667818270037, 6053.788117415869, 4574.108048930427, 4586.380838586815, 4605.309203619417, 4627.097715945426, 4656.092062047868, 4113.074558224375, 4132.876013719593, 4134.255833949918, 4151.356539736285, 4156.4388807510595, 5601.80393686219, 5776.5089967352405, 5782.132680098019, 5783.681897495678, 5787.450192231731, 6022.247219097613, 6037.305709843425, 6073.089036644538, 6113.111460343324, 6131.0708424985305, 5746.511546518509, 5799.014167591519, 5808.3901190375245, 5815.621984570989, 5837.883242335214, 4879.26810978349, 5002.449730529639, 5049.368828896388, 5060.443351231362, 5069.112905241568, 6170.598911070766, 6217.0, 6219.502439804804, 6343.0, 6349.206349206349, 6108.938910611015, 6110.480609148272, 6114.0, 6124.234470691164, 6137.877242455215, 6097.298810636834, 6167.753289868355, 6315.115883776367, 6337.2395312562785, 6339.429451349401, 5923.763049477972, 5963.165156877953, 6016.368281330398, 6030.7286172121485, 6035.305939816977, 6106.969465152646, 6124.14262003311, 6126.356732543019, 6128.295246046583, 6145.078238264117, 5792.710364481674, 5873.882522349614, 5875.471207591338, 5922.082077278029, 5960.731767070579, 5887.911681324869, 5990.31111422192, 5994.220751302303, 5999.610025348338, 6003.099535069775, 5879.147523609138, 5889.411058894077, 5904.468597826216, 5909.349971503218, 5924.496417804535, 5783.681897495678, 5856.063029915364, 5947.256592925884, 5954.07711804671, 5979.4917432018765, 5756.165356023437, 5817.360090390139, 5834.883302334015, 5858.2677165354335, 5870.354261031369], "value": 5594.722865528413, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.2908251932644, 632.0866348126956, 660.3792435110994, 679.320679320679, 720.2005773591316, 41031.17937641249, 45551.77224113879, 45715.542844571544, 45777.7711111444, 45849.541504584944, 46833.531664683425, 47116.76441617795, 47385.52614473854, 47427.76286118573, 47468.0, 9023.368364214492, 9151.084891510862, 9165.175134237918, 9168.908310916871, 9175.862362064574, 8979.685711000116, 9036.77408064797, 9091.954540227289, 9161.083891610819, 9179.357444978821, 9176.357654964155, 9185.173334399902, 9232.215261702764, 9245.630174793001, 9251.444913305224, 9023.774405639846, 9036.096390360977, 9044.14080662336, 9044.864327035068, 9103.590338434786, 9072.909270907272, 9128.406653567497, 9221.81556368869, 9243.168114869693, 9267.397619154734, 43551.34672979908, 43951.78024109891, 44084.779576101915, 44132.0, 44139.77930110361, 3721.832517536717, 3757.530308711411, 3843.4811300474357, 3990.2817492851277, 4217.852375166885, 35748.28503429943, 35800.462993055124, 35894.0, 36138.91583252507, 37754.62245377539, 4775.14047471455, 4782.23484242523, 4790.281457781326, 4820.39745031871, 4833.927491087637, 401119.0, 405548.0, 405652.0, 405829.0, 407218.96390518156, 38101.809490952364, 63226.0, 63662.0, 63699.68150159312, 63701.36298637047, 38464.230715385536, 40417.59582404197, 40657.79671101626, 40747.18505629871, 40769.38845917313, 17127.314907403812, 17135.65728685419, 17149.65700686004, 17233.138343082795, 17233.482995510156, 14487.855121448862, 14525.92737036308, 14546.0, 14571.125732456087, 14594.854051459562, 9204.907950920538, 9213.90786092144, 9252.953735231415, 9311.580978855967, 9357.625694972261, 3469.8438570264398, 3497.370473314828, 3541.1501239702284, 3545.3795585772386, 3611.602723700391, 1054.0, 1102.1788767368362, 1111.9944400277948, 1124.0726400719439, 1163.1276542593055, 33559.49660755091, 34539.654603454146, 34673.47989780155, 34710.0, 34729.479057814155, 1117.742919128605, 1126.7802778458286, 1138.7039369763756, 1155.3241353808116, 1224.9632511024683, 17364.826351736574, 17443.65112697739, 17915.641687166182, 18126.0, 18223.271069157352, 654879.0, 664384.0, 665014.0, 666174.0, 669567.0, 65608.67195663991, 65947.0, 66284.0, 66339.66830165914, 66343.33656663468, 1177.43483128099, 1193.2065176657425, 1221.2794451273792, 1226.5032661771997, 1352.0738294268458, 32975.67024329726, 33658.66341336555, 33866.830665846515, 33925.0, 34332.485012724326, 56314.43685563092, 56658.43341566531, 56660.43339566552, 56712.14931775944, 56741.0, 490798.0, 493362.0, 493767.0, 495365.0, 496781.0, 31644.5253321205, 31670.683293166774, 31706.04881853548, 31746.206344841565, 32070.35859282848, 53073.0, 53198.73400632972, 53847.461525385814, 53902.73048634732, 54324.0, 44009.0, 44732.0, 44918.7540622961, 45487.77256113698, 46043.539564605264, 43604.34593481164, 44590.0, 45354.0, 45732.77133614444, 46877.76561117172, 43517.56482435135, 43885.12229755323, 44014.0, 44915.55084449114, 47243.0, 39290.0, 39940.60059399369, 40034.799826000686, 40168.7991560052, 40368.3944740835, 29848.403031939673, 29939.850300748356, 31718.682813171574, 32233.35533289368, 32473.350532988734], "value": 20477.860115541993, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.67865707434044, 407.32384242158025, 426.6032589691587, 435.09717336526705, 439.30808975863005, 19010.144543495542, 20454.488637784045, 20574.48563785906, 21012.159513619437, 21360.57278854422, 19999.500012499695, 20120.49698757532, 20194.697079543817, 20417.59164816703, 20518.0, 5700.173474846145, 5976.581639285252, 5977.462028417442, 5981.162637230791, 5987.730552125143, 5785.710714464281, 5897.911531327012, 5916.3787802280785, 5924.792632257871, 6000.2199714037115, 6072.544559158058, 6106.603070800406, 6111.877762444748, 6117.388261173892, 6213.440790328869, 6516.967415162918, 6635.0, 6779.661016949182, 6924.792256232321, 6925.0, 6102.237220347457, 6150.876982460326, 6153.230846144232, 6157.076438534211, 6157.507399408037, 14980.400783968627, 15115.395384184729, 15198.772018419733, 20361.77829330245, 23994.7600523996, 2570.5630042892753, 2625.4092829113297, 2630.5002049610703, 2887.566864970271, 2926.956095658567, 10442.582296708122, 10669.146468282597, 10841.13270938331, 14786.40854365824, 14981.325840337211, 1972.5364539333245, 1996.3511858645998, 2022.6662600670873, 2043.1214577731719, 2083.666613341873, 90130.5493472535, 90571.0, 91401.54299228461, 91603.0, 94108.52945735295, 11795.35125568102, 11865.754095819988, 11896.167268291136, 12117.575884843987, 12141.150119491727, 16710.0, 16721.581960451087, 16766.0, 16779.580510487336, 16821.411250606416, 8669.306455483546, 8707.129287071242, 8773.298136149093, 8935.955320223356, 9044.14080662336, 8473.195046470575, 8478.194571515696, 8515.531645759544, 8732.257758090507, 8747.737567872973, 4672.5327467253, 4748.6913350632785, 4960.107180707508, 5154.407243167008, 5156.381234251839, 1937.8255956963942, 2020.9191632334837, 2060.2789023841538, 2060.536379314642, 2109.440998135495, 925.4863550729275, 994.8109859126743, 1030.1810061001372, 1044.3942513342242, 1068.278911734576, 19547.706784398244, 20012.89993550023, 20279.0, 20433.591328173352, 20552.794472055088, 1042.4266653340633, 1047.8323468245044, 1052.2003277509148, 1060.750723579958, 1088.4394536813547, 10770.838437423445, 11644.24312419707, 11662.650120496399, 11673.474693638807, 11681.357525336018, 396316.0, 396684.0, 578854.0, 586509.0, 595909.0, 60597.39402606006, 74490.62754686191, 99681.0, 103257.48371258096, 105804.0, 1073.0, 1086.0714089453404, 1108.257467496779, 1126.7633796902742, 1130.37829193943, 17355.47933561995, 17981.280748769903, 18271.36050238235, 18281.17734701915, 18611.06944652789, 38960.80519597384, 40513.39229911612, 41142.58857411388, 41506.79246603748, 42186.78906605447, 58313.4168658308, 58362.416375835695, 58757.41242587519, 59052.11421828762, 60397.396026039176, 8780.385373024083, 8891.555422228734, 8947.239484643878, 8976.775580610538, 8990.910090899008, 13704.862951370358, 13714.86285137136, 13850.792238116235, 14121.929390352983, 14161.433542658591, 12174.208676436003, 12237.632871013884, 12306.200096993667, 12399.690007749878, 12436.751264974831, 11766.823497647714, 11849.407529623311, 11999.0, 12111.091668125102, 12427.067969902475, 12172.756544868877, 12264.632061038183, 12364.81452778227, 12484.43820028119, 12510.812337814757, 8802.559872006503, 8822.161894620001, 8837.690680826141, 8984.0, 9043.728688139367, 9142.49716265585, 11484.655460336204, 11760.88239117598, 11992.0, 12014.519419223134], "value": 9697.69485658348, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.626843289177, 1497.9850201497989, 1537.6155961009747, 1562.570293169379, 1571.8428157184283, 8468.06851246364, 8861.291096712264, 9039.90960090399, 9793.461359625227, 9799.608015679372, 8910.153535414125, 9210.125038121369, 9243.075692430753, 9272.490013049279, 9325.253979681625, 2282.6005449046393, 2322.5703244899664, 2329.324495896188, 2332.6384410416413, 2332.7783860533223, 2327.0808030827898, 2348.3776799148154, 2382.904683812654, 2386.7971222446026, 2388.9283321500384, 2359.398353419884, 2365.727941286757, 2374.9168779092647, 2375.7743014413604, 2396.7363590005084, 2336.953260934789, 2356.964645530318, 2374.5725769361507, 2382.154335211001, 2389.940251493709, 2318.8376813623054, 2322.8141748660237, 2323.674685544025, 2324.9186278480342, 2328.2549584133085, 9232.399894006869, 9260.536973151315, 9261.490618016007, 9272.0, 9292.90707092934, 5222.112240919053, 5343.332083489564, 5385.272988146628, 5385.380681221671, 5489.752961116759, 3500.5449291592186, 3514.3147086318177, 3515.244222492151, 3552.4493703476, 3593.6406359364114, 1077.3643550305278, 1095.1129585036067, 1121.7532142928542, 1136.2387200575552, 1148.5061423587854, 13418.329083545783, 13444.462221511129, 13520.12119212248, 13524.526641567498, 13534.796978045337, 4523.5024147343765, 4745.596624286905, 4796.616270698336, 4838.491958344393, 4876.195427754381, 11387.658370248906, 11392.088632909348, 11407.714807129889, 11428.0286175676, 11429.485673144729, 5471.316085489314, 5546.944530554723, 5557.749901254453, 5569.582281328917, 5571.9442805572235, 4604.0, 4956.0, 5060.468650791614, 5069.771860266297, 5138.332016837787, 4226.281532139544, 4245.448091748053, 4279.657627389802, 4309.913801723948, 4345.739255644671, 1309.7642424363705, 1329.3154025676783, 1332.393760838816, 1335.2656039178607, 1343.583489118357, 1076.364944682641, 1081.4484612847348, 1083.2904447586843, 1097.067492631257, 1102.7849569333903, 6401.4238718514625, 6602.075709400688, 6671.933280667228, 6714.227863795629, 6810.216825065082, 469.3358897160548, 469.47418890842476, 470.7763812189251, 472.4708326674147, 483.37161689803116, 4467.798949047301, 4498.977505112519, 4725.10223057618, 4801.879953001203, 4958.925616115761, 11944.104192185447, 12307.0, 12311.938440307742, 12357.25856448598, 12408.131430799758, 11281.097512199005, 11788.997935175435, 11808.291502509877, 12201.45093470796, 12279.570215042431, 8951.507667078373, 9025.954870225738, 9066.184043436122, 9139.177474027369, 9167.908320916838, 6423.710933007932, 6676.6995485202315, 6745.392914637706, 6757.3242675732035, 6763.6618169092335, 11075.169362298022, 11107.666769996913, 11166.832497512381, 11287.887121128684, 11288.0, 11062.115030797679, 11210.103191744804, 11348.602798901999, 11479.311241325548, 11615.0, 7653.579053151907, 8116.878246826421, 8271.54506502124, 8329.541875196923, 8438.324934005388, 9193.218576420812, 9220.262379009797, 9310.162085412345, 9317.6272949084, 9318.813623727623, 8170.468919520212, 8322.625481853453, 8372.539510326747, 8380.20388063133, 8529.616167272363, 8051.919480805117, 8056.355491560778, 8114.269715725377, 8131.552764598004, 8304.418690691593, 7467.589282589292, 7510.361619262424, 7517.285857843496, 7527.510711803715, 7589.241075892367, 5468.9179662304305, 5504.4770746778995, 5574.777976896709, 5584.553235741212, 5689.800856969986, 5593.412691667317, 5647.576431767716, 5662.0, 5701.030824759718, 5783.624064435799], "value": 4842.457866291952, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.07274875727313, 338.56832538513396, 340.75976436612183, 352.0494664406103, 364.25509832392754, 5616.269884914956, 5723.9713801430935, 5818.487193329738, 5956.85107872304, 5958.374370691075, 5762.703391736857, 5801.303843538782, 5804.984127777643, 5806.912896306549, 5822.767089316422, 4490.169318676048, 4501.932471012921, 4507.549245075499, 4514.435695538058, 4518.1415531049, 4429.911401771963, 4467.575580319881, 4479.216137175998, 4481.753503557303, 4482.439695038121, 4442.933355999663, 4446.666500012496, 4448.866534003969, 4456.821727130911, 4494.438195225597, 4462.977685111586, 4468.910621787562, 4487.506374298824, 4508.413906192207, 4510.8421205257655, 3847.0, 3870.9548421925924, 3894.1432884765304, 3966.6628336591425, 3973.8078576427247, 5578.804741834057, 5581.190727344553, 5587.55299576037, 5655.604107712462, 5679.971600142014, 5145.6398052136365, 5146.3824341078935, 5155.922661160085, 5206.427292997805, 5206.9846379955925, 5928.199693041427, 6070.785842831451, 6075.787347442818, 6084.300305464884, 6147.2930612979635, 4317.179735850178, 4335.869923902256, 4342.30523116303, 4363.410939523155, 4370.978145109254, 6226.750929962841, 6384.489240860767, 6404.167458230447, 6414.679266036726, 6418.711157997855, 4345.9348109778375, 4405.757683327448, 4407.730019040197, 4415.845445409395, 4423.977880110579, 4497.8425755098415, 4512.774361281923, 4517.186906356887, 4520.118576877478, 4522.140793249272, 5170.870728231825, 5188.870278242998, 5203.8178663746585, 5208.9739551302, 5211.296474975906, 5961.241433777046, 5989.520838332923, 6098.26820781509, 6133.754649814046, 6152.400375902208, 1515.3181068519211, 1542.9768553471483, 1545.3200591739599, 1546.615778877898, 1552.74379727346, 951.286535098676, 962.4995002598749, 972.747085757694, 987.7036888933292, 997.4962643864947, 5157.942621762605, 5177.747679759317, 5211.765470553834, 5231.142944254811, 5246.317978662826, 5472.2065300531995, 5512.91730624033, 5547.417521160301, 5558.749856256478, 5568.888622227532, 5004.724740139327, 5227.320448341691, 5230.443298557017, 5235.408472805985, 5253.0, 2901.6663083745216, 2961.6001839751357, 2977.196157037631, 3001.5947847040807, 3031.363413683107, 5626.7339848534575, 5704.914426283609, 5712.2288491054005, 5790.623609465371, 5827.388124246893, 5275.287836142148, 5474.39781624021, 5551.361593416728, 5615.596100974756, 5657.632253903483, 5608.298962629671, 5692.430756924275, 5733.8566535836935, 5743.396943320891, 5787.65274083548, 5162.561182299547, 5454.263674404064, 5528.695921724344, 5532.751026203911, 5536.947979883809, 5405.297311349499, 5438.755256013568, 5448.264484294569, 5481.75332110048, 5520.723963801875, 5644.435556444323, 5655.095184770417, 5695.117256825199, 5710.400407957105, 5715.799947002001, 3839.4676897254035, 3923.1761330119853, 3932.9016774580864, 3965.821538030738, 3982.5021872265966, 5444.782208711607, 5536.307961504812, 5572.136318870582, 6154.78458253959, 6312.400321969406, 6105.297890742621, 6126.908096378469, 6176.536759742948, 6228.128062071223, 6258.687065646791, 6033.215681961317, 6123.540734445023, 6156.78451254204, 6176.3514830943905, 6187.381261873777, 6086.513078953584, 6099.8780024398375, 6112.510999120149, 6114.908276375947, 6131.294901086432, 6240.126382306572, 6240.781572644935, 6264.373562643881, 6264.68676566179, 6284.780032698834, 5860.0, 5989.251343582052, 6037.45662890342, 6045.153678484928, 6113.205283313141], "value": 4454.050506573556, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.9718259860904, 835.427732003578, 839.2866063845731, 904.0326850270211, 918.228687902162, 15160.545183644495, 15759.290831912576, 15828.0, 15836.28736706848, 15882.36470541177, 15759.763603545927, 15811.288492017859, 15951.441699540519, 15976.920115399436, 16014.519564413056, 847.0513025411548, 858.3819649852112, 868.9217970382664, 872.8777971084053, 881.9426737262057, 878.2929741558044, 882.3029806452895, 885.8759773631697, 887.0, 887.6981826179098, 923.833709932212, 924.4407133684125, 925.4678559828092, 927.8979312275678, 929.869818225449, 914.1452741686478, 915.5834095486604, 916.7845556294233, 918.6876462002917, 918.8346097702411, 665.9101021362103, 674.1573033707865, 676.3304328714586, 676.705633049625, 679.4598294355999, 14960.177190254532, 15008.924955375152, 15057.397704091823, 15057.623559411102, 15072.773908391382, 14251.71734543896, 14605.48880789178, 14802.703945921128, 14924.62688432787, 15098.698026039418, 13253.150572626932, 13272.73454530904, 13275.46898124074, 13326.466941322335, 13749.0, 4038.5355684096116, 4109.383592461125, 4119.958800411988, 4127.545969943304, 4183.016991007142, 85113.0, 85234.0, 85597.57201214017, 86734.56632716859, 90002.54998725095, 12256.264624122581, 12337.691557711129, 12392.132550721362, 12393.256404615751, 12695.0, 23807.880960595085, 23820.64269035966, 23930.760692392854, 23956.7604323958, 23974.760252397253, 9007.414518056305, 9039.367244292967, 9048.23090037341, 9148.17666410013, 9344.859827102599, 4861.6596838220985, 4991.50084991498, 4993.226049962189, 5163.277141200235, 5184.662996905189, 3427.365937301607, 3500.5274287971306, 3517.314123745845, 3545.0428384336083, 3554.608993010767, 661.9437347825392, 665.2981104934244, 669.6618207805027, 671.3890359772583, 688.1776277348521, 573.498189084551, 632.5983000794529, 718.3175982816346, 755.7770457714877, 760.6310939194486, 9746.171575416027, 10083.546240419051, 10086.848697269546, 10121.291509594404, 10739.248252622398, 634.1724050114644, 638.1608185236399, 644.2784081828382, 646.3697894552868, 647.6826355086068, 4611.953880461219, 4755.144074066632, 4794.7842347093765, 4819.108464933998, 4855.732934688555, 130674.34662826815, 132716.0, 133270.0, 137861.0, 141541.1691766159, 117438.0, 117982.0, 118024.0, 118752.0, 122515.3874230641, 60892.0, 61311.693441533396, 62167.68916155481, 64617.35382646207, 98708.50645746726, 8949.149830766068, 9059.36584439083, 9131.726048218565, 9521.666741664008, 10646.148308135485, 44148.33777493404, 45596.08807823758, 51494.485055148965, 51865.22202166895, 54246.45753542572, 77491.0, 78519.63640543075, 79147.60426197833, 82312.58843705982, 84542.57728711318, 13343.532976345781, 13396.397162127532, 14116.50592229267, 14120.576382708536, 14171.645708856948, 14730.2634868254, 14870.256487175382, 15927.0, 15935.12356820386, 16213.837861621705, 13592.252426116658, 14322.856771432153, 14525.128492290496, 14767.0, 16487.587810304838, 14818.703625927637, 15272.0, 15353.462628807938, 15641.687166256383, 16442.917785410995, 14537.418503260174, 14584.85415145835, 14734.410623574937, 15554.222288885285, 15565.14391708467, 12075.27548347102, 12187.695307617381, 12531.436085376363, 12881.35593220354, 13088.411021503865, 12679.175853569488, 12683.239005659321, 12717.427715752629, 12755.426005829575, 12938.223706577635], "value": 8011.576391486461, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1496.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 107.0, 110.0, 112.0, 111.0, 110.0, 110.0, 110.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 121.0, 139.0, 160.0, 121.0, 143.0, 151.0, 117.0, 175.0, 116.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 164.0, 163.0, 165.0, 163.0, 162.0, 163.0, 162.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 167.0, 76.0, 75.0, 79.0, 76.0, 165.0, 74.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 159.0, 84.0, 85.0, 83.0, 150.0, 83.0, 84.0, 144.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 119.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 150.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 51.0, 51.0, 50.0, 51.0, 51.0, 51.0, 51.0, 52.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 59.0, 61.0, 60.0, 59.0, 60.0, 60.0, 63.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 73.0, 71.0, 79.0, 73.0, 74.0, 72.0, 78.0, 72.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 115.0, 118.0, 118.0, 118.0, 121.0, 126.0, 118.0, 148.0, 129.0], "value": 123.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 153.0, 153.0, 155.0, 152.0, 153.0, 152.0, 158.0, 155.0, 157.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 62.0, 62.0, 64.0, 62.0, 62.0, 61.0, 60.0, 61.0], "value": 62.6, "unit": "score"}]}]} 10:32:37 INFO - Return code: 0 10:32:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:32:37 ERROR - # TBPL SUCCESS # 10:32:37 INFO - Running post-action listener: _resource_record_post_action 10:32:37 INFO - [mozharness: 2016-09-23 17:32:37.447191Z] Finished run-tests step (success) 10:32:37 INFO - Running post-run listener: _resource_record_post_run 10:32:37 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287797248; Read time: 12; Write time: 231916 10:32:37 INFO - TinderboxPrint: CPU usage
13.3% 10:32:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:32:37 INFO - TinderboxPrint: I/O write bytes / time
287,797,248 / 231,916 10:32:37 INFO - TinderboxPrint: CPU idle
8,215.3 (86.7%) 10:32:37 INFO - TinderboxPrint: CPU user
1,201.5 (12.7%) 10:32:37 INFO - TinderboxPrint: Swap in / out
0 / 0 10:32:37 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 71294976; Read time: 0; Write time: 51784 10:32:37 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 216502272; Read time: 0; Write time: 180132 10:32:38 INFO - Running post-run listener: _upload_blobber_files 10:32:38 INFO - Blob upload gear active. 10:32:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:32:38 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 10:32:38 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:32:38 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:32:38 INFO - (blobuploader) - INFO - Open directory for files ... 10:32:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:32:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:32:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:39 INFO - (blobuploader) - INFO - Done attempting. 10:32:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:32:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:32:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:42 INFO - (blobuploader) - INFO - Done attempting. 10:32:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:32:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:32:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:43 INFO - (blobuploader) - INFO - Done attempting. 10:32:43 INFO - (blobuploader) - INFO - Iteration through files over. 10:32:43 INFO - Return code: 0 10:32:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:32:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:32:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a28fae3775f075a9364456c4ce471a46d90a517635f71dcb7c873c6c4913a1b13cd42e1b0b08c94256414a8e59bbf60516fa397de296503ec66a442c6660d19f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c7f6123c933ea26a48243df083c415e9cb17f60e336d3f1c351372e1f444359ac9b18cbe1e0b940db8ab3d3e81d78a89656960fe5f9b8f86c6930e21fc9a7fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0070f6886fc6913804a1e53015fd5bd66153f2c910bfdf10c2570ec273c78c36048c190466fdf800ec110b10257f3c1ab0a15177d87bc8e4764ccc97d1d81979"} 10:32:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:32:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:32:43 INFO - Contents: 10:32:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a28fae3775f075a9364456c4ce471a46d90a517635f71dcb7c873c6c4913a1b13cd42e1b0b08c94256414a8e59bbf60516fa397de296503ec66a442c6660d19f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c7f6123c933ea26a48243df083c415e9cb17f60e336d3f1c351372e1f444359ac9b18cbe1e0b940db8ab3d3e81d78a89656960fe5f9b8f86c6930e21fc9a7fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0070f6886fc6913804a1e53015fd5bd66153f2c910bfdf10c2570ec273c78c36048c190466fdf800ec110b10257f3c1ab0a15177d87bc8e4764ccc97d1d81979"} 10:32:43 INFO - Running post-run listener: copy_logs_to_upload_dir 10:32:43 INFO - Copying logs to upload dir... 10:32:43 INFO - mkdir: /builds/slave/test/build/upload/logs 10:32:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1675.476021 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-09-23 10:32:42.817618) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 10:32:42.821795) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502 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-Beta/sha512/a28fae3775f075a9364456c4ce471a46d90a517635f71dcb7c873c6c4913a1b13cd42e1b0b08c94256414a8e59bbf60516fa397de296503ec66a442c6660d19f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c7f6123c933ea26a48243df083c415e9cb17f60e336d3f1c351372e1f444359ac9b18cbe1e0b940db8ab3d3e81d78a89656960fe5f9b8f86c6930e21fc9a7fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0070f6886fc6913804a1e53015fd5bd66153f2c910bfdf10c2570ec273c78c36048c190466fdf800ec110b10257f3c1ab0a15177d87bc8e4764ccc97d1d81979"} build_url:https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/JPFHz9BDRDK5PFEmjlcpKQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a28fae3775f075a9364456c4ce471a46d90a517635f71dcb7c873c6c4913a1b13cd42e1b0b08c94256414a8e59bbf60516fa397de296503ec66a442c6660d19f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c7f6123c933ea26a48243df083c415e9cb17f60e336d3f1c351372e1f444359ac9b18cbe1e0b940db8ab3d3e81d78a89656960fe5f9b8f86c6930e21fc9a7fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0070f6886fc6913804a1e53015fd5bd66153f2c910bfdf10c2570ec273c78c36048c190466fdf800ec110b10257f3c1ab0a15177d87bc8e4764ccc97d1d81979"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 10:32:42.854747) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 10:32:42.855097) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1474650205.443425-1161826502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 10:32:42.937261) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 10:32:42.937953) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 10:32:42.938598) ========= ========= Total master_lag: 0.16 =========