builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1471297451.71 results: success (0) buildid: 20160815115416 builduid: ab4a40b9db484a3abbb7d4d5046b52a7 revision: 65f69c19b3c703615572e2d570e8eab34b18b8ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 14:44:11.712810) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 14:44:11.713290) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 14:44:11.713561) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 14:44:11.728237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 14:44:11.728604) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-15 14:44:11-- 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% 224M=0s 2016-08-15 14:44:11 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102175 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 14:44:11.844591) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 14:44:11.844897) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020162 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 14:44:11.894099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 14:44:11.894464) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 65f69c19b3c703615572e2d570e8eab34b18b8ea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 65f69c19b3c703615572e2d570e8eab34b18b8ea --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=6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-15 14:44:11,988 truncating revision to first 12 chars 2016-08-15 14:44:11,989 Setting DEBUG logging. 2016-08-15 14:44:11,989 attempt 1/10 2016-08-15 14:44:11,989 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/65f69c19b3c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-15 14:44:12,686 unpacking tar archive at: mozilla-aurora-65f69c19b3c7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.041274 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 14:44:12.951419) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 14:44:12.951740) ========= script_repo_revision: 65f69c19b3c703615572e2d570e8eab34b18b8ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 14:44:12.952126) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 14:44:12.952403) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 14:44:12.962610) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-08-15 14:44:12.962973) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:44:13 INFO - MultiFileLogger online at 20160815 14:44:13 in /builds/slave/test 14:44:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:44:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:44:13 INFO - {'append_to_log': False, 14:44:13 INFO - 'base_work_dir': '/builds/slave/test', 14:44:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:44:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:44:13 INFO - 'branch': 'Mozilla-Aurora', 14:44:13 INFO - 'buildbot_json_path': 'buildprops.json', 14:44:13 INFO - 'config_files': ('talos/linux_config.py',), 14:44:13 INFO - 'default_actions': ('clobber', 14:44:13 INFO - 'read-buildbot-config', 14:44:13 INFO - 'download-and-extract', 14:44:13 INFO - 'populate-webroot', 14:44:13 INFO - 'create-virtualenv', 14:44:13 INFO - 'install', 14:44:13 INFO - 'run-tests'), 14:44:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:44:13 INFO - 'download_minidump_stackwalk': True, 14:44:13 INFO - 'download_symbols': 'ondemand', 14:44:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:44:13 INFO - 'tooltool.py': '/tools/tooltool.py', 14:44:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:44:13 INFO - '/tools/misc-python/virtualenv.py')}, 14:44:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:44:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:44:13 INFO - 'installer_path': 'installer.exe', 14:44:13 INFO - 'log_level': 'info', 14:44:13 INFO - 'log_name': 'talos', 14:44:13 INFO - 'log_to_console': True, 14:44:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:44:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:44:13 INFO - 'opt_config_files': (), 14:44:13 INFO - 'pip_index': False, 14:44:13 INFO - 'sps_profile': False, 14:44:13 INFO - 'sps_profile_interval': 0, 14:44:13 INFO - 'suite': 'dromaeojs-e10s', 14:44:13 INFO - 'system_bits': '32', 14:44:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:44:13 INFO - 'title': 'talos-linux64-ix-023', 14:44:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:44:13 INFO - 'use_talos_json': True, 14:44:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:44:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:44:13 INFO - 'work_dir': 'build'} 14:44:13 INFO - [mozharness: 2016-08-15 21:44:13.153929Z] Running clobber step. 14:44:13 INFO - Running pre-action listener: _resource_record_pre_action 14:44:13 INFO - Running main action method: clobber 14:44:13 INFO - rmtree: /builds/slave/test/build 14:44:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:44:13 INFO - Running post-action listener: _resource_record_post_action 14:44:13 INFO - [mozharness: 2016-08-15 21:44:13.610468Z] Finished clobber step (success) 14:44:13 INFO - [mozharness: 2016-08-15 21:44:13.610569Z] Running read-buildbot-config step. 14:44:13 INFO - Running pre-action listener: _resource_record_pre_action 14:44:13 INFO - Running main action method: read_buildbot_config 14:44:13 INFO - Using buildbot properties: 14:44:13 INFO - { 14:44:13 INFO - "project": "", 14:44:13 INFO - "product": "firefox", 14:44:13 INFO - "script_repo_revision": "production", 14:44:13 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 14:44:13 INFO - "repository": "", 14:44:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 14:44:13 INFO - "buildid": "20160815115416", 14:44:13 INFO - "pgo_build": "True", 14:44:13 INFO - "basedir": "/builds/slave/test", 14:44:13 INFO - "buildnumber": 464, 14:44:13 INFO - "slavename": "talos-linux64-ix-023", 14:44:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:44:13 INFO - "platform": "ubuntu64_hw", 14:44:13 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:44:13 INFO - "branch": "mozilla-aurora", 14:44:13 INFO - "repo_path": "releases/mozilla-aurora", 14:44:13 INFO - "revision": "65f69c19b3c703615572e2d570e8eab34b18b8ea", 14:44:13 INFO - "stage_platform": "linux64-pgo", 14:44:13 INFO - "builduid": "ab4a40b9db484a3abbb7d4d5046b52a7", 14:44:13 INFO - "slavebuilddir": "test" 14:44:13 INFO - } 14:44:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 14:44:13 INFO - Running post-action listener: _resource_record_post_action 14:44:13 INFO - [mozharness: 2016-08-15 21:44:13.612987Z] Finished read-buildbot-config step (success) 14:44:13 INFO - [mozharness: 2016-08-15 21:44:13.613074Z] Running download-and-extract step. 14:44:13 INFO - Running pre-action listener: _resource_record_pre_action 14:44:13 INFO - Running main action method: download_and_extract 14:44:13 INFO - mkdir: /builds/slave/test/build/tests 14:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:44:13 INFO - https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:44:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:44:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:44:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:44:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:44:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:44:13 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:44:13 INFO - retry: Failed, sleeping 30 seconds before retrying 14:44:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 14:44:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:44:43 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:44:43 INFO - retry: Failed, sleeping 60 seconds before retrying 14:45:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 14:45:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:45:43 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:45:43 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 14:45:43 INFO - Caught exception: HTTP Error 404: Not Found 14:45:43 INFO - Caught exception: HTTP Error 404: Not Found 14:45:43 INFO - Caught exception: HTTP Error 404: Not Found 14:45:43 INFO - trying https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:45:43 INFO - Downloading https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:45:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:45:44 INFO - Downloaded 1361 bytes. 14:45:44 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:45:44 INFO - Using the following test package requirements: 14:45:44 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 14:45:44 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:45:44 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:45:44 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:45:44 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:45:44 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:45:44 INFO - u'jsshell-linux-x86_64.zip'], 14:45:44 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:45:44 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:45:44 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 14:45:44 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:45:44 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:45:44 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:45:44 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:45:44 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:45:44 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:45:44 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:45:44 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:45:44 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:44 INFO - https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:45:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:45:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:45:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:45:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:45:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:45:44 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:45:44 INFO - retry: Failed, sleeping 30 seconds before retrying 14:46:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 14:46:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:46:14 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:46:14 INFO - retry: Failed, sleeping 60 seconds before retrying 14:47:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 14:47:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:47:14 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:47:14 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 14:47:14 INFO - Caught exception: HTTP Error 404: Not Found 14:47:14 INFO - Caught exception: HTTP Error 404: Not Found 14:47:14 INFO - Caught exception: HTTP Error 404: Not Found 14:47:14 INFO - trying https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:47:14 INFO - Downloading https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:47:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:47:15 INFO - Downloaded 21766514 bytes. 14:47:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:47:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:47:16 INFO - Return code: 0 14:47:16 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:16 INFO - https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:47:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:47:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:47:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:47:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:47:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:47:16 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:47:16 INFO - retry: Failed, sleeping 30 seconds before retrying 14:47:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 14:47:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:47:46 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:47:46 INFO - retry: Failed, sleeping 60 seconds before retrying 14:48:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 14:48:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:48:46 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:48:46 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 14:48:46 INFO - Caught exception: HTTP Error 404: Not Found 14:48:46 INFO - Caught exception: HTTP Error 404: Not Found 14:48:46 INFO - Caught exception: HTTP Error 404: Not Found 14:48:46 INFO - trying https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:48:46 INFO - Downloading https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:48:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:48:47 INFO - Downloaded 21766514 bytes. 14:48:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:48:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:48:48 INFO - Return code: 0 14:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:48 INFO - https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:48:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:48:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:48:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:48:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:48:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:48:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:48:48 INFO - retry: Failed, sleeping 30 seconds before retrying 14:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 14:49:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:49:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:49:18 INFO - retry: Failed, sleeping 60 seconds before retrying 14:50:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 14:50:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:50:18 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:50:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 14:50:18 INFO - Caught exception: HTTP Error 404: Not Found 14:50:18 INFO - Caught exception: HTTP Error 404: Not Found 14:50:18 INFO - Caught exception: HTTP Error 404: Not Found 14:50:18 INFO - trying https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:50:18 INFO - Downloading https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:50:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:50:20 INFO - Downloaded 14413723 bytes. 14:50:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:50:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:50:21 INFO - Return code: 0 14:50:21 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')]} 14:50:21 INFO - https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:50:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:50:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:50:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:50:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:50:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:50:21 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:50:21 INFO - retry: Failed, sleeping 30 seconds before retrying 14:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 14:50:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:50:51 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:50:51 INFO - retry: Failed, sleeping 60 seconds before retrying 14:51:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 14:51:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:51:51 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:51:51 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 14:51:51 INFO - Caught exception: HTTP Error 404: Not Found 14:51:51 INFO - Caught exception: HTTP Error 404: Not Found 14:51:51 INFO - Caught exception: HTTP Error 404: Not Found 14:51:51 INFO - trying https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:51:51 INFO - Downloading https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:51:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:51:52 INFO - Downloaded 63754371 bytes. 14:51:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:51:52 INFO - mkdir: /builds/slave/test/properties 14:51:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:51:52 INFO - Writing to file /builds/slave/test/properties/build_url 14:51:52 INFO - Contents: 14:51:52 INFO - build_url:https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:51:53 INFO - Running post-action listener: _resource_record_post_action 14:51:53 INFO - Running post-action listener: set_extra_try_arguments 14:51:53 INFO - [mozharness: 2016-08-15 21:51:53.280092Z] Finished download-and-extract step (success) 14:51:53 INFO - [mozharness: 2016-08-15 21:51:53.280324Z] Running populate-webroot step. 14:51:53 INFO - Running pre-action listener: _resource_record_pre_action 14:51:53 INFO - Running main action method: populate_webroot 14:51:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:51:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:51:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:51:53 INFO - '--tppagecycles', 14:51:53 INFO - '7'], 14:51:53 INFO - 'tests': ['tsvgm']}}, 14:51:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:51:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:51:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:51:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:51:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:51:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:51:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:53 INFO - 'talos_options': ['--disable-e10s'], 14:51:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:53 INFO - 'talos_options': ['--disable-e10s'], 14:51:53 INFO - 'tests': ['damp', 'tps']}, 14:51:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:53 INFO - 'tests': ['damp', 'tps']}, 14:51:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:51:53 INFO - 'tests': ['dromaeo_dom']}, 14:51:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:51:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:51:53 INFO - 'tests': ['basic_compositor_video']}, 14:51:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:51:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:51:53 INFO - 'tests': ['a11yr', 14:51:53 INFO - 'ts_paint', 14:51:53 INFO - 'tpaint', 14:51:53 INFO - 'sessionrestore', 14:51:53 INFO - 'sessionrestore_no_auto_restore', 14:51:53 INFO - 'tabpaint']}, 14:51:53 INFO - 'other-e10s': {'tests': ['a11yr', 14:51:53 INFO - 'ts_paint', 14:51:53 INFO - 'tpaint', 14:51:53 INFO - 'sessionrestore', 14:51:53 INFO - 'sessionrestore_no_auto_restore', 14:51:53 INFO - 'tabpaint']}, 14:51:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:51:53 INFO - 'ts_paint', 14:51:53 INFO - 'tpaint', 14:51:53 INFO - 'sessionrestore', 14:51:53 INFO - 'sessionrestore_no_auto_restore', 14:51:53 INFO - 'tabpaint']}, 14:51:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:51:53 INFO - 'ts_paint', 14:51:53 INFO - 'tpaint', 14:51:53 INFO - 'sessionrestore', 14:51:53 INFO - 'sessionrestore_no_auto_restore', 14:51:53 INFO - 'tabpaint']}, 14:51:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:51:53 INFO - 'tests': ['a11yr', 14:51:53 INFO - 'ts_paint', 14:51:53 INFO - 'tpaint', 14:51:53 INFO - 'sessionrestore', 14:51:53 INFO - 'sessionrestore_no_auto_restore', 14:51:53 INFO - 'tabpaint']}, 14:51:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:51:53 INFO - 'tests': ['a11yr', 14:51:53 INFO - 'ts_paint', 14:51:53 INFO - 'tpaint', 14:51:53 INFO - 'sessionrestore', 14:51:53 INFO - 'sessionrestore_no_auto_restore', 14:51:53 INFO - 'tabpaint']}, 14:51:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:51:53 INFO - 'tests': ['tsvgx', 14:51:53 INFO - 'tsvgr_opacity', 14:51:53 INFO - 'tart', 14:51:53 INFO - 'tscrollx', 14:51:53 INFO - 'cart']}, 14:51:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:51:53 INFO - 'tsvgr_opacity', 14:51:53 INFO - 'tart', 14:51:53 INFO - 'tscrollx', 14:51:53 INFO - 'cart']}, 14:51:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:53 INFO - 'talos_options': ['--disable-e10s'], 14:51:53 INFO - 'tests': ['tp5o']}, 14:51:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:53 INFO - 'tests': ['tp5o']}, 14:51:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:53 INFO - 'talos_options': ['--disable-e10s', 14:51:53 INFO - '--xperf_path', 14:51:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:53 INFO - 'tests': ['tp5n']}, 14:51:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:53 INFO - 'talos_options': ['--xperf_path', 14:51:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:53 INFO - 'tests': ['tp5n']}}, 14:51:53 INFO - 'talos.zip': {'path': '', 14:51:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:51:53 INFO - Running post-action listener: _resource_record_post_action 14:51:53 INFO - [mozharness: 2016-08-15 21:51:53.301915Z] Finished populate-webroot step (success) 14:51:53 INFO - [mozharness: 2016-08-15 21:51:53.302004Z] Running create-virtualenv step. 14:51:53 INFO - Running pre-action listener: _resource_record_pre_action 14:51:53 INFO - Running main action method: create_virtualenv 14:51:53 INFO - Creating virtualenv /builds/slave/test/build/venv 14:51:53 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 14:51:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:51:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:51:53 INFO - Using real prefix '/usr' 14:51:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:51:53 INFO - Installing distribute.............................................................................................................................................................................................done. 14:51:55 INFO - Installing pip.................done. 14:51:55 INFO - Return code: 0 14:51:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e570>, '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 0x239f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239f900>, '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': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', '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 14:51:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:51:55 INFO - Using env: {'DISPLAY': ':0', 14:51:55 INFO - 'HOME': '/home/cltbld', 14:51:55 INFO - 'LANG': 'en_US.UTF-8', 14:51:55 INFO - 'LANGUAGE': 'en_US:en', 14:51:55 INFO - 'LOGNAME': 'cltbld', 14:51:55 INFO - 'MAIL': '/var/mail/cltbld', 14:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:55 INFO - 'MOZ_NO_REMOTE': '1', 14:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:55 INFO - 'NO_EM_RESTART': '1', 14:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:55 INFO - 'PWD': '/builds/slave/test', 14:51:55 INFO - 'SHELL': '/bin/bash', 14:51:55 INFO - 'SHLVL': '1', 14:51:55 INFO - 'TERM': 'linux', 14:51:55 INFO - 'TMOUT': '86400', 14:51:55 INFO - 'USER': 'cltbld', 14:51:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', 14:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:55 INFO - '_': '/tools/buildbot/bin/python'} 14:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:56 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 14:51:56 INFO - Cleaning up... 14:51:56 INFO - Return code: 0 14:51:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:51: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')]} 14:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:56 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 0x20e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e570>, '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 0x239f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239f900>, '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': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', '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 14:51:56 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 14:51:56 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 14:51:56 INFO - Using env: {'DISPLAY': ':0', 14:51:56 INFO - 'HOME': '/home/cltbld', 14:51:56 INFO - 'LANG': 'en_US.UTF-8', 14:51:56 INFO - 'LANGUAGE': 'en_US:en', 14:51:56 INFO - 'LOGNAME': 'cltbld', 14:51:56 INFO - 'MAIL': '/var/mail/cltbld', 14:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:56 INFO - 'MOZ_NO_REMOTE': '1', 14:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:56 INFO - 'NO_EM_RESTART': '1', 14:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:56 INFO - 'PWD': '/builds/slave/test', 14:51:56 INFO - 'SHELL': '/bin/bash', 14:51:56 INFO - 'SHLVL': '1', 14:51:56 INFO - 'TERM': 'linux', 14:51:56 INFO - 'TMOUT': '86400', 14:51:56 INFO - 'USER': 'cltbld', 14:51:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', 14:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:56 INFO - '_': '/tools/buildbot/bin/python'} 14:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:56 INFO - Downloading/unpacking psutil>=3.1.1 14:51:56 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 14:51:56 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 14:51:56 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 14:51:56 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 14:51:56 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 14:51:56 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 14:51:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:51:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:58 INFO - Installing collected packages: psutil 14:51:58 INFO - Running setup.py install for psutil 14:51:58 INFO - building 'psutil._psutil_linux' extension 14:51:58 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 14:51:58 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 14:51:58 INFO - building 'psutil._psutil_posix' extension 14:51:58 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 14:51:58 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 14:51:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:58 INFO - Successfully installed psutil 14:51:58 INFO - Cleaning up... 14:51:58 INFO - Return code: 0 14:51:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:51:58 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')]} 14:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:58 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')]} 14:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:58 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 0x20e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e570>, '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 0x239f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239f900>, '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': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', '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 14:51:58 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 14:51:58 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 14:51:58 INFO - Using env: {'DISPLAY': ':0', 14:51:58 INFO - 'HOME': '/home/cltbld', 14:51:58 INFO - 'LANG': 'en_US.UTF-8', 14:51:58 INFO - 'LANGUAGE': 'en_US:en', 14:51:58 INFO - 'LOGNAME': 'cltbld', 14:51:58 INFO - 'MAIL': '/var/mail/cltbld', 14:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:58 INFO - 'MOZ_NO_REMOTE': '1', 14:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:58 INFO - 'NO_EM_RESTART': '1', 14:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:58 INFO - 'PWD': '/builds/slave/test', 14:51:58 INFO - 'SHELL': '/bin/bash', 14:51:58 INFO - 'SHLVL': '1', 14:51:58 INFO - 'TERM': 'linux', 14:51:58 INFO - 'TMOUT': '86400', 14:51:58 INFO - 'USER': 'cltbld', 14:51:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', 14:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:58 INFO - '_': '/tools/buildbot/bin/python'} 14:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:52:01 INFO - Installing collected packages: mozsystemmonitor 14:52:01 INFO - Running setup.py install for mozsystemmonitor 14:52:01 INFO - Successfully installed mozsystemmonitor 14:52:01 INFO - Cleaning up... 14:52:01 INFO - Return code: 0 14:52:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:52:01 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')]} 14:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:01 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')]} 14:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:01 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 0x20e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e570>, '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 0x239f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239f900>, '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': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', '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 14:52:01 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 14:52:01 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 14:52:01 INFO - Using env: {'DISPLAY': ':0', 14:52:01 INFO - 'HOME': '/home/cltbld', 14:52:01 INFO - 'LANG': 'en_US.UTF-8', 14:52:01 INFO - 'LANGUAGE': 'en_US:en', 14:52:01 INFO - 'LOGNAME': 'cltbld', 14:52:01 INFO - 'MAIL': '/var/mail/cltbld', 14:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:01 INFO - 'MOZ_NO_REMOTE': '1', 14:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:01 INFO - 'NO_EM_RESTART': '1', 14:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:01 INFO - 'PWD': '/builds/slave/test', 14:52:01 INFO - 'SHELL': '/bin/bash', 14:52:01 INFO - 'SHLVL': '1', 14:52:01 INFO - 'TERM': 'linux', 14:52:01 INFO - 'TMOUT': '86400', 14:52:01 INFO - 'USER': 'cltbld', 14:52:01 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', 14:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:01 INFO - '_': '/tools/buildbot/bin/python'} 14:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:01 INFO - Downloading/unpacking jsonschema==2.5.1 14:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:52:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:52:03 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 14:52:03 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 14:52:03 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 14:52:03 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 14:52:03 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 14:52:03 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 14:52:03 INFO - Downloading functools32-3.2.3-2.tar.gz 14:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:52:03 INFO - warning: no files found matching '*.txt' 14:52:03 INFO - no previously-included directories found matching 'build' 14:52:03 INFO - no previously-included directories found matching 'dist' 14:52:03 INFO - no previously-included directories found matching '.git*' 14:52:03 INFO - Installing collected packages: jsonschema, functools32 14:52:03 INFO - Running setup.py install for functools32 14:52:03 INFO - warning: no files found matching '*.txt' 14:52:03 INFO - no previously-included directories found matching 'build' 14:52:03 INFO - no previously-included directories found matching 'dist' 14:52:03 INFO - no previously-included directories found matching '.git*' 14:52:03 INFO - Successfully installed jsonschema functools32 14:52:03 INFO - Cleaning up... 14:52:03 INFO - Return code: 0 14:52:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:03 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 0x20e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e570>, '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 0x239f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239f900>, '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': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', '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 14:52:03 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 14:52:03 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 14:52:03 INFO - Using env: {'DISPLAY': ':0', 14:52:03 INFO - 'HOME': '/home/cltbld', 14:52:03 INFO - 'LANG': 'en_US.UTF-8', 14:52:03 INFO - 'LANGUAGE': 'en_US:en', 14:52:03 INFO - 'LOGNAME': 'cltbld', 14:52:03 INFO - 'MAIL': '/var/mail/cltbld', 14:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:03 INFO - 'MOZ_NO_REMOTE': '1', 14:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:03 INFO - 'NO_EM_RESTART': '1', 14:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:03 INFO - 'PWD': '/builds/slave/test', 14:52:03 INFO - 'SHELL': '/bin/bash', 14:52:03 INFO - 'SHLVL': '1', 14:52:03 INFO - 'TERM': 'linux', 14:52:03 INFO - 'TMOUT': '86400', 14:52:03 INFO - 'USER': 'cltbld', 14:52:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', 14:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:03 INFO - '_': '/tools/buildbot/bin/python'} 14:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:52:03 INFO - Cleaning up... 14:52:03 INFO - Return code: 0 14:52:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52: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')]} 14:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:04 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 0x20e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e570>, '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 0x239f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239f900>, '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': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', '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 14:52:04 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 14:52:04 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 14:52:04 INFO - Using env: {'DISPLAY': ':0', 14:52:04 INFO - 'HOME': '/home/cltbld', 14:52:04 INFO - 'LANG': 'en_US.UTF-8', 14:52:04 INFO - 'LANGUAGE': 'en_US:en', 14:52:04 INFO - 'LOGNAME': 'cltbld', 14:52:04 INFO - 'MAIL': '/var/mail/cltbld', 14:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:04 INFO - 'MOZ_NO_REMOTE': '1', 14:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:04 INFO - 'NO_EM_RESTART': '1', 14:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:04 INFO - 'PWD': '/builds/slave/test', 14:52:04 INFO - 'SHELL': '/bin/bash', 14:52:04 INFO - 'SHLVL': '1', 14:52:04 INFO - 'TERM': 'linux', 14:52:04 INFO - 'TMOUT': '86400', 14:52:04 INFO - 'USER': 'cltbld', 14:52:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', 14:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:04 INFO - '_': '/tools/buildbot/bin/python'} 14:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:04 INFO - Downloading/unpacking blobuploader==1.2.4 14:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:06 INFO - Downloading blobuploader-1.2.4.tar.gz 14:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:52:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:52:06 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 14:52:06 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 14:52:06 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 14:52:06 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 14:52:06 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 14:52:06 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 14:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:52:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:52:06 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 14:52:06 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 14:52:06 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 14:52:06 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 14:52:06 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 14:52:06 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 14:52:06 INFO - Downloading docopt-0.6.1.tar.gz 14:52:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:52:07 INFO - Installing collected packages: blobuploader, requests, docopt 14:52:07 INFO - Running setup.py install for blobuploader 14:52:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:52:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:52:07 INFO - Running setup.py install for requests 14:52:07 INFO - Running setup.py install for docopt 14:52:07 INFO - Successfully installed blobuploader requests docopt 14:52:07 INFO - Cleaning up... 14:52:07 INFO - Return code: 0 14:52:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:52:07 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')]} 14:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:07 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')]} 14:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:07 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 0x20e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e570>, '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 0x239f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239f900>, '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': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', '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 14:52:07 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 14:52:07 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 14:52:07 INFO - Using env: {'DISPLAY': ':0', 14:52:07 INFO - 'HOME': '/home/cltbld', 14:52:07 INFO - 'LANG': 'en_US.UTF-8', 14:52:07 INFO - 'LANGUAGE': 'en_US:en', 14:52:07 INFO - 'LOGNAME': 'cltbld', 14:52:07 INFO - 'MAIL': '/var/mail/cltbld', 14:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:07 INFO - 'MOZ_NO_REMOTE': '1', 14:52:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:07 INFO - 'NO_EM_RESTART': '1', 14:52:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:07 INFO - 'PWD': '/builds/slave/test', 14:52:07 INFO - 'SHELL': '/bin/bash', 14:52:07 INFO - 'SHLVL': '1', 14:52:07 INFO - 'TERM': 'linux', 14:52:07 INFO - 'TMOUT': '86400', 14:52:07 INFO - 'USER': 'cltbld', 14:52:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', 14:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:07 INFO - '_': '/tools/buildbot/bin/python'} 14:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:52:07 INFO - Running setup.py (path:/tmp/pip-R447Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:52:07 INFO - Running setup.py (path:/tmp/pip-UMpoyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:52:08 INFO - Running setup.py (path:/tmp/pip-9EMe66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:52:08 INFO - Running setup.py (path:/tmp/pip-zd6fMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:52:08 INFO - Running setup.py (path:/tmp/pip-VyjHrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:52:08 INFO - Running setup.py (path:/tmp/pip-Mp8hov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:52:08 INFO - Running setup.py (path:/tmp/pip-J3AB0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:52:08 INFO - Running setup.py (path:/tmp/pip-Z7vFWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:52:08 INFO - Running setup.py (path:/tmp/pip-d_7_qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:52:08 INFO - Running setup.py (path:/tmp/pip-oLPaIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:52:08 INFO - Running setup.py (path:/tmp/pip-u50FQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:52:08 INFO - Running setup.py (path:/tmp/pip-Q326HQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:52:08 INFO - Running setup.py (path:/tmp/pip-njzHJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:52:08 INFO - Running setup.py (path:/tmp/pip-QzuUr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:08 INFO - Running setup.py (path:/tmp/pip-e7gnuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:52:08 INFO - Running setup.py (path:/tmp/pip-j6jncG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:52:09 INFO - Running setup.py (path:/tmp/pip-MZtpQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:52:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:52:09 INFO - Running setup.py install for manifestparser 14:52:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:52:09 INFO - Running setup.py install for mozcrash 14:52:09 INFO - Running setup.py install for mozdebug 14:52:09 INFO - Running setup.py install for mozdevice 14:52:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:52:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:52:09 INFO - Running setup.py install for mozfile 14:52:09 INFO - Running setup.py install for mozhttpd 14:52:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:52:09 INFO - Running setup.py install for mozinfo 14:52:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:52:09 INFO - Running setup.py install for mozInstall 14:52:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:52:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:52:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:52:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:52:09 INFO - Running setup.py install for mozleak 14:52:10 INFO - Running setup.py install for mozlog 14:52:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:52:10 INFO - Running setup.py install for moznetwork 14:52:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:52:10 INFO - Running setup.py install for mozprocess 14:52:10 INFO - Running setup.py install for mozprofile 14:52:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:52:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:52:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:52:10 INFO - Running setup.py install for mozrunner 14:52:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:52:10 INFO - Running setup.py install for mozscreenshot 14:52:10 INFO - Running setup.py install for moztest 14:52:10 INFO - Running setup.py install for mozversion 14:52:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:52:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:52:10 INFO - Cleaning up... 14:52:10 INFO - Return code: 0 14:52:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:10 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 0x20e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e570>, '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 0x239f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239f900>, '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': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', '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 14:52:10 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 14:52:10 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 14:52:10 INFO - Using env: {'DISPLAY': ':0', 14:52:10 INFO - 'HOME': '/home/cltbld', 14:52:10 INFO - 'LANG': 'en_US.UTF-8', 14:52:10 INFO - 'LANGUAGE': 'en_US:en', 14:52:10 INFO - 'LOGNAME': 'cltbld', 14:52:10 INFO - 'MAIL': '/var/mail/cltbld', 14:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:10 INFO - 'MOZ_NO_REMOTE': '1', 14:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:10 INFO - 'NO_EM_RESTART': '1', 14:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:10 INFO - 'PWD': '/builds/slave/test', 14:52:10 INFO - 'SHELL': '/bin/bash', 14:52:10 INFO - 'SHLVL': '1', 14:52:10 INFO - 'TERM': 'linux', 14:52:10 INFO - 'TMOUT': '86400', 14:52:10 INFO - 'USER': 'cltbld', 14:52:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', 14:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:10 INFO - '_': '/tools/buildbot/bin/python'} 14:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:52:11 INFO - Running setup.py (path:/tmp/pip-1sFrmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:52:11 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)) 14:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:52:11 INFO - Running setup.py (path:/tmp/pip-ieMmxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:52:11 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)) 14:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:52:11 INFO - Running setup.py (path:/tmp/pip-mEptEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:52:11 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)) 14:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:52:11 INFO - Running setup.py (path:/tmp/pip-Awlito-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:52:11 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)) 14:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:52:11 INFO - Running setup.py (path:/tmp/pip-YzBDcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:52:11 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)) 14:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:52:11 INFO - Running setup.py (path:/tmp/pip-dTI0_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:52:11 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)) 14:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:52:11 INFO - Running setup.py (path:/tmp/pip-9bnu9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:52:11 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)) 14:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:52:11 INFO - Running setup.py (path:/tmp/pip-Pp9CoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:52:11 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)) 14:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:52:11 INFO - Running setup.py (path:/tmp/pip-6wWlVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:52:11 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)) 14:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:52:11 INFO - Running setup.py (path:/tmp/pip-ZowYak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:52:11 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)) 14:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:52:11 INFO - Running setup.py (path:/tmp/pip-S7Jg_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:52:11 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)) 14:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:52:11 INFO - Running setup.py (path:/tmp/pip-s0ASWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:52:12 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)) 14:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:52:12 INFO - Running setup.py (path:/tmp/pip-Gj2V1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:52:12 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)) 14:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:52:12 INFO - Running setup.py (path:/tmp/pip-2gqeBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:52:12 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)) 14:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:12 INFO - Running setup.py (path:/tmp/pip-vqZFEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:12 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)) 14:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:52:12 INFO - Running setup.py (path:/tmp/pip-zrJsJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:52:12 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)) 14:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:52:12 INFO - Running setup.py (path:/tmp/pip-eylDv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:52:12 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)) 14:52:12 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)) 14:52:12 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)) 14:52:12 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)) 14:52:12 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)) 14:52:12 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)) 14:52:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:52:12 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 14:52:12 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 14:52:12 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 14:52:12 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 14:52:12 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 14:52:12 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 14:52:14 INFO - Downloading blessings-1.6.tar.gz 14:52:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:52:14 INFO - Installing collected packages: blessings 14:52:14 INFO - Running setup.py install for blessings 14:52:14 INFO - Successfully installed blessings 14:52:14 INFO - Cleaning up... 14:52:14 INFO - Return code: 0 14:52:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:52:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:52:14 INFO - Reading from file tmpfile_stdout 14:52:14 INFO - Current package versions: 14:52:14 INFO - argparse == 1.2.1 14:52:14 INFO - blessings == 1.6 14:52:14 INFO - blobuploader == 1.2.4 14:52:14 INFO - docopt == 0.6.1 14:52:14 INFO - functools32 == 3.2.3-2 14:52:14 INFO - jsonschema == 2.5.1 14:52:14 INFO - manifestparser == 1.1 14:52:14 INFO - mozInstall == 1.12 14:52:14 INFO - mozcrash == 0.17 14:52:14 INFO - mozdebug == 0.1 14:52:14 INFO - mozdevice == 0.48 14:52:14 INFO - mozfile == 1.2 14:52:14 INFO - mozhttpd == 0.7 14:52:14 INFO - mozinfo == 0.9 14:52:14 INFO - mozleak == 0.1 14:52:14 INFO - mozlog == 3.3 14:52:14 INFO - moznetwork == 0.27 14:52:14 INFO - mozprocess == 0.23 14:52:14 INFO - mozprofile == 0.28 14:52:14 INFO - mozrunner == 6.12 14:52:14 INFO - mozscreenshot == 0.1 14:52:14 INFO - mozsystemmonitor == 0.3 14:52:14 INFO - moztest == 0.7 14:52:14 INFO - mozversion == 1.4 14:52:14 INFO - psutil == 3.1.1 14:52:14 INFO - requests == 1.2.3 14:52:14 INFO - wsgiref == 0.1.2 14:52:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:52:14 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')]} 14:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:14 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')]} 14:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:14 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 0x20e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e570>, '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 0x239f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239f900>, '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': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', '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 14:52:14 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 14:52:14 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 14:52:14 INFO - Using env: {'DISPLAY': ':0', 14:52:14 INFO - 'HOME': '/home/cltbld', 14:52:14 INFO - 'LANG': 'en_US.UTF-8', 14:52:14 INFO - 'LANGUAGE': 'en_US:en', 14:52:14 INFO - 'LOGNAME': 'cltbld', 14:52:14 INFO - 'MAIL': '/var/mail/cltbld', 14:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:14 INFO - 'MOZ_NO_REMOTE': '1', 14:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:14 INFO - 'NO_EM_RESTART': '1', 14:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:14 INFO - 'PWD': '/builds/slave/test', 14:52:14 INFO - 'SHELL': '/bin/bash', 14:52:14 INFO - 'SHLVL': '1', 14:52:14 INFO - 'TERM': 'linux', 14:52:14 INFO - 'TMOUT': '86400', 14:52:14 INFO - 'USER': 'cltbld', 14:52:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', 14:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:14 INFO - '_': '/tools/buildbot/bin/python'} 14:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:14 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)) 14:52:14 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)) 14:52:14 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)) 14:52:14 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)) 14:52:14 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)) 14:52:14 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)) 14:52:14 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)) 14:52:14 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)) 14:52:14 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)) 14:52:14 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)) 14:52:14 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)) 14:52:14 INFO - Cleaning up... 14:52:14 INFO - Return code: 0 14:52:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:52:14 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')]} 14:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:14 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')]} 14:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:14 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 0x20e0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e570>, '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 0x239f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239f900>, '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': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', '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 14:52:14 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 14:52:14 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 14:52:14 INFO - Using env: {'DISPLAY': ':0', 14:52:14 INFO - 'HOME': '/home/cltbld', 14:52:14 INFO - 'LANG': 'en_US.UTF-8', 14:52:14 INFO - 'LANGUAGE': 'en_US:en', 14:52:14 INFO - 'LOGNAME': 'cltbld', 14:52:14 INFO - 'MAIL': '/var/mail/cltbld', 14:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:14 INFO - 'MOZ_NO_REMOTE': '1', 14:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:14 INFO - 'NO_EM_RESTART': '1', 14:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:14 INFO - 'PWD': '/builds/slave/test', 14:52:14 INFO - 'SHELL': '/bin/bash', 14:52:14 INFO - 'SHLVL': '1', 14:52:14 INFO - 'TERM': 'linux', 14:52:14 INFO - 'TMOUT': '86400', 14:52:14 INFO - 'USER': 'cltbld', 14:52:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', 14:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:14 INFO - '_': '/tools/buildbot/bin/python'} 14:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:52:15 INFO - Cleaning up... 14:52:15 INFO - Return code: 0 14:52:15 INFO - Running post-action listener: _resource_record_post_action 14:52:15 INFO - Running post-action listener: _start_resource_monitoring 14:52:15 INFO - Starting resource monitoring. 14:52:15 INFO - [mozharness: 2016-08-15 21:52:15.230604Z] Finished create-virtualenv step (success) 14:52:15 INFO - [mozharness: 2016-08-15 21:52:15.231040Z] Running install step. 14:52:15 INFO - Running pre-action listener: _resource_record_pre_action 14:52:15 INFO - Running main action method: install 14:52:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:52:15 INFO - Reading from file tmpfile_stdout 14:52:15 INFO - Detecting whether we're running mozinstall >=1.0... 14:52:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:52:15 INFO - Reading from file tmpfile_stdout 14:52:15 INFO - Output received: 14:52:15 INFO - Usage: mozinstall [options] installer 14:52:15 INFO - Options: 14:52:15 INFO - -h, --help show this help message and exit 14:52:15 INFO - -d DEST, --destination=DEST 14:52:15 INFO - Directory to install application into. [default: 14:52:15 INFO - "/builds/slave/test"] 14:52:15 INFO - --app=APP Application being installed. [default: firefox] 14:52:15 INFO - mkdir: /builds/slave/test/build/application 14:52:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:52:31 INFO - Reading from file tmpfile_stdout 14:52:31 INFO - Output received: 14:52:31 INFO - /builds/slave/test/build/application/firefox/firefox 14:52:31 INFO - Running post-action listener: _resource_record_post_action 14:52:31 INFO - [mozharness: 2016-08-15 21:52:31.516253Z] Finished install step (success) 14:52:31 INFO - [mozharness: 2016-08-15 21:52:31.516534Z] Running run-tests step. 14:52:31 INFO - Running pre-action listener: _resource_record_pre_action 14:52:31 INFO - Running main action method: run_tests 14:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:52:31 INFO - Python 2.7.3 14:52:31 INFO - Return code: 0 14:52:31 INFO - grabbing minidump binary from tooltool 14:52: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')]} 14:52:31 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 0x239e570>, '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 0x239f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239f900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:52:31 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 14:52:31 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 14:52:31 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 14:52:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:52:31 INFO - Return code: 0 14:52:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:52:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:52:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:52:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:52:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 14:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 14:52:31 INFO - Using env: {'DISPLAY': ':0', 14:52:31 INFO - 'HOME': '/home/cltbld', 14:52:31 INFO - 'LANG': 'en_US.UTF-8', 14:52:31 INFO - 'LANGUAGE': 'en_US:en', 14:52:31 INFO - 'LOGNAME': 'cltbld', 14:52:31 INFO - 'MAIL': '/var/mail/cltbld', 14:52:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:52:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:31 INFO - 'MOZ_NO_REMOTE': '1', 14:52:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:31 INFO - 'NO_EM_RESTART': '1', 14:52:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:31 INFO - 'PWD': '/builds/slave/test', 14:52:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:52:31 INFO - 'SHELL': '/bin/bash', 14:52:31 INFO - 'SHLVL': '1', 14:52:31 INFO - 'TERM': 'linux', 14:52:31 INFO - 'TMOUT': '86400', 14:52:31 INFO - 'USER': 'cltbld', 14:52:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869', 14:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:31 INFO - '_': '/tools/buildbot/bin/python'} 14:52:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 14:52:31 INFO - mozversion application_buildid: 20160815115416 14:52:31 INFO - mozversion application_changeset: 65f69c19b3c703615572e2d570e8eab34b18b8ea 14:52:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:52:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:52:31 INFO - mozversion application_name: Firefox 14:52:31 INFO - mozversion application_remotingname: firefox-dev 14:52:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:52:31 INFO - mozversion application_vendor: Mozilla 14:52:31 INFO - mozversion application_version: 50.0a2 14:52:31 INFO - mozversion platform_buildid: 20160815115416 14:52:31 INFO - mozversion platform_changeset: 65f69c19b3c703615572e2d570e8eab34b18b8ea 14:52:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:52:31 INFO - mozversion platform_version: 50.0a2 14:52:31 INFO - using testdate: 1471297951 14:52:31 INFO - actual date: 1471297951 14:52:31 INFO - starting webserver on 'localhost:60681' 14:52:31 INFO - SUITE-START | Running 2 tests 14:52:31 INFO - TEST-START | dromaeo_css 14:52:31 INFO - operating with platform_type : linux_ 14:52:31 INFO - Initialising browser for dromaeo_css test... 14:52:31 INFO - TEST-INFO | started process 9087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJAEjqo/profile http://localhost:60681/getInfo.html) 14:52:36 INFO - PROCESS | 9087 | __metrics Screen width/height:1600/1200 14:52:36 INFO - PROCESS | 9087 | colorDepth:24 14:52:36 INFO - PROCESS | 9087 | Browser inner width/height: 1024/697 14:52:36 INFO - PROCESS | 9087 | __metrics 14:52:36 ERROR - PROCESS | 9087 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:52:37 INFO - TEST-INFO | 9087: exit 0 14:52:37 INFO - Browser initialized. 14:52:37 INFO - Running cycle 1/1 for dromaeo_css test... 14:52:37 INFO - TEST-INFO | started process 9210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJAEjqo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:52:49 INFO - PROCESS | 9210 | RSS: Main: 152539136 14:52:49 INFO - PROCESS | 9210 | 14:53:38 INFO - PROCESS | 9210 | 1471298018800 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] 14:55:47 INFO - PROCESS | 9210 | Cycle 1(1): loaded http://localhost:60681/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60681/tests/dromaeo/cssquery-ext.html) 14:55:48 INFO - PROCESS | 9210 | RSS: Main: 157958144 14:55:48 INFO - PROCESS | 9210 | 14:58:50 INFO - PROCESS | 9210 | Cycle 1(1): loaded http://localhost:60681/tests/dromaeo/cssquery-ext.html (next: http://localhost:60681/tests/dromaeo/cssquery-jquery.html) 14:58:51 INFO - PROCESS | 9210 | RSS: Main: 154230784 14:58:51 INFO - PROCESS | 9210 | 15:01:53 INFO - PROCESS | 9210 | Cycle 1(1): loaded http://localhost:60681/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60681/tests/dromaeo/cssquery-mootools.html) 15:01:53 INFO - PROCESS | 9210 | RSS: Main: 154509312 15:01:53 INFO - PROCESS | 9210 | 15:04:55 INFO - PROCESS | 9210 | Cycle 1(1): loaded http://localhost:60681/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60681/tests/dromaeo/cssquery-prototype.html) 15:04:56 INFO - PROCESS | 9210 | RSS: Main: 153419776 15:04:56 INFO - PROCESS | 9210 | 15:07:58 INFO - PROCESS | 9210 | Cycle 1(1): loaded http://localhost:60681/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60681/tests/dromaeo/cssquery-yui.html) 15:07:59 INFO - PROCESS | 9210 | RSS: Main: 155230208 15:07:59 INFO - PROCESS | 9210 | 15:11:01 INFO - PROCESS | 9210 | Cycle 1(1): loaded http://localhost:60681/tests/dromaeo/cssquery-yui.html (next: http://localhost:60681/tests/dromaeo/cssquery-dojo.html) 15:11:01 INFO - PROCESS | 9210 | RSS: Main: 156237824 15:11:01 INFO - PROCESS | 9210 | 15:11:01 INFO - PROCESS | 9210 | __start_tp_report 15:11:01 INFO - PROCESS | 9210 | _x_x_mozilla_page_load 15:11:01 INFO - PROCESS | 9210 | _x_x_mozilla_page_load_details 15:11:01 INFO - PROCESS | 9210 | |i|pagename|runs| 15:11:01 INFO - PROCESS | 9210 | |0;dojo.html;3366.8821591244296;3368.7473439492037;3371.6965473107425;3388.15296175956;3395.983020084899;5778.191053252543;5844.590878638497;5851.3270973838025;5857.560682948785;5867.970660146704;5645.830625081244;5758.395368486301;5760.395158508359;5783.9710801445935;5806.390329015446;5244;5249.553787928021;5292.603054770908;5311.49540793624;5348;5213.869653258661;5223.973880130613;5260.552853007499;5264.8157314494;5330.680159190461;5272.472752724716;5277.3139491866;5293.841184764463;5305.840824775263;5405.594580406485;5339.119045357511;5356.491133342326;5358.410574836765;5364.973175134139;5367.892642147174;5097.949020509822;5183.222516622499;5237.057329680656;5303.310569625924;5311.787528498855;5661.688607126606;5692.174634677948;5737.569682273846;5787.913181302284;5816.767329306823;6188.628682279033;6244.75020999164;6244.937550624527;6246;6275.372462753734;5909;6263.592866463711;6296.685165741695;6307.842303942392;6312.463440607554;5724.141378793172;5744.798932037401;5770.422957704238;5814.186013958049;5851.414858514199;6338.144350512622;6385.776497822554;6394;6402.6158430494315;6404.7117879695525;5954.434328738763;6097.908531372033;6119.173911521976;6123.969380153071;6124.142620033199;6075.149479072933;6077.24034495688;6109.053096770008;6167.383261673796;6228.875422491616;6146.846328841814;6175.135481032659;6181.84545386369;6203.627782333075;6210.72051757672;6022.337542870281;6140.78507252253;6211.720472578745;6222.844428889314;6233.376662333731;4660.813567457331;4696.201645720235;4710.152172608895;4714.245720684674;4736.360591320196;4164.208800327928;4197.895052623648;4220.78896055196;4238.152369526046;4239.703220774516;5753.424657534213;5989;6004.249468816398;6006.12911127884;6012.699365031818;6035.094735789667;6074.331823499411;6102.572819902653;6204.100405441276;6204.875902481925;5905.734241959036;5910.556708246899;5917.408259174048;5920.31916329619;5923.052311630118;5259.263703081571;5279.049771041249;5312.893742125136;5320.015797077475;5331.786728530893;6276.748930042747;6340.841478963062;6344.746210151542;6395.456386207225;6403.167588213502;6211.0372892201785;6220.129181914535;6234.470070044097;6239.532035097295;6250.781222657185;6218.906716399348;6372.458341041063;6409.294977552372;6469.7412103515335;6480.7731729391135;6037.366076561898;6105.694715264308;6117.724702388492;6121.3572574879;6123.252118380239;6145.667304550192;6187.628742275478;6199.5040396767245;6222.844428889314;6223.595466294676;5948.048312270016;6037.09443583466;6090;6097.17688112117;6109.663968481598;6006.759729610767;6103.084537319438;6112.755489780359;6119.204503414528;6122.142899993915;5980.132880732356;5997.460228579274;5999.98000339952;6005.489533389711;6026.698665066641;5985.850353741192;5999.430054144849;6033.155358249761;6142;6162.537809664203;5863.824085277449;5964.552658550713;5989.880202396015;6004.159417681441;6018.759249629966 15:11:01 INFO - PROCESS | 9210 | |1;ext.html;592.8932792097421;643.1863692429076;644.3653001793233;656.7405874679501;706.3113464372235;41062.58937410625;45962.54037459625;46043;46070.30894536576;46114.76942615287;46125.538744612546;46231.537684623145;46487.53512464874;46520;46637.30044049342;8912.46525208488;9111.954440227822;9118.726438206864;9123.589438475285;9131.2238459731;9045;9058.094190580956;9095.363324567283;9141.588628511732;9167.679131230409;9162.083791620851;9175.082491750838;9213.03263157369;9215.95392023039;9229.169374756271;9089.590968406404;9162.679306224283;9164.541772911327;9168.404053736553;9182.219511341544;9018.413803102843;9076.22852057576;9125.087491250822;9134.725958221265;9139.223166030895;42889.14221715548;43169.784151079046;43278;43303.56696433027;43313;3636.709063274932;3817.751846129993;4402.471703395581;4567.703079422976;4609.262517997105;34638.82680586606;34646.48030279548;34666.30667386663;34728;36729;4705.176594096054;4816.494268101834;4876.926846097312;4891.486393928657;4994.300797888299;389860;392188;393658;394540;396490.01754991326;69564.65217673879;70771.29228707647;70796.29203707897;70911.2908870915;70931.645341774;40454.79772601177;40903.18193636111;41329.793351033055;43498.782506087264;43574.56425435705;17142.142892855307;17358;17358.826411735972;17396.3041478342;17407.73888391675;12454.750904981849;12491;12546.81179782304;12565.120441569003;12618.305993170463;21705.67441488379;22246;22400.439989000406;22415.32754017382;22600.09599615997;7836.412269079842;7844.333231675371;8036.879446808302;8077.959610202029;8199.344052475906;989.7129832348683;1082.1667316166508;1093.1801149138146;1143.1197977557235;1195.1992165249303;34173;34199;34299.657003429646;34466.65533344685;34900;1143.6854864912216;1151.8099513580332;1185.25921299188;1203.1096988228824;1223.2904915149193;17438.302467901143;17952.102394880203;18032.90983545074;18156.909215453838;18257.269709211483;720068;733980;735456;1047683;1065375;63282;63863.36136638574;64138.67930660317;64413.35586644074;64558.35441645524;1425.5865798918198;1448.6821086262107;1451.0495625365402;1452.6949340638373;1477.6379786952266;32516.212710764674;34801.30397392088;34913.47629785504;34919.65080349164;34926;57096.71451642715;57844.421555785586;57973.71013144907;58049;58097;510099;515976;516142;517625;518858;30865.69134308718;31143.22141946379;31275;31487.055388338387;31598.52602210923;49729.75135124301;50642.240366393795;50748.49251507438;51438.48561514337;51675;42997.785011074746;43229.27082916774;43487.56512434962;44055.33916991312;44783.10433791241;45231.77384113058;45511;45855.77072114618;46319;46853.29720054134;38909.80545097256;42947.14105717931;44207.77896110499;44246;45377.546224537335;37790;38866.6113338863;39108.21783564256;39332;39378.80310598428;29747.492908226355;30415.239619009702;30441.391172176875;30596.235094122825;30922.99000564956 15:11:01 INFO - PROCESS | 9210 | |2;jquery.html;405.4526389374347;410.6283813149101;418.8910883170376;421.3511192763145;428.78775006371853;18821.811781882177;19717.408477745692;19796.50508737282;20259.290924817633;20852.478688032807;19504;19544.218231270734;19900.50248743782;20045.398638040846;20110.497237569067;4885.096257192422;5126.231065340192;5162.664426812264;5221.817236396727;5226.05930932432;5177.715225662587;5200.141976573861;5618.297712785902;5792.507636850873;5833.708314584275;5769.82690519283;5841.64950102993;5954.672493012882;5996.640201587918;6009.669468179249;5455.672659640414;5697.6011679182475;5726.3987281335485;5801.593888427812;5814.6511209327155;5660.632058916157;5708.40061793514;5874.1776151338845;5895.263092113486;5929.110633404981;12880.677983050406;13129.212247265099;18151;24316.39209019771;24605.384865378328;2388.211890076288;2395.8921848516857;2426.5632186206476;2468.9506209875703;2661.640678508396;9599.088086631758;9638.277129215337;10027.197824174122;10144.239182061376;10210.183185345155;1974.0919177178514;1999.2902519605475;2040.4898775306174;2071.9378418647466;2097.643400621898;84899.57550212271;85802;87808.5609571948;87935.12064879398;88156;9954.651587194558;9957.850632240523;10744.623938162127;11133.888661113286;11533.88466115328;15703.528894132965;15729.68540629181;15768.211589420484;15812.92093539548;15917.283722232527;8060.959695201604;8062.919370806217;8167.305779008851;8247.95876020616;8265.545395003333;7315.122185337687;7514.286142816423;7524.134724506752;7611.619419029026;7659.463837531431;4942.555170034714;4988.850334489971;5005.574526165244;5047.520485553867;5071.391433027987;1992.3524854422371;2144.678298255243;2153.644648632958;2155.622766015941;2158.7733288004533;974.9658761943298;1023.3655133816932;1055.5091882274778;1067.7223921780237;1108.9908183552927;20455.488612784502;20544.58910821775;20558.588828223652;20784.896075519526;21281.78718212798;1002.997002997003;1055.3562326980536;1075.2043487819114;1120.781447617723;1132.620572108353;10920.836187457195;11329.773404531863;11360.659180224606;11436.885631143748;11518.539258429737;213501;528945;530805;533293;536649;92412.34537048607;93632.53183734174;95106.52446737722;102537.48731256295;105930;453.6053633339016;473.1577791531149;476.67586041491427;477.88769639134773;480.22923208250955;10603.098736607166;10640.467976600985;10990.725231869268;11020.953009464089;11075.169362297698;38563.22873542457;38651.22697546089;44036.559634403246;44546.554534455536;44730.329045065;65133.67433162804;67988.66005670138;68177;68983;69941;8535.10381409943;8651.653933842828;8810.471371717718;9002.86495702578;9151.63393464254;12586.87413125857;13982.790258145933;14054.648633784238;14107.576772696835;14207.431702731776;11950.46222919988;11969.64091077269;12280.078994075302;12286.078544109407;12314.50741970347;11782.175247732577;11859.34773587461;11926.761464770829;12190.51237950472;12262.38688065611;11690.88309116898;12243.693907652023;12343.382830858602;12534.749305014031;12631.557895473614;8023.157568455462;8043.879341809995;8299.668013279643;8410.579471026547;8849.380543361904;8311.584420778816;8566.314694824523;8629;8759.737207883774;8844.425112367675 15:11:01 INFO - PROCESS | 9210 | |3;mootools.html;1533.8772898168145;1563.874890008799;1757.5869670627408;1871.1860340751766;1885.65115453641;8712.477251364906;9345.485998270093;9372.765680857974;10113.342632728876;10117.190624750021;9350.111739384765;9818.803623927517;9836.163926066292;9843;9862.16171625411;2522.836015658981;2570.023391111375;2571.1643715792347;2574.832635878671;2576.3687896465394;2471.4315707387223;2542.2627438042946;2544.4656622109287;2562.743725627441;2567.6533667954773;2462.704475462938;2476.6037434010564;2487.4154573675173;2495.36368226103;2506.9247922562263;2466.9259922202364;2488.377905523619;2492.339530024536;2526.5831137862233;2534.214393538009;2450.130203777651;2455.1284294075526;2456.8157388195955;2466.075221791828;2496.737842526527;9629;9861.654842080565;9883.752906177331;9885.604575816958;9936.95031524845;5848.7075646217945;6005.159277701126;6036.426539478743;6038.547108966845;6039.124326972608;3573;3677.3380791457794;3693.316736403774;3746.7751934883995;3757.3424650686293;1236;1257.063487701668;1269.5873841001712;1333.3066805261308;1342.5166939901726;13171.341432928411;13497.730045399037;13592.184468931895;13913.721725565432;13933.094348867291;4879.365682461257;4902.632302577321;5003.424606170337;5055.974720126376;5152.716600587004;10854.34873907568;10880.510377033053;10882.401467919182;10907.127429805596;10934.4532773361;5920.970395147997;5939.287285525765;5944.4352786485215;5964.075568286922;5986.910196347058;4743.739094349775;5216.061109000417;5333.173358129496;5349.518543331041;5574.275344205308;4131.409407378181;4193.748375097504;4301.290287102655;4325.675574331937;4365.694401391936;1206.240068756695;1280.929548874802;1288.0404098946344;1288.5940928607458;1305.3799445263423;886.8625363068605;962.6245764151986;977.6089564174245;1039.594558122333;1072.2333531524996;6158.507319414436;6220.129181914535;6372.968135159294;6570.06462765823;6779.62712050832;467.2080823004974;471.9693219940693;473.84145763608336;476.3902205177379;488.8875558621466;4427.070315233773;4444.82220711168;4459.375687403766;4492.775361231926;4533.818647254139;11716.23844450125;12060.577879774166;12432.75134497305;12481.063920206021;12516.3741812909;12030.338331391857;12352.135350525377;12526.248425094524;12538.623841284776;12566.748665026831;8993.595288212045;9159.671847582063;9163.49600771964;9168.633254669872;9204.217641500547;6493.350664933658;6681.966590167018;6689.531732778659;6743.932560674527;6787.966060169865;11049.558017679203;11362.204645674723;11626.418679066182;11666.066714662977;11679.708007299885;11320.943395282971;11446.141539384746;11472.02487788514;11612.593559225386;11643.825342620037;7915.960420197862;8472.915270847212;8627.568621569022;8712.12878712149;8865.601047952729;9556.569954351931;9670.806583868423;9676.322657413913;9688.273379496706;9700;7963.681452742057;8246.340292776444;8309.875351869849;8388.916110838814;8411.032731235742;8197.79505512367;8220.054693710299;8254.380921430797;8303.128171542143;8324.6670133194;7325.670344834602;7500.287472690085;7679.2704693054075;7682.8079298018;7913.050433947963;5351.5718742501285;5386.946130538645;5402.945970540244;5461.481159289861;5540.695261760642;5467.261919640957;5513.09034009384;5571.220029195835;5571.637843540157;5574.9163762542785 15:11:01 INFO - PROCESS | 9210 | |4;prototype.html;322.21379833206976;330.6280434511175;338.7019422907841;339.73670405435786;343.9535662685537;5675;5735.569832262587;5748.223989761381;5844.415558444153;5862.413758624136;5704.374253337789;5758.7408566614495;5766.481016708495;5771.971140144294;5777;4539.568740969603;4548.9090218195615;4554.294084416921;4565;4576.473705523874;4387.648988080962;4474.673169951623;4485.259932111214;4517.254652982254;4539.72887591475;4427.358033085216;4438.178936896668;4447.644188464915;4449.176902273073;4452.265376212938;4438.4451943507065;4439.64482841372;4453.354263631788;4453.487848897385;4454.109178164364;3726.1802403471193;3819.7135214858995;3844.3272427325105;3846.615338466159;3849.5573009104032;5577.972110139464;5584.246126772874;5612.07400778871;5613.691246981414;5618.15727640853;5043.697378157322;5059.849563935313;5090.465501122366;5108.386993560796;5118.385793704742;5744.626599271034;5976.432238937337;6023.69881505923;6026.939730602681;6044.818655440344;4336.848210312655;4347.80435380273;4351.694491652492;4352.368906508538;4359.956400435986;6072.908906366408;6239.438450539428;6310.5898116622275;6317.5893566918;6323.30443651198;4401.163778882003;4408.465132548798;4414.779261036935;4422.601965823092;4429.7785110744335;4446.3108218226225;4456.420665313489;4461.442319710036;4469.195544801902;4469.7318160910445;4854.524192661697;5055.823046193365;5074.467180945948;5105.310783044316;5111.718855462911;5954.374790647006;6094.603850749687;6134.570580059442;6146.7706458708435;6153.8307721532765;1508.4494159631656;1547.829738728739;1551.5422950229708;1555.5566663500847;1555.7476231633418;962.1725316228038;991.4447909170743;1004.7039319278196;1011.5549158370441;1018.2312354172552;5258.684478931276;5287.894242115136;5291.550218231493;5296.443873393316;5306.787728490817;5402.37872644643;5518.448155184449;5553.77784888608;5599.524040456526;5606.803761868315;5038.5969122470115;5229.921551176735;5307.99148161848;5326.866828329323;5347.705876176769;2964.4960356738975;2969.792114551961;2979.9404011920074;2988.2529367658085;2996.4007198560375;5712.971435142797;5722.567908638812;5724.599278050497;5728.513076388554;5755.453231942959;5950.047992321208;6412.422881940648;6441;6467.579607325509;6471.255805582324;6536;6540.738370465223;6548.853950558633;6562.639054852029;6574.638394888231;6110.2973158085615;6274.498040156868;6302.684865756602;6310.327763142679;6320.778772742932;6221.222347206599;6230.532710046674;6282.43458088756;6283.8114856554375;6325.746970121144;6393.155046004669;6480.222373315232;6482.448991835558;6554.8361290968105;6593.439557637463;4416.668749843839;4441.244988352052;4444.555494478089;4446.844360447369;4450.709294304745;6058.637456211669;6125.632462052291;6266.780662676784;6325.995152302803;6360.395762402564;6126.203593532812;6154.661493617894;6179.81460556184;6193.163922870535;6196.81409557714;5963.552733544915;6130.172426722514;6138.478229350555;6141.232345956755;6189.35011823752;6010.248718910137;6052.727627256696;6076.483498902643;6077.544184186292;6078.422549857756;6136.7852125175405;6193.071039343954;6212.596181248205;6228.844278893064;6239.719212635351;5825.912611310749;6039.610889495353;6045.304789949212;6053.334133245427;6070.210872586712 15:11:01 INFO - PROCESS | 9210 | |5;yui.html;763.6716212028828;825.2655136928136;843.4812590256994;853.6073406233132;922.1608336413865;16713;16957.660846783056;16973.57566060849;16988.74516882246;17622.471325860228;16751.162441877917;17043.147842607883;17047.829521704778;17162.31350745972;17176;736.7126820539967;866.7269810009858;880.0847118996252;884.6549845560237;898.5552151684892;888.3071204460531;890.2655309369763;891.2023738753811;891.3760367742574;896.1710417863483;938.6573900526292;939.8684184214216;940.2384068904175;940.9482478463682;941.6139382853031;930.3022732950287;931.2363861633463;931.2736065868634;933.9579718912631;935.0649350649351;688.0161369241982;689.5414549324693;691.3639451704444;691.4675699711245;693.5907814389534;15211.771823422658;15214.923925380303;15250.466233681878;15308.617284567863;15358.462453814063;16647.16764161787;16776.08751004769;17015.31938722462;17279.481615551555;17316.740248896276;13201.14192577489;13222;13249.602511924657;13538.458461661521;13550.661233469144;4123.9175216495805;4170.4995400551825;4181.540030596632;4187.958120418787;4217.240896638604;86533;87074.12925870724;87255.56372218161;88351.55824220902;90385;12626.558070467674;12887.226766394046;12903;12991.090623656253;13032.674183145307;25226.621600676004;25316.987320506974;25337;25369.112081077445;25458.490830183662;8848.336374771789;9003.909960900308;9143.359964802534;9202.171804537624;9210.125038121369;5011.924821127686;5135.707449156196;5233.005728911495;5322.946770532322;5537.889242215133;3977.76133431995;4119.114390406077;4143.544210136883;4178.728382655178;4187.973946383156;664.6410938093376;665.653859992801;680.146416247616;699.720111955222;700.8668353012911;690.5856486108295;719.3633634233636;770.8034451215017;787.42517961887;798.9201079891965;9967.252456065824;10351.327163734484;10442.269041167045;10589.84115238272;10971.067459266053;703.282651695268;704.9964750176216;724.0195981195365;770.7225398856407;814.5316443045273;4929.630277729185;5338.91991620126;5358;5409.377921539073;5451.809186678447;69762.65118674374;70442.64778676073;71462.64268678623;111230.44384778025;111969;100403.49798250962;101829.49085254526;104169;105367.4731626337;105516;77425.61287193529;78252.43495130066;94313;95517.52241238888;96061;10279.229057820543;10425.791484170426;10467.371957682259;10635.89364106349;11001.339919604849;53311.733441332544;54142.729286353315;55773;56369.43630563642;56800.715996419756;47197.528024719315;47249.05501889874;69382.65308673626;77202.22797772175;79004;13143.802842957171;13504.594862154152;13845.930770346487;13968.886443945818;14135.434582616992;14057.297135143406;14267.500637477639;14961;14967.326470308644;15798.76301855496;14856.182909939625;14869.776953345492;15303.846961530242;15342.846571534143;15603.219839007777;14107.929460352632;14550.563483095524;14892.702145957237;15208.543743687707;16115.838841611434;13018.674533136747;13781.862181378057;14214.14715117055;14376.712465750417;15216.467423640119;10487.790244195226;11733.88266117362;12323.59982750335;12986.415611297703;13229.735405291647;11814.480087397029;12387.132900697225;12398.25610463375;12676.492940282655;12942.223466592035 15:11:01 INFO - PROCESS | 9210 | __end_tp_report 15:11:01 INFO - PROCESS | 9210 | __start_cc_report 15:11:01 INFO - PROCESS | 9210 | _x_x_mozilla_cycle_collect,320 15:11:01 INFO - PROCESS | 9210 | __end_cc_report 15:11:01 INFO - PROCESS | 9210 | __startTimestamp1471299061743__endTimestamp 15:11:01 INFO - PROCESS | 9210 | 15:11:01 INFO - PROCESS | 9210 | ------- Summary: start ------- 15:11:01 INFO - PROCESS | 9210 | Number of tests: 6 15:11:01 INFO - PROCESS | 9210 | 15:11:01 INFO - PROCESS | 9210 | [#0] dojo.html Cycles:165 Average:5757.70 Median:5999.98 stddev:651.25 (10.9%) stddev-sans-first:625.66 15:11:01 INFO - PROCESS | 9210 | Values: 3366.9 3368.7 3371.7 3388.2 3396.0 5778.2 5844.6 5851.3 5857.6 5868.0 5645.8 5758.4 5760.4 5784.0 5806.4 5244.0 5249.6 5292.6 5311.5 5348.0 5213.9 5224.0 5260.6 5264.8 5330.7 5272.5 5277.3 5293.8 5305.8 5405.6 5339.1 5356.5 5358.4 5365.0 5367.9 5097.9 5183.2 5237.1 5303.3 5311.8 5661.7 5692.2 5737.6 5787.9 5816.8 6188.6 6244.8 6244.9 6246.0 6275.4 5909.0 6263.6 6296.7 6307.8 6312.5 5724.1 5744.8 5770.4 5814.2 5851.4 6338.1 6385.8 6394.0 6402.6 6404.7 5954.4 6097.9 6119.2 6124.0 6124.1 6075.1 6077.2 6109.1 6167.4 6228.9 6146.8 6175.1 6181.8 6203.6 6210.7 6022.3 6140.8 6211.7 6222.8 6233.4 4660.8 4696.2 4710.2 4714.2 4736.4 4164.2 4197.9 4220.8 4238.2 4239.7 5753.4 5989.0 6004.2 6006.1 6012.7 6035.1 6074.3 6102.6 6204.1 6204.9 5905.7 5910.6 5917.4 5920.3 5923.1 5259.3 5279.0 5312.9 5320.0 5331.8 6276.7 6340.8 6344.7 6395.5 6403.2 6211.0 6220.1 6234.5 6239.5 6250.8 6218.9 6372.5 6409.3 6469.7 6480.8 6037.4 6105.7 6117.7 6121.4 6123.3 6145.7 6187.6 6199.5 6222.8 6223.6 5948.0 6037.1 6090.0 6097.2 6109.7 6006.8 6103.1 6112.8 6119.2 6122.1 5980.1 5997.5 6000.0 6005.5 6026.7 5985.9 5999.4 6033.2 6142.0 6162.5 5863.8 5964.6 5989.9 6004.2 6018.8 15:11:01 INFO - PROCESS | 9210 | 15:11:01 INFO - PROCESS | 9210 | [#1] ext.html Cycles:180 Average:73999.59 Median:44131.56 stddev:169396.40 (383.8%) stddev-sans-first:169781.94 15:11:01 INFO - PROCESS | 9210 | Values: 592.9 643.2 644.4 656.7 706.3 41062.6 45962.5 46043.0 46070.3 46114.8 46125.5 46231.5 46487.5 46520.0 46637.3 8912.5 9112.0 9118.7 9123.6 9131.2 9045.0 9058.1 9095.4 9141.6 9167.7 9162.1 9175.1 9213.0 9216.0 9229.2 9089.6 9162.7 9164.5 9168.4 9182.2 9018.4 9076.2 9125.1 9134.7 9139.2 42889.1 43169.8 43278.0 43303.6 43313.0 3636.7 3817.8 4402.5 4567.7 4609.3 34638.8 34646.5 34666.3 34728.0 36729.0 4705.2 4816.5 4876.9 4891.5 4994.3 389860.0 392188.0 393658.0 394540.0 396490.0 69564.7 70771.3 70796.3 70911.3 70931.6 40454.8 40903.2 41329.8 43498.8 43574.6 17142.1 17358.0 17358.8 17396.3 17407.7 12454.8 12491.0 12546.8 12565.1 12618.3 21705.7 22246.0 22400.4 22415.3 22600.1 7836.4 7844.3 8036.9 8078.0 8199.3 989.7 1082.2 1093.2 1143.1 1195.2 34173.0 34199.0 34299.7 34466.7 34900.0 1143.7 1151.8 1185.3 1203.1 1223.3 17438.3 17952.1 18032.9 18156.9 18257.3 720068.0 733980.0 735456.0 1047683.0 1065375.0 63282.0 63863.4 64138.7 64413.4 64558.4 1425.6 1448.7 1451.0 1452.7 1477.6 32516.2 34801.3 34913.5 34919.7 34926.0 57096.7 57844.4 57973.7 58049.0 58097.0 510099.0 515976.0 516142.0 517625.0 518858.0 30865.7 31143.2 31275.0 31487.1 31598.5 49729.8 50642.2 50748.5 51438.5 51675.0 42997.8 43229.3 43487.6 44055.3 44783.1 45231.8 45511.0 45855.8 46319.0 46853.3 38909.8 42947.1 44207.8 44246.0 45377.5 37790.0 38866.6 39108.2 39332.0 39378.8 29747.5 30415.2 30441.4 30596.2 30923.0 15:11:01 INFO - PROCESS | 9210 | 15:11:01 INFO - PROCESS | 9210 | [#2] jquery.html Cycles:180 Average:28768.62 Median:408.04 stddev:80704.79 (19778.6%) stddev-sans-first:80903.09 15:11:01 INFO - PROCESS | 9210 | Values: 405.5 410.6 418.9 421.4 428.8 18821.8 19717.4 19796.5 20259.3 20852.5 19504.0 19544.2 19900.5 20045.4 20110.5 4885.1 5126.2 5162.7 5221.8 5226.1 5177.7 5200.1 5618.3 5792.5 5833.7 5769.8 5841.6 5954.7 5996.6 6009.7 5455.7 5697.6 5726.4 5801.6 5814.7 5660.6 5708.4 5874.2 5895.3 5929.1 12880.7 13129.2 18151.0 24316.4 24605.4 2388.2 2395.9 2426.6 2469.0 2661.6 9599.1 9638.3 10027.2 10144.2 10210.2 1974.1 1999.3 2040.5 2071.9 2097.6 84899.6 85802.0 87808.6 87935.1 88156.0 9954.7 9957.9 10744.6 11133.9 11533.9 15703.5 15729.7 15768.2 15812.9 15917.3 8061.0 8062.9 8167.3 8248.0 8265.5 7315.1 7514.3 7524.1 7611.6 7659.5 4942.6 4988.9 5005.6 5047.5 5071.4 1992.4 2144.7 2153.6 2155.6 2158.8 975.0 1023.4 1055.5 1067.7 1109.0 20455.5 20544.6 20558.6 20784.9 21281.8 1003.0 1055.4 1075.2 1120.8 1132.6 10920.8 11329.8 11360.7 11436.9 11518.5 213501.0 528945.0 530805.0 533293.0 536649.0 92412.3 93632.5 95106.5 102537.5 105930.0 453.6 473.2 476.7 477.9 480.2 10603.1 10640.5 10990.7 11021.0 11075.2 38563.2 38651.2 44036.6 44546.6 44730.3 65133.7 67988.7 68177.0 68983.0 69941.0 8535.1 8651.7 8810.5 9002.9 9151.6 12586.9 13982.8 14054.6 14107.6 14207.4 11950.5 11969.6 12280.1 12286.1 12314.5 11782.2 11859.3 11926.8 12190.5 12262.4 11690.9 12243.7 12343.4 12534.7 12631.6 8023.2 8043.9 8299.7 8410.6 8849.4 8311.6 8566.3 8629.0 8759.7 8844.4 15:11:01 INFO - PROCESS | 9210 | 15:11:01 INFO - PROCESS | 9210 | [#3] mootools.html Cycles:180 Average:6380.19 Median:472.91 stddev:3716.47 (785.9%) stddev-sans-first:3709.05 15:11:01 INFO - PROCESS | 9210 | Values: 1533.9 1563.9 1757.6 1871.2 1885.7 8712.5 9345.5 9372.8 10113.3 10117.2 9350.1 9818.8 9836.2 9843.0 9862.2 2522.8 2570.0 2571.2 2574.8 2576.4 2471.4 2542.3 2544.5 2562.7 2567.7 2462.7 2476.6 2487.4 2495.4 2506.9 2466.9 2488.4 2492.3 2526.6 2534.2 2450.1 2455.1 2456.8 2466.1 2496.7 9629.0 9861.7 9883.8 9885.6 9937.0 5848.7 6005.2 6036.4 6038.5 6039.1 3573.0 3677.3 3693.3 3746.8 3757.3 1236.0 1257.1 1269.6 1333.3 1342.5 13171.3 13497.7 13592.2 13913.7 13933.1 4879.4 4902.6 5003.4 5056.0 5152.7 10854.3 10880.5 10882.4 10907.1 10934.5 5921.0 5939.3 5944.4 5964.1 5986.9 4743.7 5216.1 5333.2 5349.5 5574.3 4131.4 4193.7 4301.3 4325.7 4365.7 1206.2 1280.9 1288.0 1288.6 1305.4 886.9 962.6 977.6 1039.6 1072.2 6158.5 6220.1 6373.0 6570.1 6779.6 467.2 472.0 473.8 476.4 488.9 4427.1 4444.8 4459.4 4492.8 4533.8 11716.2 12060.6 12432.8 12481.1 12516.4 12030.3 12352.1 12526.2 12538.6 12566.7 8993.6 9159.7 9163.5 9168.6 9204.2 6493.4 6682.0 6689.5 6743.9 6788.0 11049.6 11362.2 11626.4 11666.1 11679.7 11320.9 11446.1 11472.0 11612.6 11643.8 7916.0 8472.9 8627.6 8712.1 8865.6 9556.6 9670.8 9676.3 9688.3 9700.0 7963.7 8246.3 8309.9 8388.9 8411.0 8197.8 8220.1 8254.4 8303.1 8324.7 7325.7 7500.3 7679.3 7682.8 7913.1 5351.6 5386.9 5402.9 5461.5 5540.7 5467.3 5513.1 5571.2 5571.6 5574.9 15:11:01 INFO - PROCESS | 9210 | 15:11:01 INFO - PROCESS | 9210 | [#4] prototype.html Cycles:180 Average:5037.54 Median:5612.88 stddev:1507.37 (26.9%) stddev-sans-first:1469.46 15:11:01 INFO - PROCESS | 9210 | Values: 322.2 330.6 338.7 339.7 344.0 5675.0 5735.6 5748.2 5844.4 5862.4 5704.4 5758.7 5766.5 5772.0 5777.0 4539.6 4548.9 4554.3 4565.0 4576.5 4387.6 4474.7 4485.3 4517.3 4539.7 4427.4 4438.2 4447.6 4449.2 4452.3 4438.4 4439.6 4453.4 4453.5 4454.1 3726.2 3819.7 3844.3 3846.6 3849.6 5578.0 5584.2 5612.1 5613.7 5618.2 5043.7 5059.8 5090.5 5108.4 5118.4 5744.6 5976.4 6023.7 6026.9 6044.8 4336.8 4347.8 4351.7 4352.4 4360.0 6072.9 6239.4 6310.6 6317.6 6323.3 4401.2 4408.5 4414.8 4422.6 4429.8 4446.3 4456.4 4461.4 4469.2 4469.7 4854.5 5055.8 5074.5 5105.3 5111.7 5954.4 6094.6 6134.6 6146.8 6153.8 1508.4 1547.8 1551.5 1555.6 1555.7 962.2 991.4 1004.7 1011.6 1018.2 5258.7 5287.9 5291.6 5296.4 5306.8 5402.4 5518.4 5553.8 5599.5 5606.8 5038.6 5229.9 5308.0 5326.9 5347.7 2964.5 2969.8 2979.9 2988.3 2996.4 5713.0 5722.6 5724.6 5728.5 5755.5 5950.0 6412.4 6441.0 6467.6 6471.3 6536.0 6540.7 6548.9 6562.6 6574.6 6110.3 6274.5 6302.7 6310.3 6320.8 6221.2 6230.5 6282.4 6283.8 6325.7 6393.2 6480.2 6482.4 6554.8 6593.4 4416.7 4441.2 4444.6 4446.8 4450.7 6058.6 6125.6 6266.8 6326.0 6360.4 6126.2 6154.7 6179.8 6193.2 6196.8 5963.6 6130.2 6138.5 6141.2 6189.4 6010.2 6052.7 6076.5 6077.5 6078.4 6136.8 6193.1 6212.6 6228.8 6239.7 5825.9 6039.6 6045.3 6053.3 6070.2 15:11:01 INFO - PROCESS | 9210 | 15:11:01 INFO - PROCESS | 9210 | [#5] yui.html Cycles:180 Average:21044.29 Median:4174.61 stddev:28729.27 (688.2%) stddev-sans-first:28769.50 15:11:01 INFO - PROCESS | 9210 | Values: 763.7 825.3 843.5 853.6 922.2 16713.0 16957.7 16973.6 16988.7 17622.5 16751.2 17043.1 17047.8 17162.3 17176.0 736.7 866.7 880.1 884.7 898.6 888.3 890.3 891.2 891.4 896.2 938.7 939.9 940.2 940.9 941.6 930.3 931.2 931.3 934.0 935.1 688.0 689.5 691.4 691.5 693.6 15211.8 15214.9 15250.5 15308.6 15358.5 16647.2 16776.1 17015.3 17279.5 17316.7 13201.1 13222.0 13249.6 13538.5 13550.7 4123.9 4170.5 4181.5 4188.0 4217.2 86533.0 87074.1 87255.6 88351.6 90385.0 12626.6 12887.2 12903.0 12991.1 13032.7 25226.6 25317.0 25337.0 25369.1 25458.5 8848.3 9003.9 9143.4 9202.2 9210.1 5011.9 5135.7 5233.0 5322.9 5537.9 3977.8 4119.1 4143.5 4178.7 4188.0 664.6 665.7 680.1 699.7 700.9 690.6 719.4 770.8 787.4 798.9 9967.3 10351.3 10442.3 10589.8 10971.1 703.3 705.0 724.0 770.7 814.5 4929.6 5338.9 5358.0 5409.4 5451.8 69762.7 70442.6 71462.6 111230.4 111969.0 100403.5 101829.5 104169.0 105367.5 105516.0 77425.6 78252.4 94313.0 95517.5 96061.0 10279.2 10425.8 10467.4 10635.9 11001.3 53311.7 54142.7 55773.0 56369.4 56800.7 47197.5 47249.1 69382.7 77202.2 79004.0 13143.8 13504.6 13845.9 13968.9 14135.4 14057.3 14267.5 14961.0 14967.3 15798.8 14856.2 14869.8 15303.8 15342.8 15603.2 14107.9 14550.6 14892.7 15208.5 16115.8 13018.7 13781.9 14214.1 14376.7 15216.5 10487.8 11733.9 12323.6 12986.4 13229.7 11814.5 12387.1 12398.3 12676.5 12942.2 15:11:01 INFO - PROCESS | 9210 | -------- Summary: end -------- 15:11:01 INFO - PROCESS | 9210 | 15:11:02 INFO - TEST-INFO | 9210: exit 0 15:11:02 INFO - TEST-OK | dromaeo_css | took 1110694ms 15:11:02 INFO - TEST-START | kraken 15:11:02 INFO - operating with platform_type : linux_ 15:11:02 INFO - Initialising browser for kraken test... 15:11:02 INFO - TEST-INFO | started process 9471 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMiwTWI/profile http://localhost:60681/getInfo.html) 15:11:06 INFO - PROCESS | 9471 | __metrics Screen width/height:1600/1200 15:11:06 INFO - PROCESS | 9471 | colorDepth:24 15:11:06 INFO - PROCESS | 9471 | Browser inner width/height: 1024/697 15:11:06 INFO - PROCESS | 9471 | __metrics 15:11:07 ERROR - PROCESS | 9471 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:11:08 INFO - TEST-INFO | 9471: exit 0 15:11:08 INFO - Browser initialized. 15:11:08 INFO - Running cycle 1/1 for kraken test... 15:11:08 INFO - TEST-INFO | started process 9596 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMiwTWI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:19 INFO - PROCESS | 9596 | RSS: Main: 152309760 15:11:19 INFO - PROCESS | 9596 | 15:11:22 INFO - PROCESS | 9596 | Cycle 1(1): loaded http://localhost:60681/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60681/tests/kraken/driver.html?testName=audio-beat-detection) 15:11:23 INFO - PROCESS | 9596 | RSS: Main: 157872128 15:11:23 INFO - PROCESS | 9596 | 15:11:25 INFO - PROCESS | 9596 | Cycle 1(1): loaded http://localhost:60681/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60681/tests/kraken/driver.html?testName=audio-dft) 15:11:26 INFO - PROCESS | 9596 | RSS: Main: 156114944 15:11:26 INFO - PROCESS | 9596 | 15:11:29 INFO - PROCESS | 9596 | Cycle 1(1): loaded http://localhost:60681/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60681/tests/kraken/driver.html?testName=audio-fft) 15:11:29 INFO - PROCESS | 9596 | RSS: Main: 157302784 15:11:29 INFO - PROCESS | 9596 | 15:11:32 INFO - PROCESS | 9596 | Cycle 1(1): loaded http://localhost:60681/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60681/tests/kraken/driver.html?testName=audio-oscillator) 15:11:32 INFO - PROCESS | 9596 | RSS: Main: 156745728 15:11:32 INFO - PROCESS | 9596 | 15:11:34 INFO - PROCESS | 9596 | Cycle 1(1): loaded http://localhost:60681/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60681/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:11:35 INFO - PROCESS | 9596 | RSS: Main: 156971008 15:11:35 INFO - PROCESS | 9596 | 15:11:38 INFO - PROCESS | 9596 | Cycle 1(1): loaded http://localhost:60681/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60681/tests/kraken/driver.html?testName=imaging-darkroom) 15:11:39 INFO - PROCESS | 9596 | RSS: Main: 155885568 15:11:39 INFO - PROCESS | 9596 | 15:11:42 INFO - PROCESS | 9596 | Cycle 1(1): loaded http://localhost:60681/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60681/tests/kraken/driver.html?testName=imaging-desaturate) 15:11:43 INFO - PROCESS | 9596 | RSS: Main: 155058176 15:11:43 INFO - PROCESS | 9596 | 15:11:46 INFO - PROCESS | 9596 | Cycle 1(1): loaded http://localhost:60681/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60681/tests/kraken/driver.html?testName=json-parse-financial) 15:11:46 INFO - PROCESS | 9596 | RSS: Main: 156487680 15:11:46 INFO - PROCESS | 9596 | 15:11:48 INFO - PROCESS | 9596 | Cycle 1(1): loaded http://localhost:60681/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60681/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:11:48 INFO - PROCESS | 9596 | RSS: Main: 156602368 15:11:48 INFO - PROCESS | 9596 | 15:11:50 INFO - PROCESS | 9596 | Cycle 1(1): loaded http://localhost:60681/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60681/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:11:51 INFO - PROCESS | 9596 | RSS: Main: 156729344 15:11:51 INFO - PROCESS | 9596 | 15:11:53 INFO - PROCESS | 9596 | Cycle 1(1): loaded http://localhost:60681/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60681/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:11:53 INFO - PROCESS | 9596 | RSS: Main: 156958720 15:11:53 INFO - PROCESS | 9596 | 15:11:56 INFO - PROCESS | 9596 | Cycle 1(1): loaded http://localhost:60681/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:11:57 INFO - PROCESS | 9596 | RSS: Main: 157392896 15:11:57 INFO - PROCESS | 9596 | 15:11:59 INFO - PROCESS | 9596 | Cycle 1(1): loaded http://localhost:60681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:12:00 INFO - PROCESS | 9596 | RSS: Main: 157949952 15:12:00 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | Cycle 1(1): loaded http://localhost:60681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60681/tests/kraken/driver.html?testName=ai-astar) 15:12:02 INFO - PROCESS | 9596 | RSS: Main: 158748672 15:12:02 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | __start_tp_report 15:12:02 INFO - PROCESS | 9596 | _x_x_mozilla_page_load 15:12:02 INFO - PROCESS | 9596 | _x_x_mozilla_page_load_details 15:12:02 INFO - PROCESS | 9596 | |i|pagename|runs| 15:12:02 INFO - PROCESS | 9596 | |0;ai-astar;100;110;104;111;111;110;110;109;111;112 15:12:02 INFO - PROCESS | 9596 | |1;audio-beat-detection;150;116;148;180;118;147;154;118;166;116 15:12:02 INFO - PROCESS | 9596 | |2;audio-dft;161;163;166;162;161;161;163;162;163;162 15:12:02 INFO - PROCESS | 9596 | |3;audio-fft;75;75;76;190;75;74;73;76;176;76 15:12:02 INFO - PROCESS | 9596 | |4;audio-oscillator;84;83;151;84;84;84;141;83;87;141 15:12:02 INFO - PROCESS | 9596 | |5;imaging-gaussian-blur;118;117;117;117;118;117;118;118;118;117 15:12:02 INFO - PROCESS | 9596 | |6;imaging-darkroom;147;148;147;147;148;148;147;147;148;147 15:12:02 INFO - PROCESS | 9596 | |7;imaging-desaturate;96;95;96;96;95;96;96;96;96;96 15:12:02 INFO - PROCESS | 9596 | |8;json-parse-financial;54;52;54;52;53;53;51;56;52;52 15:12:02 INFO - PROCESS | 9596 | |9;json-stringify-tinderbox;59;61;59;59;59;63;59;59;59;61 15:12:02 INFO - PROCESS | 9596 | |10;stanford-crypto-aes;75;76;73;73;76;73;73;77;72;73 15:12:02 INFO - PROCESS | 9596 | |11;stanford-crypto-ccm;122;117;126;119;119;116;124;123;162;137 15:12:02 INFO - PROCESS | 9596 | |12;stanford-crypto-pbkdf2;153;153;155;150;150;153;152;158;154;152 15:12:02 INFO - PROCESS | 9596 | |13;stanford-crypto-sha256-iterative;63;62;66;62;63;62;62;65;61;62 15:12:02 INFO - PROCESS | 9596 | __end_tp_report 15:12:02 INFO - PROCESS | 9596 | __start_cc_report 15:12:02 INFO - PROCESS | 9596 | _x_x_mozilla_cycle_collect,894 15:12:02 INFO - PROCESS | 9596 | __end_cc_report 15:12:02 INFO - PROCESS | 9596 | __startTimestamp1471299122349__endTimestamp 15:12:02 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | ------- Summary: start ------- 15:12:02 INFO - PROCESS | 9596 | Number of tests: 14 15:12:02 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.50 stddev:3.79 (3.4%) stddev-sans-first:2.33 15:12:02 INFO - PROCESS | 9596 | Values: 100.0 110.0 104.0 111.0 111.0 110.0 110.0 109.0 111.0 112.0 15:12:02 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:149.00 stddev:23.07 (15.5%) stddev-sans-first:24.25 15:12:02 INFO - PROCESS | 9596 | Values: 150.0 116.0 148.0 180.0 118.0 147.0 154.0 118.0 166.0 116.0 15:12:02 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.51 (0.9%) stddev-sans-first:1.51 15:12:02 INFO - PROCESS | 9596 | Values: 161.0 163.0 166.0 162.0 161.0 161.0 163.0 162.0 163.0 162.0 15:12:02 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | [#3] audio-fft Cycles:10 Average:96.60 Median:75.00 stddev:45.67 (60.9%) stddev-sans-first:47.76 15:12:02 INFO - PROCESS | 9596 | Values: 75.0 75.0 76.0 190.0 75.0 74.0 73.0 76.0 176.0 76.0 15:12:02 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:84.00 stddev:29.22 (34.8%) stddev-sans-first:30.24 15:12:02 INFO - PROCESS | 9596 | Values: 84.0 83.0 151.0 84.0 84.0 84.0 141.0 83.0 87.0 141.0 15:12:02 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 15:12:02 INFO - PROCESS | 9596 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 117.0 15:12:02 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:12:02 INFO - PROCESS | 9596 | Values: 147.0 148.0 147.0 147.0 148.0 148.0 147.0 147.0 148.0 147.0 15:12:02 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:12:02 INFO - PROCESS | 9596 | Values: 96.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 15:12:02 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.45 (2.7%) stddev-sans-first:1.48 15:12:02 INFO - PROCESS | 9596 | Values: 54.0 52.0 54.0 52.0 53.0 53.0 51.0 56.0 52.0 52.0 15:12:02 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:59.00 stddev:1.40 (2.4%) stddev-sans-first:1.45 15:12:02 INFO - PROCESS | 9596 | Values: 59.0 61.0 59.0 59.0 59.0 63.0 59.0 59.0 59.0 61.0 15:12:02 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:74.00 stddev:1.73 (2.3%) stddev-sans-first:1.80 15:12:02 INFO - PROCESS | 9596 | Values: 75.0 76.0 73.0 73.0 76.0 73.0 73.0 77.0 72.0 73.0 15:12:02 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:123.50 stddev:13.83 (11.2%) stddev-sans-first:14.58 15:12:02 INFO - PROCESS | 9596 | Values: 122.0 117.0 126.0 119.0 119.0 116.0 124.0 123.0 162.0 137.0 15:12:02 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.00 Median:153.00 stddev:2.36 (1.5%) stddev-sans-first:2.50 15:12:02 INFO - PROCESS | 9596 | Values: 153.0 153.0 155.0 150.0 150.0 153.0 152.0 158.0 154.0 152.0 15:12:02 INFO - PROCESS | 9596 | 15:12:02 INFO - PROCESS | 9596 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.50 stddev:1.55 (2.5%) stddev-sans-first:1.64 15:12:02 INFO - PROCESS | 9596 | Values: 63.0 62.0 66.0 62.0 63.0 62.0 62.0 65.0 61.0 62.0 15:12:02 INFO - PROCESS | 9596 | -------- Summary: end -------- 15:12:02 INFO - PROCESS | 9596 | 15:12:03 INFO - TEST-INFO | 9596: exit 0 15:12:03 INFO - TEST-OK | kraken | took 60823ms 15:12:03 INFO - SUITE-END | took 1171s 15:12:03 INFO - Completed test suite (00:19:31) 15:12:03 INFO - javascript benchmark 15:12:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7680.643162498825, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3366.8821591244296, 3368.7473439492037, 3371.6965473107425, 3388.15296175956, 3395.983020084899, 5778.191053252543, 5844.590878638497, 5851.3270973838025, 5857.560682948785, 5867.970660146704, 5645.830625081244, 5758.395368486301, 5760.395158508359, 5783.9710801445935, 5806.390329015446, 5244.0, 5249.553787928021, 5292.603054770908, 5311.49540793624, 5348.0, 5213.869653258661, 5223.973880130613, 5260.552853007499, 5264.8157314494, 5330.680159190461, 5272.472752724716, 5277.3139491866, 5293.841184764463, 5305.840824775263, 5405.594580406485, 5339.119045357511, 5356.491133342326, 5358.410574836765, 5364.973175134139, 5367.892642147174, 5097.949020509822, 5183.222516622499, 5237.057329680656, 5303.310569625924, 5311.787528498855, 5661.688607126606, 5692.174634677948, 5737.569682273846, 5787.913181302284, 5816.767329306823, 6188.628682279033, 6244.75020999164, 6244.937550624527, 6246.0, 6275.372462753734, 5909.0, 6263.592866463711, 6296.685165741695, 6307.842303942392, 6312.463440607554, 5724.141378793172, 5744.798932037401, 5770.422957704238, 5814.186013958049, 5851.414858514199, 6338.144350512622, 6385.776497822554, 6394.0, 6402.6158430494315, 6404.7117879695525, 5954.434328738763, 6097.908531372033, 6119.173911521976, 6123.969380153071, 6124.142620033199, 6075.149479072933, 6077.24034495688, 6109.053096770008, 6167.383261673796, 6228.875422491616, 6146.846328841814, 6175.135481032659, 6181.84545386369, 6203.627782333075, 6210.72051757672, 6022.337542870281, 6140.78507252253, 6211.720472578745, 6222.844428889314, 6233.376662333731, 4660.813567457331, 4696.201645720235, 4710.152172608895, 4714.245720684674, 4736.360591320196, 4164.208800327928, 4197.895052623648, 4220.78896055196, 4238.152369526046, 4239.703220774516, 5753.424657534213, 5989.0, 6004.249468816398, 6006.12911127884, 6012.699365031818, 6035.094735789667, 6074.331823499411, 6102.572819902653, 6204.100405441276, 6204.875902481925, 5905.734241959036, 5910.556708246899, 5917.408259174048, 5920.31916329619, 5923.052311630118, 5259.263703081571, 5279.049771041249, 5312.893742125136, 5320.015797077475, 5331.786728530893, 6276.748930042747, 6340.841478963062, 6344.746210151542, 6395.456386207225, 6403.167588213502, 6211.0372892201785, 6220.129181914535, 6234.470070044097, 6239.532035097295, 6250.781222657185, 6218.906716399348, 6372.458341041063, 6409.294977552372, 6469.7412103515335, 6480.7731729391135, 6037.366076561898, 6105.694715264308, 6117.724702388492, 6121.3572574879, 6123.252118380239, 6145.667304550192, 6187.628742275478, 6199.5040396767245, 6222.844428889314, 6223.595466294676, 5948.048312270016, 6037.09443583466, 6090.0, 6097.17688112117, 6109.663968481598, 6006.759729610767, 6103.084537319438, 6112.755489780359, 6119.204503414528, 6122.142899993915, 5980.132880732356, 5997.460228579274, 5999.98000339952, 6005.489533389711, 6026.698665066641, 5985.850353741192, 5999.430054144849, 6033.155358249761, 6142.0, 6162.537809664203, 5863.824085277449, 5964.552658550713, 5989.880202396015, 6004.159417681441, 6018.759249629966], "value": 5713.940238212686, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.8932792097421, 643.1863692429076, 644.3653001793233, 656.7405874679501, 706.3113464372235, 41062.58937410625, 45962.54037459625, 46043.0, 46070.30894536576, 46114.76942615287, 46125.538744612546, 46231.537684623145, 46487.53512464874, 46520.0, 46637.30044049342, 8912.46525208488, 9111.954440227822, 9118.726438206864, 9123.589438475285, 9131.2238459731, 9045.0, 9058.094190580956, 9095.363324567283, 9141.588628511732, 9167.679131230409, 9162.083791620851, 9175.082491750838, 9213.03263157369, 9215.95392023039, 9229.169374756271, 9089.590968406404, 9162.679306224283, 9164.541772911327, 9168.404053736553, 9182.219511341544, 9018.413803102843, 9076.22852057576, 9125.087491250822, 9134.725958221265, 9139.223166030895, 42889.14221715548, 43169.784151079046, 43278.0, 43303.56696433027, 43313.0, 3636.709063274932, 3817.751846129993, 4402.471703395581, 4567.703079422976, 4609.262517997105, 34638.82680586606, 34646.48030279548, 34666.30667386663, 34728.0, 36729.0, 4705.176594096054, 4816.494268101834, 4876.926846097312, 4891.486393928657, 4994.300797888299, 389860.0, 392188.0, 393658.0, 394540.0, 396490.01754991326, 69564.65217673879, 70771.29228707647, 70796.29203707897, 70911.2908870915, 70931.645341774, 40454.79772601177, 40903.18193636111, 41329.793351033055, 43498.782506087264, 43574.56425435705, 17142.142892855307, 17358.0, 17358.826411735972, 17396.3041478342, 17407.73888391675, 12454.750904981849, 12491.0, 12546.81179782304, 12565.120441569003, 12618.305993170463, 21705.67441488379, 22246.0, 22400.439989000406, 22415.32754017382, 22600.09599615997, 7836.412269079842, 7844.333231675371, 8036.879446808302, 8077.959610202029, 8199.344052475906, 989.7129832348683, 1082.1667316166508, 1093.1801149138146, 1143.1197977557235, 1195.1992165249303, 34173.0, 34199.0, 34299.657003429646, 34466.65533344685, 34900.0, 1143.6854864912216, 1151.8099513580332, 1185.25921299188, 1203.1096988228824, 1223.2904915149193, 17438.302467901143, 17952.102394880203, 18032.90983545074, 18156.909215453838, 18257.269709211483, 720068.0, 733980.0, 735456.0, 1047683.0, 1065375.0, 63282.0, 63863.36136638574, 64138.67930660317, 64413.35586644074, 64558.35441645524, 1425.5865798918198, 1448.6821086262107, 1451.0495625365402, 1452.6949340638373, 1477.6379786952266, 32516.212710764674, 34801.30397392088, 34913.47629785504, 34919.65080349164, 34926.0, 57096.71451642715, 57844.421555785586, 57973.71013144907, 58049.0, 58097.0, 510099.0, 515976.0, 516142.0, 517625.0, 518858.0, 30865.69134308718, 31143.22141946379, 31275.0, 31487.055388338387, 31598.52602210923, 49729.75135124301, 50642.240366393795, 50748.49251507438, 51438.48561514337, 51675.0, 42997.785011074746, 43229.27082916774, 43487.56512434962, 44055.33916991312, 44783.10433791241, 45231.77384113058, 45511.0, 45855.77072114618, 46319.0, 46853.29720054134, 38909.80545097256, 42947.14105717931, 44207.77896110499, 44246.0, 45377.546224537335, 37790.0, 38866.6113338863, 39108.21783564256, 39332.0, 39378.80310598428, 29747.492908226355, 30415.239619009702, 30441.391172176875, 30596.235094122825, 30922.99000564956], "value": 21699.476783438473, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.4526389374347, 410.6283813149101, 418.8910883170376, 421.3511192763145, 428.78775006371853, 18821.811781882177, 19717.408477745692, 19796.50508737282, 20259.290924817633, 20852.478688032807, 19504.0, 19544.218231270734, 19900.50248743782, 20045.398638040846, 20110.497237569067, 4885.096257192422, 5126.231065340192, 5162.664426812264, 5221.817236396727, 5226.05930932432, 5177.715225662587, 5200.141976573861, 5618.297712785902, 5792.507636850873, 5833.708314584275, 5769.82690519283, 5841.64950102993, 5954.672493012882, 5996.640201587918, 6009.669468179249, 5455.672659640414, 5697.6011679182475, 5726.3987281335485, 5801.593888427812, 5814.6511209327155, 5660.632058916157, 5708.40061793514, 5874.1776151338845, 5895.263092113486, 5929.110633404981, 12880.677983050406, 13129.212247265099, 18151.0, 24316.39209019771, 24605.384865378328, 2388.211890076288, 2395.8921848516857, 2426.5632186206476, 2468.9506209875703, 2661.640678508396, 9599.088086631758, 9638.277129215337, 10027.197824174122, 10144.239182061376, 10210.183185345155, 1974.0919177178514, 1999.2902519605475, 2040.4898775306174, 2071.9378418647466, 2097.643400621898, 84899.57550212271, 85802.0, 87808.5609571948, 87935.12064879398, 88156.0, 9954.651587194558, 9957.850632240523, 10744.623938162127, 11133.888661113286, 11533.88466115328, 15703.528894132965, 15729.68540629181, 15768.211589420484, 15812.92093539548, 15917.283722232527, 8060.959695201604, 8062.919370806217, 8167.305779008851, 8247.95876020616, 8265.545395003333, 7315.122185337687, 7514.286142816423, 7524.134724506752, 7611.619419029026, 7659.463837531431, 4942.555170034714, 4988.850334489971, 5005.574526165244, 5047.520485553867, 5071.391433027987, 1992.3524854422371, 2144.678298255243, 2153.644648632958, 2155.622766015941, 2158.7733288004533, 974.9658761943298, 1023.3655133816932, 1055.5091882274778, 1067.7223921780237, 1108.9908183552927, 20455.488612784502, 20544.58910821775, 20558.588828223652, 20784.896075519526, 21281.78718212798, 1002.997002997003, 1055.3562326980536, 1075.2043487819114, 1120.781447617723, 1132.620572108353, 10920.836187457195, 11329.773404531863, 11360.659180224606, 11436.885631143748, 11518.539258429737, 213501.0, 528945.0, 530805.0, 533293.0, 536649.0, 92412.34537048607, 93632.53183734174, 95106.52446737722, 102537.48731256295, 105930.0, 453.6053633339016, 473.1577791531149, 476.67586041491427, 477.88769639134773, 480.22923208250955, 10603.098736607166, 10640.467976600985, 10990.725231869268, 11020.953009464089, 11075.169362297698, 38563.22873542457, 38651.22697546089, 44036.559634403246, 44546.554534455536, 44730.329045065, 65133.67433162804, 67988.66005670138, 68177.0, 68983.0, 69941.0, 8535.10381409943, 8651.653933842828, 8810.471371717718, 9002.86495702578, 9151.63393464254, 12586.87413125857, 13982.790258145933, 14054.648633784238, 14107.576772696835, 14207.431702731776, 11950.46222919988, 11969.64091077269, 12280.078994075302, 12286.078544109407, 12314.50741970347, 11782.175247732577, 11859.34773587461, 11926.761464770829, 12190.51237950472, 12262.38688065611, 11690.88309116898, 12243.693907652023, 12343.382830858602, 12534.749305014031, 12631.557895473614, 8023.157568455462, 8043.879341809995, 8299.668013279643, 8410.579471026547, 8849.380543361904, 8311.584420778816, 8566.314694824523, 8629.0, 8759.737207883774, 8844.425112367675], "value": 9002.619920115218, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1533.8772898168145, 1563.874890008799, 1757.5869670627408, 1871.1860340751766, 1885.65115453641, 8712.477251364906, 9345.485998270093, 9372.765680857974, 10113.342632728876, 10117.190624750021, 9350.111739384765, 9818.803623927517, 9836.163926066292, 9843.0, 9862.16171625411, 2522.836015658981, 2570.023391111375, 2571.1643715792347, 2574.832635878671, 2576.3687896465394, 2471.4315707387223, 2542.2627438042946, 2544.4656622109287, 2562.743725627441, 2567.6533667954773, 2462.704475462938, 2476.6037434010564, 2487.4154573675173, 2495.36368226103, 2506.9247922562263, 2466.9259922202364, 2488.377905523619, 2492.339530024536, 2526.5831137862233, 2534.214393538009, 2450.130203777651, 2455.1284294075526, 2456.8157388195955, 2466.075221791828, 2496.737842526527, 9629.0, 9861.654842080565, 9883.752906177331, 9885.604575816958, 9936.95031524845, 5848.7075646217945, 6005.159277701126, 6036.426539478743, 6038.547108966845, 6039.124326972608, 3573.0, 3677.3380791457794, 3693.316736403774, 3746.7751934883995, 3757.3424650686293, 1236.0, 1257.063487701668, 1269.5873841001712, 1333.3066805261308, 1342.5166939901726, 13171.341432928411, 13497.730045399037, 13592.184468931895, 13913.721725565432, 13933.094348867291, 4879.365682461257, 4902.632302577321, 5003.424606170337, 5055.974720126376, 5152.716600587004, 10854.34873907568, 10880.510377033053, 10882.401467919182, 10907.127429805596, 10934.4532773361, 5920.970395147997, 5939.287285525765, 5944.4352786485215, 5964.075568286922, 5986.910196347058, 4743.739094349775, 5216.061109000417, 5333.173358129496, 5349.518543331041, 5574.275344205308, 4131.409407378181, 4193.748375097504, 4301.290287102655, 4325.675574331937, 4365.694401391936, 1206.240068756695, 1280.929548874802, 1288.0404098946344, 1288.5940928607458, 1305.3799445263423, 886.8625363068605, 962.6245764151986, 977.6089564174245, 1039.594558122333, 1072.2333531524996, 6158.507319414436, 6220.129181914535, 6372.968135159294, 6570.06462765823, 6779.62712050832, 467.2080823004974, 471.9693219940693, 473.84145763608336, 476.3902205177379, 488.8875558621466, 4427.070315233773, 4444.82220711168, 4459.375687403766, 4492.775361231926, 4533.818647254139, 11716.23844450125, 12060.577879774166, 12432.75134497305, 12481.063920206021, 12516.3741812909, 12030.338331391857, 12352.135350525377, 12526.248425094524, 12538.623841284776, 12566.748665026831, 8993.595288212045, 9159.671847582063, 9163.49600771964, 9168.633254669872, 9204.217641500547, 6493.350664933658, 6681.966590167018, 6689.531732778659, 6743.932560674527, 6787.966060169865, 11049.558017679203, 11362.204645674723, 11626.418679066182, 11666.066714662977, 11679.708007299885, 11320.943395282971, 11446.141539384746, 11472.02487788514, 11612.593559225386, 11643.825342620037, 7915.960420197862, 8472.915270847212, 8627.568621569022, 8712.12878712149, 8865.601047952729, 9556.569954351931, 9670.806583868423, 9676.322657413913, 9688.273379496706, 9700.0, 7963.681452742057, 8246.340292776444, 8309.875351869849, 8388.916110838814, 8411.032731235742, 8197.79505512367, 8220.054693710299, 8254.380921430797, 8303.128171542143, 8324.6670133194, 7325.670344834602, 7500.287472690085, 7679.2704693054075, 7682.8079298018, 7913.050433947963, 5351.5718742501285, 5386.946130538645, 5402.945970540244, 5461.481159289861, 5540.695261760642, 5467.261919640957, 5513.09034009384, 5571.220029195835, 5571.637843540157, 5574.9163762542785], "value": 4972.917391808094, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.21379833206976, 330.6280434511175, 338.7019422907841, 339.73670405435786, 343.9535662685537, 5675.0, 5735.569832262587, 5748.223989761381, 5844.415558444153, 5862.413758624136, 5704.374253337789, 5758.7408566614495, 5766.481016708495, 5771.971140144294, 5777.0, 4539.568740969603, 4548.9090218195615, 4554.294084416921, 4565.0, 4576.473705523874, 4387.648988080962, 4474.673169951623, 4485.259932111214, 4517.254652982254, 4539.72887591475, 4427.358033085216, 4438.178936896668, 4447.644188464915, 4449.176902273073, 4452.265376212938, 4438.4451943507065, 4439.64482841372, 4453.354263631788, 4453.487848897385, 4454.109178164364, 3726.1802403471193, 3819.7135214858995, 3844.3272427325105, 3846.615338466159, 3849.5573009104032, 5577.972110139464, 5584.246126772874, 5612.07400778871, 5613.691246981414, 5618.15727640853, 5043.697378157322, 5059.849563935313, 5090.465501122366, 5108.386993560796, 5118.385793704742, 5744.626599271034, 5976.432238937337, 6023.69881505923, 6026.939730602681, 6044.818655440344, 4336.848210312655, 4347.80435380273, 4351.694491652492, 4352.368906508538, 4359.956400435986, 6072.908906366408, 6239.438450539428, 6310.5898116622275, 6317.5893566918, 6323.30443651198, 4401.163778882003, 4408.465132548798, 4414.779261036935, 4422.601965823092, 4429.7785110744335, 4446.3108218226225, 4456.420665313489, 4461.442319710036, 4469.195544801902, 4469.7318160910445, 4854.524192661697, 5055.823046193365, 5074.467180945948, 5105.310783044316, 5111.718855462911, 5954.374790647006, 6094.603850749687, 6134.570580059442, 6146.7706458708435, 6153.8307721532765, 1508.4494159631656, 1547.829738728739, 1551.5422950229708, 1555.5566663500847, 1555.7476231633418, 962.1725316228038, 991.4447909170743, 1004.7039319278196, 1011.5549158370441, 1018.2312354172552, 5258.684478931276, 5287.894242115136, 5291.550218231493, 5296.443873393316, 5306.787728490817, 5402.37872644643, 5518.448155184449, 5553.77784888608, 5599.524040456526, 5606.803761868315, 5038.5969122470115, 5229.921551176735, 5307.99148161848, 5326.866828329323, 5347.705876176769, 2964.4960356738975, 2969.792114551961, 2979.9404011920074, 2988.2529367658085, 2996.4007198560375, 5712.971435142797, 5722.567908638812, 5724.599278050497, 5728.513076388554, 5755.453231942959, 5950.047992321208, 6412.422881940648, 6441.0, 6467.579607325509, 6471.255805582324, 6536.0, 6540.738370465223, 6548.853950558633, 6562.639054852029, 6574.638394888231, 6110.2973158085615, 6274.498040156868, 6302.684865756602, 6310.327763142679, 6320.778772742932, 6221.222347206599, 6230.532710046674, 6282.43458088756, 6283.8114856554375, 6325.746970121144, 6393.155046004669, 6480.222373315232, 6482.448991835558, 6554.8361290968105, 6593.439557637463, 4416.668749843839, 4441.244988352052, 4444.555494478089, 4446.844360447369, 4450.709294304745, 6058.637456211669, 6125.632462052291, 6266.780662676784, 6325.995152302803, 6360.395762402564, 6126.203593532812, 6154.661493617894, 6179.81460556184, 6193.163922870535, 6196.81409557714, 5963.552733544915, 6130.172426722514, 6138.478229350555, 6141.232345956755, 6189.35011823752, 6010.248718910137, 6052.727627256696, 6076.483498902643, 6077.544184186292, 6078.422549857756, 6136.7852125175405, 6193.071039343954, 6212.596181248205, 6228.844278893064, 6239.719212635351, 5825.912611310749, 6039.610889495353, 6045.304789949212, 6053.334133245427, 6070.210872586712], "value": 4549.406591682181, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.6716212028828, 825.2655136928136, 843.4812590256994, 853.6073406233132, 922.1608336413865, 16713.0, 16957.660846783056, 16973.57566060849, 16988.74516882246, 17622.471325860228, 16751.162441877917, 17043.147842607883, 17047.829521704778, 17162.31350745972, 17176.0, 736.7126820539967, 866.7269810009858, 880.0847118996252, 884.6549845560237, 898.5552151684892, 888.3071204460531, 890.2655309369763, 891.2023738753811, 891.3760367742574, 896.1710417863483, 938.6573900526292, 939.8684184214216, 940.2384068904175, 940.9482478463682, 941.6139382853031, 930.3022732950287, 931.2363861633463, 931.2736065868634, 933.9579718912631, 935.0649350649351, 688.0161369241982, 689.5414549324693, 691.3639451704444, 691.4675699711245, 693.5907814389534, 15211.771823422658, 15214.923925380303, 15250.466233681878, 15308.617284567863, 15358.462453814063, 16647.16764161787, 16776.08751004769, 17015.31938722462, 17279.481615551555, 17316.740248896276, 13201.14192577489, 13222.0, 13249.602511924657, 13538.458461661521, 13550.661233469144, 4123.9175216495805, 4170.4995400551825, 4181.540030596632, 4187.958120418787, 4217.240896638604, 86533.0, 87074.12925870724, 87255.56372218161, 88351.55824220902, 90385.0, 12626.558070467674, 12887.226766394046, 12903.0, 12991.090623656253, 13032.674183145307, 25226.621600676004, 25316.987320506974, 25337.0, 25369.112081077445, 25458.490830183662, 8848.336374771789, 9003.909960900308, 9143.359964802534, 9202.171804537624, 9210.125038121369, 5011.924821127686, 5135.707449156196, 5233.005728911495, 5322.946770532322, 5537.889242215133, 3977.76133431995, 4119.114390406077, 4143.544210136883, 4178.728382655178, 4187.973946383156, 664.6410938093376, 665.653859992801, 680.146416247616, 699.720111955222, 700.8668353012911, 690.5856486108295, 719.3633634233636, 770.8034451215017, 787.42517961887, 798.9201079891965, 9967.252456065824, 10351.327163734484, 10442.269041167045, 10589.84115238272, 10971.067459266053, 703.282651695268, 704.9964750176216, 724.0195981195365, 770.7225398856407, 814.5316443045273, 4929.630277729185, 5338.91991620126, 5358.0, 5409.377921539073, 5451.809186678447, 69762.65118674374, 70442.64778676073, 71462.64268678623, 111230.44384778025, 111969.0, 100403.49798250962, 101829.49085254526, 104169.0, 105367.4731626337, 105516.0, 77425.61287193529, 78252.43495130066, 94313.0, 95517.52241238888, 96061.0, 10279.229057820543, 10425.791484170426, 10467.371957682259, 10635.89364106349, 11001.339919604849, 53311.733441332544, 54142.729286353315, 55773.0, 56369.43630563642, 56800.715996419756, 47197.528024719315, 47249.05501889874, 69382.65308673626, 77202.22797772175, 79004.0, 13143.802842957171, 13504.594862154152, 13845.930770346487, 13968.886443945818, 14135.434582616992, 14057.297135143406, 14267.500637477639, 14961.0, 14967.326470308644, 15798.76301855496, 14856.182909939625, 14869.776953345492, 15303.846961530242, 15342.846571534143, 15603.219839007777, 14107.929460352632, 14550.563483095524, 14892.702145957237, 15208.543743687707, 16115.838841611434, 13018.674533136747, 13781.862181378057, 14214.14715117055, 14376.712465750417, 15216.467423640119, 10487.790244195226, 11733.88266117362, 12323.59982750335, 12986.415611297703, 13229.735405291647, 11814.480087397029, 12387.132900697225, 12398.25610463375, 12676.492940282655, 12942.223466592035], "value": 8128.762882849814, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1501.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 104.0, 111.0, 111.0, 110.0, 110.0, 109.0, 111.0, 112.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 116.0, 148.0, 180.0, 118.0, 147.0, 154.0, 118.0, 166.0, 116.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 166.0, 162.0, 161.0, 161.0, 163.0, 162.0, 163.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 190.0, 75.0, 74.0, 73.0, 76.0, 176.0, 76.0], "value": 96.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 151.0, 84.0, 84.0, 84.0, 141.0, 83.0, 87.0, 141.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 54.0, 52.0, 53.0, 53.0, 51.0, 56.0, 52.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 59.0, 59.0, 63.0, 59.0, 59.0, 59.0, 61.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 73.0, 73.0, 76.0, 73.0, 73.0, 77.0, 72.0, 73.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 117.0, 126.0, 119.0, 119.0, 116.0, 124.0, 123.0, 162.0, 137.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 155.0, 150.0, 150.0, 153.0, 152.0, 158.0, 154.0, 152.0], "value": 153.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 66.0, 62.0, 63.0, 62.0, 62.0, 65.0, 61.0, 62.0], "value": 62.8, "unit": "score"}]}]} 15:12:03 INFO - Return code: 0 15:12:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:12:03 ERROR - # TBPL SUCCESS # 15:12:03 INFO - Running post-action listener: _resource_record_post_action 15:12:03 INFO - [mozharness: 2016-08-15 22:12:03.650924Z] Finished run-tests step (success) 15:12:03 INFO - Running post-run listener: _resource_record_post_run 15:12:03 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 328765440; Read time: 32; Write time: 254980 15:12:03 INFO - TinderboxPrint: CPU usage
13.3% 15:12:03 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 15:12:03 INFO - TinderboxPrint: I/O write bytes / time
328,765,440 / 254,980 15:12:03 INFO - TinderboxPrint: CPU idle
8,221.4 (86.7%) 15:12:03 INFO - TinderboxPrint: CPU user
1,200.3 (12.7%) 15:12:03 INFO - TinderboxPrint: Swap in / out
0 / 0 15:12:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 78352384; Read time: 0; Write time: 87732 15:12:03 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 262144; Write bytes: 249507840; Read time: 16; Write time: 167216 15:12:04 INFO - Running post-run listener: _upload_blobber_files 15:12:04 INFO - Blob upload gear active. 15:12:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:12:04 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 15:12:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:12:04 INFO - (blobuploader) - INFO - Open directory for files ... 15:12:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:12:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:12:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:12:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:12:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:12:05 INFO - (blobuploader) - INFO - Done attempting. 15:12:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:12:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:12:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:12:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:12:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:12:06 INFO - (blobuploader) - INFO - Done attempting. 15:12:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:12:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:12:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:12:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:12:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:12:10 INFO - (blobuploader) - INFO - Done attempting. 15:12:10 INFO - (blobuploader) - INFO - Iteration through files over. 15:12:10 INFO - Return code: 0 15:12:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:12:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:12:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e43eb4f07dc61c8a45e6501db85819327eab6632f98ad0549b1c24e2d94e5efb6bf6312a467e7f3bf646b9c62ce5a0b3b31e95c9bb686494d052e8f37a6ee7ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28678242753b465f78c41d53ea4fc76d5b03a3cb033d2328c5c9d5e429aa49e19073e7e0f39c33f57d8d200e72081db136d75b16c34383ae39d501f071c63801", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ce91568d4160b393a0c4f31794a045d146e875fae1663b64a51507a03a1a97a0bec977a149088faf5a8b064311aea997d29ac5ad924d941f26d8f6c10eabde6"} 15:12:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:12:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:12:10 INFO - Contents: 15:12:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e43eb4f07dc61c8a45e6501db85819327eab6632f98ad0549b1c24e2d94e5efb6bf6312a467e7f3bf646b9c62ce5a0b3b31e95c9bb686494d052e8f37a6ee7ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28678242753b465f78c41d53ea4fc76d5b03a3cb033d2328c5c9d5e429aa49e19073e7e0f39c33f57d8d200e72081db136d75b16c34383ae39d501f071c63801", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ce91568d4160b393a0c4f31794a045d146e875fae1663b64a51507a03a1a97a0bec977a149088faf5a8b064311aea997d29ac5ad924d941f26d8f6c10eabde6"} 15:12:10 INFO - Running post-run listener: copy_logs_to_upload_dir 15:12:10 INFO - Copying logs to upload dir... 15:12:10 INFO - mkdir: /builds/slave/test/build/upload/logs 15:12:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.041544 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-08-15 15:12:10.001476) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 15:12:10.004543) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e43eb4f07dc61c8a45e6501db85819327eab6632f98ad0549b1c24e2d94e5efb6bf6312a467e7f3bf646b9c62ce5a0b3b31e95c9bb686494d052e8f37a6ee7ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28678242753b465f78c41d53ea4fc76d5b03a3cb033d2328c5c9d5e429aa49e19073e7e0f39c33f57d8d200e72081db136d75b16c34383ae39d501f071c63801", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ce91568d4160b393a0c4f31794a045d146e875fae1663b64a51507a03a1a97a0bec977a149088faf5a8b064311aea997d29ac5ad924d941f26d8f6c10eabde6"} build_url:https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/RcuYPrIsScScbYr8dDsVSQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e43eb4f07dc61c8a45e6501db85819327eab6632f98ad0549b1c24e2d94e5efb6bf6312a467e7f3bf646b9c62ce5a0b3b31e95c9bb686494d052e8f37a6ee7ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28678242753b465f78c41d53ea4fc76d5b03a3cb033d2328c5c9d5e429aa49e19073e7e0f39c33f57d8d200e72081db136d75b16c34383ae39d501f071c63801", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ce91568d4160b393a0c4f31794a045d146e875fae1663b64a51507a03a1a97a0bec977a149088faf5a8b064311aea997d29ac5ad924d941f26d8f6c10eabde6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 15:12:10.029350) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:12:10.029656) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471297450.929305-1375172869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:12:10.114832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 15:12:10.115188) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 15:12:10.115492) ========= ========= Total master_lag: 0.15 =========