builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1472917471.21 results: success (0) buildid: 20160903060149 builduid: f87c0ad87a034d17a366f5c689f7a6dd revision: 99eeb3248e0a1070cfbe8d405a3c6bf1906a7e28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 08:44:31.207540) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 08:44:31.208050) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 08:44:31.208467) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 08:44:31.267569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 08:44:31.268248) ========= 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=fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-03 08:44:31-- 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% 50.3M=0s 2016-09-03 08:44:31 (50.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135886 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 08:44:31.418738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 08:44:31.419078) ========= 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=fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022324 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 08:44:31.470522) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 08:44:31.470916) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 99eeb3248e0a1070cfbe8d405a3c6bf1906a7e28 --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 99eeb3248e0a1070cfbe8d405a3c6bf1906a7e28 --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=fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-03 08:44:31,989 truncating revision to first 12 chars 2016-09-03 08:44:31,989 Setting DEBUG logging. 2016-09-03 08:44:31,989 attempt 1/10 2016-09-03 08:44:31,989 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/99eeb3248e0a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-03 08:44:32,373 unpacking tar archive at: mozilla-aurora-99eeb3248e0a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.805106 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 08:44:32.290104) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 08:44:32.290435) ========= script_repo_revision: 99eeb3248e0a1070cfbe8d405a3c6bf1906a7e28 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 08:44:32.290871) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 08:44:32.291175) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 08:44:32.301783) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 59 secs) (at 2016-09-03 08:44:32.302117) ========= /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=fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:44:32 INFO - MultiFileLogger online at 20160903 08:44:32 in /builds/slave/test 08:44:32 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 08:44:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:44:32 INFO - {'append_to_log': False, 08:44:32 INFO - 'base_work_dir': '/builds/slave/test', 08:44:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:44:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:44:32 INFO - 'branch': 'Mozilla-Aurora', 08:44:32 INFO - 'buildbot_json_path': 'buildprops.json', 08:44:32 INFO - 'config_files': ('talos/linux_config.py',), 08:44:32 INFO - 'default_actions': ('clobber', 08:44:32 INFO - 'read-buildbot-config', 08:44:32 INFO - 'download-and-extract', 08:44:32 INFO - 'populate-webroot', 08:44:32 INFO - 'create-virtualenv', 08:44:32 INFO - 'install', 08:44:32 INFO - 'run-tests'), 08:44:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:44:32 INFO - 'download_minidump_stackwalk': True, 08:44:32 INFO - 'download_symbols': 'ondemand', 08:44:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:44:32 INFO - 'tooltool.py': '/tools/tooltool.py', 08:44:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:44:32 INFO - '/tools/misc-python/virtualenv.py')}, 08:44:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:44:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:44:32 INFO - 'installer_path': 'installer.exe', 08:44:32 INFO - 'log_level': 'info', 08:44:32 INFO - 'log_name': 'talos', 08:44:32 INFO - 'log_to_console': True, 08:44:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:44:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:44:32 INFO - 'opt_config_files': (), 08:44:32 INFO - 'pip_index': False, 08:44:32 INFO - 'sps_profile': False, 08:44:32 INFO - 'sps_profile_interval': 0, 08:44:32 INFO - 'suite': 'dromaeojs-e10s', 08:44:32 INFO - 'system_bits': '32', 08:44:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:44:32 INFO - 'title': 'talos-linux64-ix-048', 08:44:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:44:32 INFO - 'use_talos_json': True, 08:44:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:44:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:44:32 INFO - 'work_dir': 'build'} 08:44:32 INFO - [mozharness: 2016-09-03 15:44:32.915731Z] Running clobber step. 08:44:32 INFO - Running pre-action listener: _resource_record_pre_action 08:44:32 INFO - Running main action method: clobber 08:44:32 INFO - rmtree: /builds/slave/test/build 08:44:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:44:33 INFO - Running post-action listener: _resource_record_post_action 08:44:33 INFO - [mozharness: 2016-09-03 15:44:33.374166Z] Finished clobber step (success) 08:44:33 INFO - [mozharness: 2016-09-03 15:44:33.374266Z] Running read-buildbot-config step. 08:44:33 INFO - Running pre-action listener: _resource_record_pre_action 08:44:33 INFO - Running main action method: read_buildbot_config 08:44:33 INFO - Using buildbot properties: 08:44:33 INFO - { 08:44:33 INFO - "project": "", 08:44:33 INFO - "product": "firefox", 08:44:33 INFO - "script_repo_revision": "production", 08:44:33 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 08:44:33 INFO - "repository": "", 08:44:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 08:44:33 INFO - "buildid": "20160903060149", 08:44:33 INFO - "pgo_build": "True", 08:44:33 INFO - "basedir": "/builds/slave/test", 08:44:33 INFO - "buildnumber": 533, 08:44:33 INFO - "slavename": "talos-linux64-ix-048", 08:44:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:44:33 INFO - "platform": "ubuntu64_hw", 08:44:33 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:44:33 INFO - "branch": "mozilla-aurora", 08:44:33 INFO - "repo_path": "releases/mozilla-aurora", 08:44:33 INFO - "revision": "99eeb3248e0a1070cfbe8d405a3c6bf1906a7e28", 08:44:33 INFO - "stage_platform": "linux64-pgo", 08:44:33 INFO - "builduid": "f87c0ad87a034d17a366f5c689f7a6dd", 08:44:33 INFO - "slavebuilddir": "test" 08:44:33 INFO - } 08:44:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 08:44:33 INFO - Running post-action listener: _resource_record_post_action 08:44:33 INFO - [mozharness: 2016-09-03 15:44:33.376967Z] Finished read-buildbot-config step (success) 08:44:33 INFO - [mozharness: 2016-09-03 15:44:33.377057Z] Running download-and-extract step. 08:44:33 INFO - Running pre-action listener: _resource_record_pre_action 08:44:33 INFO - Running main action method: download_and_extract 08:44:33 INFO - mkdir: /builds/slave/test/build/tests 08:44:33 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')]} 08:44:33 INFO - https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:44:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:44:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:44:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:44:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:44:33 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:44:33 INFO - retry: Failed, sleeping 30 seconds before retrying 08:45:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:45:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:45:03 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:45:03 INFO - retry: Failed, sleeping 60 seconds before retrying 08:46:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:46:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:46:03 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:46:03 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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! 08:46:03 INFO - Caught exception: HTTP Error 404: Not Found 08:46:03 INFO - Caught exception: HTTP Error 404: Not Found 08:46:03 INFO - Caught exception: HTTP Error 404: Not Found 08:46:03 INFO - trying https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:46:03 INFO - Downloading https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:46:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:46:04 INFO - Downloaded 1361 bytes. 08:46:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:46:04 INFO - Using the following test package requirements: 08:46:04 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 08:46:04 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:46:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:46:04 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:46:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:46:04 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:46:04 INFO - u'jsshell-linux-x86_64.zip'], 08:46:04 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:46:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:46:04 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 08:46:04 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:46:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:46:04 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:46:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:46:04 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:46:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:46:04 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:46:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:46:04 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:46: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')]} 08:46:04 INFO - https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:46:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:46:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:46:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:46:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:46:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:46:04 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:46:04 INFO - retry: Failed, sleeping 30 seconds before retrying 08:46:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:46:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:46:34 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:46:34 INFO - retry: Failed, sleeping 60 seconds before retrying 08:47:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:47:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:47:34 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:47:34 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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! 08:47:34 INFO - Caught exception: HTTP Error 404: Not Found 08:47:34 INFO - Caught exception: HTTP Error 404: Not Found 08:47:34 INFO - Caught exception: HTTP Error 404: Not Found 08:47:34 INFO - trying https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:47:34 INFO - Downloading https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:47:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:47:34 INFO - Downloaded 21770110 bytes. 08:47:34 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'] 08:47:34 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 08:47:36 INFO - Return code: 0 08:47:36 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 08:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:36 INFO - https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:47:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:47:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:47:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:47:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:47:36 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:47:36 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:47:36 INFO - retry: Failed, sleeping 30 seconds before retrying 08:48:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:48:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:48:06 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:48:06 INFO - retry: Failed, sleeping 60 seconds before retrying 08:49:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:49:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:49:06 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:49:06 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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! 08:49:06 INFO - Caught exception: HTTP Error 404: Not Found 08:49:06 INFO - Caught exception: HTTP Error 404: Not Found 08:49:06 INFO - Caught exception: HTTP Error 404: Not Found 08:49:06 INFO - trying https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:49:06 INFO - Downloading https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:49:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:49:07 INFO - Downloaded 21770110 bytes. 08:49:07 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'] 08:49:07 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 08:49:08 INFO - Return code: 0 08:49:08 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')]} 08:49:08 INFO - https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:49:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:49:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:49:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:49:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:49:08 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:49:08 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:49:08 INFO - retry: Failed, sleeping 30 seconds before retrying 08:49:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:49:38 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:49:38 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:49:38 INFO - retry: Failed, sleeping 60 seconds before retrying 08:50:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:50:38 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:50:38 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:50:38 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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! 08:50:38 INFO - Caught exception: HTTP Error 404: Not Found 08:50:38 INFO - Caught exception: HTTP Error 404: Not Found 08:50:38 INFO - Caught exception: HTTP Error 404: Not Found 08:50:38 INFO - trying https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:50:38 INFO - Downloading https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:50:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:50:39 INFO - Downloaded 14413740 bytes. 08:50:39 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'] 08:50:39 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 08:50:39 INFO - Return code: 0 08:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:39 INFO - https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:50:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:50:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:50:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:50:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:50:39 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:50:39 INFO - retry: Failed, sleeping 30 seconds before retrying 08:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:51:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:51:09 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:51:09 INFO - retry: Failed, sleeping 60 seconds before retrying 08:52:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:52:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:52:09 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:52:09 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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! 08:52:09 INFO - Caught exception: HTTP Error 404: Not Found 08:52:09 INFO - Caught exception: HTTP Error 404: Not Found 08:52:09 INFO - Caught exception: HTTP Error 404: Not Found 08:52:09 INFO - trying https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:52:09 INFO - Downloading https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:52:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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 08:52:12 INFO - Downloaded 63893145 bytes. 08:52:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:52:12 INFO - mkdir: /builds/slave/test/properties 08:52:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:52:12 INFO - Writing to file /builds/slave/test/properties/build_url 08:52:12 INFO - Contents: 08:52:12 INFO - build_url:https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:52:13 INFO - Running post-action listener: _resource_record_post_action 08:52:13 INFO - Running post-action listener: set_extra_try_arguments 08:52:13 INFO - [mozharness: 2016-09-03 15:52:13.705340Z] Finished download-and-extract step (success) 08:52:13 INFO - [mozharness: 2016-09-03 15:52:13.705572Z] Running populate-webroot step. 08:52:13 INFO - Running pre-action listener: _resource_record_pre_action 08:52:13 INFO - Running main action method: populate_webroot 08:52:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:52:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:52:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:52:13 INFO - '--tppagecycles', 08:52:13 INFO - '7'], 08:52:13 INFO - 'tests': ['tsvgm']}}, 08:52:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:52:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:52:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:52:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:52:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:52:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:52:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:13 INFO - 'talos_options': ['--disable-e10s'], 08:52:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:13 INFO - 'talos_options': ['--disable-e10s'], 08:52:13 INFO - 'tests': ['damp', 'tps']}, 08:52:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:13 INFO - 'tests': ['damp', 'tps']}, 08:52:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:52:13 INFO - 'tests': ['dromaeo_dom']}, 08:52:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:52:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:52:13 INFO - 'tests': ['basic_compositor_video']}, 08:52:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:52:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:52:13 INFO - 'tests': ['a11yr', 08:52:13 INFO - 'ts_paint', 08:52:13 INFO - 'tpaint', 08:52:13 INFO - 'sessionrestore', 08:52:13 INFO - 'sessionrestore_no_auto_restore', 08:52:13 INFO - 'tabpaint']}, 08:52:13 INFO - 'other-e10s': {'tests': ['a11yr', 08:52:13 INFO - 'ts_paint', 08:52:13 INFO - 'tpaint', 08:52:13 INFO - 'sessionrestore', 08:52:13 INFO - 'sessionrestore_no_auto_restore', 08:52:13 INFO - 'tabpaint']}, 08:52:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:52:13 INFO - 'ts_paint', 08:52:13 INFO - 'tpaint', 08:52:13 INFO - 'sessionrestore', 08:52:13 INFO - 'sessionrestore_no_auto_restore', 08:52:13 INFO - 'tabpaint']}, 08:52:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:52:13 INFO - 'ts_paint', 08:52:13 INFO - 'tpaint', 08:52:13 INFO - 'sessionrestore', 08:52:13 INFO - 'sessionrestore_no_auto_restore', 08:52:13 INFO - 'tabpaint']}, 08:52:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:52:13 INFO - 'tests': ['a11yr', 08:52:13 INFO - 'ts_paint', 08:52:13 INFO - 'tpaint', 08:52:13 INFO - 'sessionrestore', 08:52:13 INFO - 'sessionrestore_no_auto_restore', 08:52:13 INFO - 'tabpaint']}, 08:52:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:52:13 INFO - 'tests': ['a11yr', 08:52:13 INFO - 'ts_paint', 08:52:13 INFO - 'tpaint', 08:52:13 INFO - 'sessionrestore', 08:52:13 INFO - 'sessionrestore_no_auto_restore', 08:52:13 INFO - 'tabpaint']}, 08:52:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:52:13 INFO - 'tests': ['tsvgx', 08:52:13 INFO - 'tsvgr_opacity', 08:52:13 INFO - 'tart', 08:52:13 INFO - 'tscrollx', 08:52:13 INFO - 'cart']}, 08:52:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:52:13 INFO - 'tsvgr_opacity', 08:52:13 INFO - 'tart', 08:52:13 INFO - 'tscrollx', 08:52:13 INFO - 'cart']}, 08:52:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:13 INFO - 'talos_options': ['--disable-e10s'], 08:52:13 INFO - 'tests': ['tp5o']}, 08:52:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:13 INFO - 'tests': ['tp5o']}, 08:52:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:13 INFO - 'talos_options': ['--disable-e10s', 08:52:13 INFO - '--xperf_path', 08:52:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:52:13 INFO - 'tests': ['tp5n']}, 08:52:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:13 INFO - 'talos_options': ['--xperf_path', 08:52:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:52:13 INFO - 'tests': ['tp5n']}}, 08:52:13 INFO - 'talos.zip': {'path': '', 08:52:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:52:13 INFO - Running post-action listener: _resource_record_post_action 08:52:13 INFO - [mozharness: 2016-09-03 15:52:13.725126Z] Finished populate-webroot step (success) 08:52:13 INFO - [mozharness: 2016-09-03 15:52:13.725214Z] Running create-virtualenv step. 08:52:13 INFO - Running pre-action listener: _resource_record_pre_action 08:52:13 INFO - Running main action method: create_virtualenv 08:52:13 INFO - Creating virtualenv /builds/slave/test/build/venv 08:52:13 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 08:52:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:52:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:52:13 INFO - Using real prefix '/usr' 08:52:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:52:14 INFO - Installing distribute.............................................................................................................................................................................................done. 08:52:16 INFO - Installing pip.................done. 08:52:16 INFO - Return code: 0 08:52:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:52: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')]} 08:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52: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')]} 08:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:16 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 0x2282030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2540570>, '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 0x2541470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2541900>, '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': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', '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 08:52:16 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 08:52:16 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 08:52:16 INFO - Using env: {'DISPLAY': ':0', 08:52:16 INFO - 'HOME': '/home/cltbld', 08:52:16 INFO - 'LANG': 'en_US.UTF-8', 08:52:16 INFO - 'LANGUAGE': 'en_US:en', 08:52:16 INFO - 'LOGNAME': 'cltbld', 08:52:16 INFO - 'MAIL': '/var/mail/cltbld', 08:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:16 INFO - 'MOZ_NO_REMOTE': '1', 08:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:16 INFO - 'NO_EM_RESTART': '1', 08:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:16 INFO - 'PWD': '/builds/slave/test', 08:52:16 INFO - 'SHELL': '/bin/bash', 08:52:16 INFO - 'SHLVL': '1', 08:52:16 INFO - 'TERM': 'linux', 08:52:16 INFO - 'TMOUT': '86400', 08:52:16 INFO - 'USER': 'cltbld', 08:52:16 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', 08:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:16 INFO - '_': '/tools/buildbot/bin/python'} 08:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:16 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 08:52:16 INFO - Cleaning up... 08:52:16 INFO - Return code: 0 08:52:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:52: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')]} 08:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52: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')]} 08:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:16 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 0x2282030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2540570>, '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 0x2541470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2541900>, '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': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', '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 08:52:16 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 08:52:16 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 08:52:16 INFO - Using env: {'DISPLAY': ':0', 08:52:16 INFO - 'HOME': '/home/cltbld', 08:52:16 INFO - 'LANG': 'en_US.UTF-8', 08:52:16 INFO - 'LANGUAGE': 'en_US:en', 08:52:16 INFO - 'LOGNAME': 'cltbld', 08:52:16 INFO - 'MAIL': '/var/mail/cltbld', 08:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:16 INFO - 'MOZ_NO_REMOTE': '1', 08:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:16 INFO - 'NO_EM_RESTART': '1', 08:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:16 INFO - 'PWD': '/builds/slave/test', 08:52:16 INFO - 'SHELL': '/bin/bash', 08:52:16 INFO - 'SHLVL': '1', 08:52:16 INFO - 'TERM': 'linux', 08:52:16 INFO - 'TMOUT': '86400', 08:52:16 INFO - 'USER': 'cltbld', 08:52:16 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', 08:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:16 INFO - '_': '/tools/buildbot/bin/python'} 08:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:16 INFO - Downloading/unpacking psutil>=3.1.1 08:52:16 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 08:52:16 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 08:52:16 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 08:52:16 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 08:52:16 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 08:52:16 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 08:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:52:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:52:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:52:18 INFO - Installing collected packages: psutil 08:52:18 INFO - Running setup.py install for psutil 08:52:18 INFO - building 'psutil._psutil_linux' extension 08:52:18 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 08:52:18 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 08:52:19 INFO - building 'psutil._psutil_posix' extension 08:52:19 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 08:52:19 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 08:52:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:52:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:52:19 INFO - Successfully installed psutil 08:52:19 INFO - Cleaning up... 08:52:19 INFO - Return code: 0 08:52:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:52:19 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')]} 08:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:19 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')]} 08:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:19 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 0x2282030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2540570>, '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 0x2541470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2541900>, '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': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', '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 08:52:19 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 08:52:19 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 08:52:19 INFO - Using env: {'DISPLAY': ':0', 08:52:19 INFO - 'HOME': '/home/cltbld', 08:52:19 INFO - 'LANG': 'en_US.UTF-8', 08:52:19 INFO - 'LANGUAGE': 'en_US:en', 08:52:19 INFO - 'LOGNAME': 'cltbld', 08:52:19 INFO - 'MAIL': '/var/mail/cltbld', 08:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:19 INFO - 'MOZ_NO_REMOTE': '1', 08:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:19 INFO - 'NO_EM_RESTART': '1', 08:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:19 INFO - 'PWD': '/builds/slave/test', 08:52:19 INFO - 'SHELL': '/bin/bash', 08:52:19 INFO - 'SHLVL': '1', 08:52:19 INFO - 'TERM': 'linux', 08:52:19 INFO - 'TMOUT': '86400', 08:52:19 INFO - 'USER': 'cltbld', 08:52:19 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', 08:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:19 INFO - '_': '/tools/buildbot/bin/python'} 08:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:52:19 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 08:52:19 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 08:52:19 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 08:52:19 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 08:52:19 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 08:52:19 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 08:52:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:52:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:52:21 INFO - Installing collected packages: mozsystemmonitor 08:52:21 INFO - Running setup.py install for mozsystemmonitor 08:52:21 INFO - Successfully installed mozsystemmonitor 08:52:21 INFO - Cleaning up... 08:52:21 INFO - Return code: 0 08:52:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:52: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')]} 08:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52: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')]} 08:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:21 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 0x2282030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2540570>, '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 0x2541470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2541900>, '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': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', '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 08:52:21 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 08:52:21 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 08:52:21 INFO - Using env: {'DISPLAY': ':0', 08:52:21 INFO - 'HOME': '/home/cltbld', 08:52:21 INFO - 'LANG': 'en_US.UTF-8', 08:52:21 INFO - 'LANGUAGE': 'en_US:en', 08:52:21 INFO - 'LOGNAME': 'cltbld', 08:52:21 INFO - 'MAIL': '/var/mail/cltbld', 08:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:21 INFO - 'MOZ_NO_REMOTE': '1', 08:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:21 INFO - 'NO_EM_RESTART': '1', 08:52:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:21 INFO - 'PWD': '/builds/slave/test', 08:52:21 INFO - 'SHELL': '/bin/bash', 08:52:21 INFO - 'SHLVL': '1', 08:52:21 INFO - 'TERM': 'linux', 08:52:21 INFO - 'TMOUT': '86400', 08:52:21 INFO - 'USER': 'cltbld', 08:52:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', 08:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:21 INFO - '_': '/tools/buildbot/bin/python'} 08:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:21 INFO - Downloading/unpacking jsonschema==2.5.1 08:52:21 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 08:52:21 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 08:52:21 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 08:52:21 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 08:52:21 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 08:52:21 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 08:52:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:52:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:23 INFO - Downloading functools32-3.2.3-2.tar.gz 08:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:52:23 INFO - warning: no files found matching '*.txt' 08:52:23 INFO - no previously-included directories found matching 'build' 08:52:23 INFO - no previously-included directories found matching 'dist' 08:52:23 INFO - no previously-included directories found matching '.git*' 08:52:23 INFO - Installing collected packages: jsonschema, functools32 08:52:24 INFO - Running setup.py install for functools32 08:52:24 INFO - warning: no files found matching '*.txt' 08:52:24 INFO - no previously-included directories found matching 'build' 08:52:24 INFO - no previously-included directories found matching 'dist' 08:52:24 INFO - no previously-included directories found matching '.git*' 08:52:24 INFO - Successfully installed jsonschema functools32 08:52:24 INFO - Cleaning up... 08:52:24 INFO - Return code: 0 08:52:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:52:24 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')]} 08:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:24 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')]} 08:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:24 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 0x2282030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2540570>, '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 0x2541470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2541900>, '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': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', '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 08:52:24 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 08:52:24 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 08:52:24 INFO - Using env: {'DISPLAY': ':0', 08:52:24 INFO - 'HOME': '/home/cltbld', 08:52:24 INFO - 'LANG': 'en_US.UTF-8', 08:52:24 INFO - 'LANGUAGE': 'en_US:en', 08:52:24 INFO - 'LOGNAME': 'cltbld', 08:52:24 INFO - 'MAIL': '/var/mail/cltbld', 08:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:24 INFO - 'MOZ_NO_REMOTE': '1', 08:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:24 INFO - 'NO_EM_RESTART': '1', 08:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:24 INFO - 'PWD': '/builds/slave/test', 08:52:24 INFO - 'SHELL': '/bin/bash', 08:52:24 INFO - 'SHLVL': '1', 08:52:24 INFO - 'TERM': 'linux', 08:52:24 INFO - 'TMOUT': '86400', 08:52:24 INFO - 'USER': 'cltbld', 08:52:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', 08:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:24 INFO - '_': '/tools/buildbot/bin/python'} 08:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:52:24 INFO - Cleaning up... 08:52:24 INFO - Return code: 0 08:52:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:52:24 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')]} 08:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:24 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')]} 08:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:24 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 0x2282030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2540570>, '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 0x2541470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2541900>, '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': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', '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 08:52:24 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 08:52:24 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 08:52:24 INFO - Using env: {'DISPLAY': ':0', 08:52:24 INFO - 'HOME': '/home/cltbld', 08:52:24 INFO - 'LANG': 'en_US.UTF-8', 08:52:24 INFO - 'LANGUAGE': 'en_US:en', 08:52:24 INFO - 'LOGNAME': 'cltbld', 08:52:24 INFO - 'MAIL': '/var/mail/cltbld', 08:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:24 INFO - 'MOZ_NO_REMOTE': '1', 08:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:24 INFO - 'NO_EM_RESTART': '1', 08:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:24 INFO - 'PWD': '/builds/slave/test', 08:52:24 INFO - 'SHELL': '/bin/bash', 08:52:24 INFO - 'SHLVL': '1', 08:52:24 INFO - 'TERM': 'linux', 08:52:24 INFO - 'TMOUT': '86400', 08:52:24 INFO - 'USER': 'cltbld', 08:52:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', 08:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:24 INFO - '_': '/tools/buildbot/bin/python'} 08:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:24 INFO - Downloading/unpacking blobuploader==1.2.4 08:52:24 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 08:52:24 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 08:52:24 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 08:52:24 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 08:52:24 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 08:52:24 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 08:52:26 INFO - Downloading blobuploader-1.2.4.tar.gz 08:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:52:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:52:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:27 INFO - Downloading docopt-0.6.1.tar.gz 08:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:52:27 INFO - Installing collected packages: blobuploader, requests, docopt 08:52:27 INFO - Running setup.py install for blobuploader 08:52:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:52:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:52:27 INFO - Running setup.py install for requests 08:52:27 INFO - Running setup.py install for docopt 08:52:27 INFO - Successfully installed blobuploader requests docopt 08:52:27 INFO - Cleaning up... 08:52:27 INFO - Return code: 0 08:52:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:27 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')]} 08:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:27 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')]} 08:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:27 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 0x2282030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2540570>, '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 0x2541470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2541900>, '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': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', '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 08:52:27 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 08:52:27 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 08:52:27 INFO - Using env: {'DISPLAY': ':0', 08:52:27 INFO - 'HOME': '/home/cltbld', 08:52:27 INFO - 'LANG': 'en_US.UTF-8', 08:52:27 INFO - 'LANGUAGE': 'en_US:en', 08:52:27 INFO - 'LOGNAME': 'cltbld', 08:52:27 INFO - 'MAIL': '/var/mail/cltbld', 08:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:27 INFO - 'MOZ_NO_REMOTE': '1', 08:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:27 INFO - 'NO_EM_RESTART': '1', 08:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:27 INFO - 'PWD': '/builds/slave/test', 08:52:27 INFO - 'SHELL': '/bin/bash', 08:52:27 INFO - 'SHLVL': '1', 08:52:27 INFO - 'TERM': 'linux', 08:52:27 INFO - 'TMOUT': '86400', 08:52:27 INFO - 'USER': 'cltbld', 08:52:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', 08:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:27 INFO - '_': '/tools/buildbot/bin/python'} 08:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:28 INFO - Running setup.py (path:/tmp/pip-daBaC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:28 INFO - Running setup.py (path:/tmp/pip-NAhWs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:28 INFO - Running setup.py (path:/tmp/pip-uALSwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:28 INFO - Running setup.py (path:/tmp/pip-b1zlse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:28 INFO - Running setup.py (path:/tmp/pip-pwA1zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:28 INFO - Running setup.py (path:/tmp/pip-WfVbgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:28 INFO - Running setup.py (path:/tmp/pip-TqjU4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:28 INFO - Running setup.py (path:/tmp/pip-xamWXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:28 INFO - Running setup.py (path:/tmp/pip-a5YDwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:28 INFO - Running setup.py (path:/tmp/pip-UFEUMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:28 INFO - Running setup.py (path:/tmp/pip-2JAFpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:28 INFO - Running setup.py (path:/tmp/pip-o9T4wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:28 INFO - Running setup.py (path:/tmp/pip-4rImJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:29 INFO - Running setup.py (path:/tmp/pip-cC8vpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:29 INFO - Running setup.py (path:/tmp/pip-cKiQa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:29 INFO - Running setup.py (path:/tmp/pip-IkAI7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:29 INFO - Running setup.py (path:/tmp/pip-f2lcHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:52:29 INFO - Running setup.py install for manifestparser 08:52:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:52:29 INFO - Running setup.py install for mozcrash 08:52:29 INFO - Running setup.py install for mozdebug 08:52:29 INFO - Running setup.py install for mozdevice 08:52:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:52:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:52:29 INFO - Running setup.py install for mozfile 08:52:29 INFO - Running setup.py install for mozhttpd 08:52:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:52:29 INFO - Running setup.py install for mozinfo 08:52:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:52:30 INFO - Running setup.py install for mozInstall 08:52:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:52:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:52:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:52:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:52:30 INFO - Running setup.py install for mozleak 08:52:30 INFO - Running setup.py install for mozlog 08:52:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:52:30 INFO - Running setup.py install for moznetwork 08:52:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:52:30 INFO - Running setup.py install for mozprocess 08:52:30 INFO - Running setup.py install for mozprofile 08:52:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:52:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:52:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:52:30 INFO - Running setup.py install for mozrunner 08:52:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:52:30 INFO - Running setup.py install for mozscreenshot 08:52:30 INFO - Running setup.py install for moztest 08:52:30 INFO - Running setup.py install for mozversion 08:52:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:52:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:52:31 INFO - Cleaning up... 08:52:31 INFO - Return code: 0 08:52:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08: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')]} 08:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:31 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 0x2282030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2540570>, '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 0x2541470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2541900>, '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': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', '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 08:52:31 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 08:52:31 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 08:52:31 INFO - Using env: {'DISPLAY': ':0', 08:52:31 INFO - 'HOME': '/home/cltbld', 08:52:31 INFO - 'LANG': 'en_US.UTF-8', 08:52:31 INFO - 'LANGUAGE': 'en_US:en', 08:52:31 INFO - 'LOGNAME': 'cltbld', 08:52:31 INFO - 'MAIL': '/var/mail/cltbld', 08:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:31 INFO - 'MOZ_NO_REMOTE': '1', 08:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:31 INFO - 'NO_EM_RESTART': '1', 08:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:31 INFO - 'PWD': '/builds/slave/test', 08:52:31 INFO - 'SHELL': '/bin/bash', 08:52:31 INFO - 'SHLVL': '1', 08:52:31 INFO - 'TERM': 'linux', 08:52:31 INFO - 'TMOUT': '86400', 08:52:31 INFO - 'USER': 'cltbld', 08:52:31 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', 08:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:31 INFO - '_': '/tools/buildbot/bin/python'} 08:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:31 INFO - Running setup.py (path:/tmp/pip-DiuoDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:31 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)) 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:31 INFO - Running setup.py (path:/tmp/pip-H46VgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:31 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)) 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:31 INFO - Running setup.py (path:/tmp/pip-dVPk7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:31 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)) 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:31 INFO - Running setup.py (path:/tmp/pip-flk41Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:31 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)) 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:31 INFO - Running setup.py (path:/tmp/pip-vZyF4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:31 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)) 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:31 INFO - Running setup.py (path:/tmp/pip-wDXp3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:31 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)) 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:31 INFO - Running setup.py (path:/tmp/pip-Iim8sL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:31 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)) 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:31 INFO - Running setup.py (path:/tmp/pip-KC4KrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:31 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)) 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:31 INFO - Running setup.py (path:/tmp/pip-r6cO4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:31 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)) 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:31 INFO - Running setup.py (path:/tmp/pip-69yxrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:32 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)) 08:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:32 INFO - Running setup.py (path:/tmp/pip-Se0RUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:32 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)) 08:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:32 INFO - Running setup.py (path:/tmp/pip-xkWKMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:32 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)) 08:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:32 INFO - Running setup.py (path:/tmp/pip-b3IYuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:32 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)) 08:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:32 INFO - Running setup.py (path:/tmp/pip-1R21RX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:32 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)) 08:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:32 INFO - Running setup.py (path:/tmp/pip-2KF0SM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:32 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)) 08:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:32 INFO - Running setup.py (path:/tmp/pip-3QClg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:32 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)) 08:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:32 INFO - Running setup.py (path:/tmp/pip-VTNFRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:32 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)) 08:52:32 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)) 08:52:32 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)) 08:52:32 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)) 08:52:32 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)) 08:52:32 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)) 08:52:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:52:32 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 08:52:32 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 08:52:32 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 08:52:32 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 08:52:32 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 08:52:32 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 08:52:34 INFO - Downloading blessings-1.6.tar.gz 08:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:52:34 INFO - Installing collected packages: blessings 08:52:34 INFO - Running setup.py install for blessings 08:52:34 INFO - Successfully installed blessings 08:52:34 INFO - Cleaning up... 08:52:34 INFO - Return code: 0 08:52:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:52:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:34 INFO - Reading from file tmpfile_stdout 08:52:34 INFO - Current package versions: 08:52:34 INFO - argparse == 1.2.1 08:52:34 INFO - blessings == 1.6 08:52:34 INFO - blobuploader == 1.2.4 08:52:34 INFO - docopt == 0.6.1 08:52:34 INFO - functools32 == 3.2.3-2 08:52:34 INFO - jsonschema == 2.5.1 08:52:34 INFO - manifestparser == 1.1 08:52:34 INFO - mozInstall == 1.12 08:52:34 INFO - mozcrash == 0.17 08:52:34 INFO - mozdebug == 0.1 08:52:34 INFO - mozdevice == 0.48 08:52:34 INFO - mozfile == 1.2 08:52:34 INFO - mozhttpd == 0.7 08:52:34 INFO - mozinfo == 0.9 08:52:34 INFO - mozleak == 0.1 08:52:34 INFO - mozlog == 3.3 08:52:34 INFO - moznetwork == 0.27 08:52:34 INFO - mozprocess == 0.23 08:52:34 INFO - mozprofile == 0.28 08:52:34 INFO - mozrunner == 6.12 08:52:34 INFO - mozscreenshot == 0.1 08:52:34 INFO - mozsystemmonitor == 0.3 08:52:34 INFO - moztest == 0.7 08:52:34 INFO - mozversion == 1.4 08:52:34 INFO - psutil == 3.1.1 08:52:34 INFO - requests == 1.2.3 08:52:34 INFO - wsgiref == 0.1.2 08:52:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:34 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 0x2282030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2540570>, '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 0x2541470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2541900>, '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': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', '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 08:52:34 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 08:52:34 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 08:52:34 INFO - Using env: {'DISPLAY': ':0', 08:52:34 INFO - 'HOME': '/home/cltbld', 08:52:34 INFO - 'LANG': 'en_US.UTF-8', 08:52:34 INFO - 'LANGUAGE': 'en_US:en', 08:52:34 INFO - 'LOGNAME': 'cltbld', 08:52:34 INFO - 'MAIL': '/var/mail/cltbld', 08:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:34 INFO - 'MOZ_NO_REMOTE': '1', 08:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:34 INFO - 'NO_EM_RESTART': '1', 08:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:34 INFO - 'PWD': '/builds/slave/test', 08:52:34 INFO - 'SHELL': '/bin/bash', 08:52:34 INFO - 'SHLVL': '1', 08:52:34 INFO - 'TERM': 'linux', 08:52:34 INFO - 'TMOUT': '86400', 08:52:34 INFO - 'USER': 'cltbld', 08:52:34 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', 08:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:34 INFO - '_': '/tools/buildbot/bin/python'} 08:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:35 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)) 08:52:35 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)) 08:52:35 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)) 08:52:35 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)) 08:52:35 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)) 08:52:35 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)) 08:52:35 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)) 08:52:35 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)) 08:52:35 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)) 08:52:35 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)) 08:52:35 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)) 08:52:35 INFO - Cleaning up... 08:52:35 INFO - Return code: 0 08:52:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2282030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2540570>, '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 0x2541470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2541900>, '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': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', '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 08:52:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:52:35 INFO - Using env: {'DISPLAY': ':0', 08:52:35 INFO - 'HOME': '/home/cltbld', 08:52:35 INFO - 'LANG': 'en_US.UTF-8', 08:52:35 INFO - 'LANGUAGE': 'en_US:en', 08:52:35 INFO - 'LOGNAME': 'cltbld', 08:52:35 INFO - 'MAIL': '/var/mail/cltbld', 08:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:35 INFO - 'MOZ_NO_REMOTE': '1', 08:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:35 INFO - 'NO_EM_RESTART': '1', 08:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:35 INFO - 'PWD': '/builds/slave/test', 08:52:35 INFO - 'SHELL': '/bin/bash', 08:52:35 INFO - 'SHLVL': '1', 08:52:35 INFO - 'TERM': 'linux', 08:52:35 INFO - 'TMOUT': '86400', 08:52:35 INFO - 'USER': 'cltbld', 08:52:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', 08:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:35 INFO - '_': '/tools/buildbot/bin/python'} 08:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:52:35 INFO - Cleaning up... 08:52:35 INFO - Return code: 0 08:52:35 INFO - Running post-action listener: _resource_record_post_action 08:52:35 INFO - Running post-action listener: _start_resource_monitoring 08:52:35 INFO - Starting resource monitoring. 08:52:35 INFO - [mozharness: 2016-09-03 15:52:35.381128Z] Finished create-virtualenv step (success) 08:52:35 INFO - [mozharness: 2016-09-03 15:52:35.381602Z] Running install step. 08:52:35 INFO - Running pre-action listener: _resource_record_pre_action 08:52:35 INFO - Running main action method: install 08:52:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:35 INFO - Reading from file tmpfile_stdout 08:52:35 INFO - Detecting whether we're running mozinstall >=1.0... 08:52:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:52:35 INFO - Reading from file tmpfile_stdout 08:52:35 INFO - Output received: 08:52:35 INFO - Usage: mozinstall [options] installer 08:52:35 INFO - Options: 08:52:35 INFO - -h, --help show this help message and exit 08:52:35 INFO - -d DEST, --destination=DEST 08:52:35 INFO - Directory to install application into. [default: 08:52:35 INFO - "/builds/slave/test"] 08:52:35 INFO - --app=APP Application being installed. [default: firefox] 08:52:35 INFO - mkdir: /builds/slave/test/build/application 08:52:35 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'] 08:52:35 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 08:52:52 INFO - Reading from file tmpfile_stdout 08:52:52 INFO - Output received: 08:52:52 INFO - /builds/slave/test/build/application/firefox/firefox 08:52:52 INFO - Running post-action listener: _resource_record_post_action 08:52:52 INFO - [mozharness: 2016-09-03 15:52:52.302668Z] Finished install step (success) 08:52:52 INFO - [mozharness: 2016-09-03 15:52:52.302948Z] Running run-tests step. 08:52:52 INFO - Running pre-action listener: _resource_record_pre_action 08:52:52 INFO - Running main action method: run_tests 08:52:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:52:52 INFO - Python 2.7.3 08:52:52 INFO - Return code: 0 08:52:52 INFO - grabbing minidump binary from tooltool 08:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:52 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 0x2540570>, '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 0x2541470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2541900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:52:52 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 08:52:52 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 08:52:52 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 08:52:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:52:52 INFO - Return code: 0 08:52:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:52:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:52:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:52:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:52:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:52:52 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/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 08:52:52 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/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 08:52:52 INFO - Using env: {'DISPLAY': ':0', 08:52:52 INFO - 'HOME': '/home/cltbld', 08:52:52 INFO - 'LANG': 'en_US.UTF-8', 08:52:52 INFO - 'LANGUAGE': 'en_US:en', 08:52:52 INFO - 'LOGNAME': 'cltbld', 08:52:52 INFO - 'MAIL': '/var/mail/cltbld', 08:52:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:52:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:52 INFO - 'MOZ_NO_REMOTE': '1', 08:52:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:52 INFO - 'NO_EM_RESTART': '1', 08:52:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:52 INFO - 'PWD': '/builds/slave/test', 08:52:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:52:52 INFO - 'SHELL': '/bin/bash', 08:52:52 INFO - 'SHLVL': '1', 08:52:52 INFO - 'TERM': 'linux', 08:52:52 INFO - 'TMOUT': '86400', 08:52:52 INFO - 'USER': 'cltbld', 08:52:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763', 08:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:52 INFO - '_': '/tools/buildbot/bin/python'} 08:52:52 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/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 08:52:52 INFO - mozversion application_buildid: 20160903060149 08:52:52 INFO - mozversion application_changeset: 99eeb3248e0a1070cfbe8d405a3c6bf1906a7e28 08:52:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:52:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:52:52 INFO - mozversion application_name: Firefox 08:52:52 INFO - mozversion application_remotingname: firefox-dev 08:52:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:52:52 INFO - mozversion application_vendor: Mozilla 08:52:52 INFO - mozversion application_version: 50.0a2 08:52:52 INFO - mozversion platform_buildid: 20160903060149 08:52:52 INFO - mozversion platform_changeset: 99eeb3248e0a1070cfbe8d405a3c6bf1906a7e28 08:52:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:52:52 INFO - mozversion platform_version: 50.0a2 08:52:52 INFO - using testdate: 1472917972 08:52:52 INFO - actual date: 1472917972 08:52:52 INFO - starting webserver on 'localhost:43471' 08:52:52 INFO - SUITE-START | Running 2 tests 08:52:52 INFO - TEST-START | dromaeo_css 08:52:52 INFO - operating with platform_type : linux_ 08:52:52 INFO - Initialising browser for dromaeo_css test... 08:52:52 INFO - TEST-INFO | started process 8701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiJ_gk7/profile http://localhost:43471/getInfo.html) 08:52:57 INFO - PROCESS | 8701 | __metrics Screen width/height:1600/1200 08:52:57 INFO - PROCESS | 8701 | colorDepth:24 08:52:57 INFO - PROCESS | 8701 | Browser inner width/height: 1024/697 08:52:57 INFO - PROCESS | 8701 | __metrics 08:52:58 ERROR - PROCESS | 8701 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:52:58 INFO - TEST-INFO | 8701: exit 0 08:52:58 INFO - Browser initialized. 08:52:58 INFO - Running cycle 1/1 for dromaeo_css test... 08:52:58 INFO - TEST-INFO | started process 8828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiJ_gk7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:53:10 INFO - PROCESS | 8828 | RSS: Main: 152162304 08:53:10 INFO - PROCESS | 8828 | 08:54:00 INFO - PROCESS | 8828 | 1472918040327 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] 08:56:08 INFO - PROCESS | 8828 | Cycle 1(1): loaded http://localhost:43471/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43471/tests/dromaeo/cssquery-ext.html) 08:56:10 INFO - PROCESS | 8828 | RSS: Main: 157122560 08:56:10 INFO - PROCESS | 8828 | 08:59:12 INFO - PROCESS | 8828 | Cycle 1(1): loaded http://localhost:43471/tests/dromaeo/cssquery-ext.html (next: http://localhost:43471/tests/dromaeo/cssquery-jquery.html) 08:59:12 INFO - PROCESS | 8828 | RSS: Main: 154050560 08:59:12 INFO - PROCESS | 8828 | 09:02:14 INFO - PROCESS | 8828 | Cycle 1(1): loaded http://localhost:43471/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43471/tests/dromaeo/cssquery-mootools.html) 09:02:15 INFO - PROCESS | 8828 | RSS: Main: 154214400 09:02:15 INFO - PROCESS | 8828 | 09:05:16 INFO - PROCESS | 8828 | Cycle 1(1): loaded http://localhost:43471/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43471/tests/dromaeo/cssquery-prototype.html) 09:05:17 INFO - PROCESS | 8828 | RSS: Main: 152838144 09:05:17 INFO - PROCESS | 8828 | 09:08:20 INFO - PROCESS | 8828 | Cycle 1(1): loaded http://localhost:43471/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43471/tests/dromaeo/cssquery-yui.html) 09:08:20 INFO - PROCESS | 8828 | RSS: Main: 155336704 09:08:20 INFO - PROCESS | 8828 | 09:11:23 INFO - PROCESS | 8828 | Cycle 1(1): loaded http://localhost:43471/tests/dromaeo/cssquery-yui.html (next: http://localhost:43471/tests/dromaeo/cssquery-dojo.html) 09:11:23 INFO - PROCESS | 8828 | RSS: Main: 155852800 09:11:23 INFO - PROCESS | 8828 | 09:11:23 INFO - PROCESS | 8828 | __start_tp_report 09:11:23 INFO - PROCESS | 8828 | _x_x_mozilla_page_load 09:11:23 INFO - PROCESS | 8828 | _x_x_mozilla_page_load_details 09:11:23 INFO - PROCESS | 8828 | |i|pagename|runs| 09:11:23 INFO - PROCESS | 8828 | |0;dojo.html;3258.6415494295625;3272.9526551503527;3282.819444930528;3291.1936575539;3299.208190034391;5663.207150998858;5729.570282228829;5732.79935202268;5749.971250143749;5752.36723960364;5739.684317362543;5805.622634528752;5828.154917536955;5842.0652695568715;5846.181534585162;5213.426523082458;5220.921686174692;5262.789488420478;5318.867028324285;5322.175062865262;5106.234064890277;5127.435982041991;5133.871653208662;5166.250893620441;5214.556762675177;5204.765785539641;5236.685798852062;5240.868978275555;5287;5313;5252.606054545905;5299.814506492293;5305.761240744157;5306.469353064701;5313.521783039507;4995.700257984533;5036.597072234213;5168.173092305251;5200.453952334989;5250.7374631268285;5569.693666848321;5640;5642.548596112301;5660.2075709400715;5696;5972.880542389172;5990.2212712347555;6077.118817771398;6083.847903802396;6100.542459315525;5953.553483488712;6065.029595264737;6132.264128304588;6135.938640613582;6143.662098584576;5655.236543066674;5732.627379220296;5737.77048918047;5768.077107662753;5768.42315768424;6267.71795269214;6268;6280;6282.560220784501;6313.968430157912;5853.473187413068;5958.791442299499;5984.850378740566;5986;6025.849353766103;6143.354947730424;6172.197614310111;6180.567360284737;6180.81457556274;6184.628922264678;6018.337982821886;6020.759169633253;6032.487238584682;6037.45662890342;6044.516438684895;5979.850503737354;5987.31145918225;6031.547633927473;6044.304904935901;6046.274447066292;4649.372334734835;4687.250039993584;4698.436187657435;4705.952940470552;4720.480747117815;4185.476815398075;4193.643540299047;4194.874153775391;4196.265653510623;4202.936955945664;5643.492085712305;5866.2960444746905;5896.823095307148;5901.3508514063415;5903.76384944606;6101.298350689727;6164.630122192682;6173.47525460332;6190.845228869224;6206.317305096436;5946.494547963472;5947.940520594825;5954.166416701665;5959.731812068468;5984.162217289583;5138.87152821175;5296.788128474818;5347.385050719139;5348.893022139613;5349.839504814861;6331.240251169797;6385.201849768779;6428.935710642927;6429.742810287629;6430.77492287777;6116.480099191618;6126.479249263863;6133.723982420891;6133.969330153499;6141.785037523665;6139.706800529493;6153.907691384722;6234.532410069172;6401.167848179707;6402;5993.730282137227;5994.910076348945;6007.87984240304;6009.338972712911;6043.093535969464;6075.483583895419;6088.908666370096;6122.357152499102;6124.173236613178;6144.477719393902;5919.822405327847;5953.077273022688;5968.313643931004;6021.7591296347655;6023.969880150571;5983.072623743326;6016.42843929826;6017.608855424383;6026.216591843032;6040.154378386941;5980.850478738066;5980.880382392241;6006.399360063959;6016.578839481369;6016.8796624068145;5829.766809327749;5866.41335866427;5877.823665290048;5911.911321330097;5998.280206375263;5802.129680547782;5836.503897168788;5857.384974577779;5872.677002764718;5924.407559244041 09:11:23 INFO - PROCESS | 8828 | |1;ext.html;588.2088590845315;653.340126472263;671.963042032688;674.5143496682389;720.5640587444599;41629.3755593666;46707.29939050917;46768.53231467684;46814.29778553324;47110.528894711046;46758.53241467584;46787;47283;47354.526454735445;47455.762721186344;9134.360594758353;9351.251899847995;9352.018038106004;9353.95323023384;9368.718938431824;9227.861582076273;9373.250139988784;9374.203192728626;9380.906190938105;9383.202427793645;9471.052894710543;9485.051494850495;9497.335186536946;9500.28747843911;9507.857382139273;9371.484568348773;9411.388259763093;9413.341066125375;9417.858732119024;9428.811423771554;9335.953320233424;9373.953130234373;9401.670941517013;9402.62389504419;9426.622935082589;44833.55166448326;45043.54956450426;45184;45301.09397812058;45392.77303613461;3802.6007269236607;3907.2576210520197;4465.776711164429;4499.235130027903;4556.430446194226;35564.46653300203;35843.4623480648;36243.27513449716;36387.4541881872;37522.24955500902;4259.70182087254;4283.678724095706;4295.183915056161;4301.376300436419;4348.804303806336;410555.99999999703;416214;416968;417738;616148;68982;69310;69515.65242173757;69830.65084674544;70113;73533.26466735265;73887.26112738911;74050;74148;74176;18908.149133289036;19297.807021929882;19418.0290985453;19875.602487950448;19994.400167994983;15028;15116.924415377853;15241.1617361044;15248.161351125573;15281;21567.67648485274;21580.89209553942;21602.783972160392;21636.567268654853;21737.45656358572;7396.186419493852;7490.700371985168;7750.224977502205;7807.336376407955;7891.250331218525;1010.3533738407425;1101.895319944604;1103.3214573037524;1184.466989854569;1212.1575505023923;34442.82778586091;34519.309613807585;34798.65201347954;34893.825530872185;34895.4765678515;1190.6547101340686;1199.7120691034088;1210.4855436439477;1210.8728583498782;1303.361352937054;17836.19737111833;18202.180901859447;18249.361272355403;18251.543711407056;18562.814371856108;426060;680688;698652;703487;704030;66920.33079669239;67694.3230567688;67894.3210567888;67957.66021169961;68222.65888670624;1492.0600021986297;1492.6566889615233;1500.2798656644873;1504.7818066380314;1512.8260250071162;35181.29637407289;35611.82194089013;35709.64290357063;35767.821160894026;36074.45888311625;57385.13922291253;57487;57872.421275786706;57958.13062803977;57998.420015799304;547637;551929;553660;554816;559593;31611.525827112153;32089;32133.35733285368;32172.19569510781;33788.493172602924;54684;54820.62948426321;54949.1757623628;55139;55876.720616396655;45843.77078114588;47086.293705595126;47695.28457073077;47701.76149119232;49194;43847;46898;47915.520844791106;48025;48063.51936480591;45652;46338;46574.53425465838;46797.2980405301;47414.288785668934;38431.61568384281;39698;40376.79811600923;40563.391549126194;41102.58897411107;30651.846740767047;31209.255302724807;31489;31545.8422707885;31644.683553164174 09:11:23 INFO - PROCESS | 8828 | |2;jquery.html;397.884613462096;402.9979850100749;408.10624731837277;414.504666923027;425.1497005988024;19281.421557353286;20588.279410220646;20602.690959635616;21082.348246795354;21316.4670883228;20460.59078818423;20557.38327850163;20925.581488370222;21415.785842141573;21549;5833.562482813784;6060.636361818283;6065.090236464522;6066.423689749467;6082.604630699013;5457.399686034533;5687.829365119053;5988.520918326523;6001.549883758714;6049.848753781169;5682.51698605619;5725.57058220633;5746.02317606008;5762.4525670061275;5780.393058728836;6330.873382532347;6364.904526432108;6366.045093236052;6373.13962615048;6373.426391624753;5506.421825708283;5932.050871860525;5962.761489540413;5966.463018328328;5987.880242395127;14215.502457414044;14402.927985360111;14505.927470362582;14597.70804583913;14843.777343339858;2504.474060447308;2654.32314759737;2660.8536530490815;2771.2240572639694;3086.089603566953;10060.849087263698;10462.63380781669;10504.632337868214;10687.30532515384;10745.51645175969;1963.3226536844766;1996.5807180492113;2094.95810083799;2146.495573540217;2155.170259450107;92450.53774731151;94186.52906735422;94456.52771736166;95116;96048;11450.568678915135;11585.594504192313;11690.123240756977;11724.58963936258;12007.21953073065;16533.58666033335;16604.08677522748;16633.584160396087;16686;16697.666046678998;9040.457572545536;9068.229200517899;9076.09239076087;9176.632934682671;9194.03462636427;8788.516631585197;8838.248748856291;8968.641254349883;9021.639134434548;9107.95446022779;4837.612990960785;4900.2894580286375;4910.06708725341;5023.844515761395;5084.7966081356335;2007.7389939308089;2112.3979665795173;2126.3727200475587;2137.786221377881;2144.3731428999663;1010.434156872154;1064.7284942339654;1069.4385447639895;1116.3636727065496;1116.9888301116885;20534.486637834172;21230.36308910735;21311.46721331948;21450.892745536483;21557;1059.613241166984;1070.288258308232;1087.8857719939451;1093.2456604942722;1111.127764704703;11629.88370116305;11641.243319184226;11756.23584467007;11864.550285631827;12078.396080196131;396753;406339;410198;583656;592792;103901;108387.45806270918;110827.44586277017;111040.4447977771;114799.42600286946;1070.673444599389;1075.419273592267;1121.8429419881386;1130.2992144870068;1135.03522006294;18548.536286592942;19225.32711355096;19715;19775.307864224684;19781.40655780329;46040.309395358425;47629;48051.279230812266;48353.758231208616;49245.41223636792;64555.354446454934;68402.3159768396;69369;69768.65115674592;70199;8645.56772161402;8897.154770296811;8936.553172341228;9017.143371379709;9036.728898133066;10201.693949181536;13230.140040897311;13990.160590364203;14196.29018549089;14811.481598144013;11822;11931.701707457383;12023.579174728842;12049.096317776377;12514.12401131912;11989.880101199225;12000.219985700902;12038.879611203776;12272.631821045383;12308.323042232763;11964.700882478008;12131.090168237593;12206.87793122093;12226.816597750863;12260.203086799329;8401.915980840113;8508.74473765788;8599.14008599135;8662;8784.604692788967;10491.895081049091;11636.476358563716;11920;11999.520019199133;12305.630831075083 09:11:23 INFO - PROCESS | 8828 | |3;mootools.html;1521.8478152184782;1537.961550961226;1689.7803285572875;1786.258702638405;1807.4848668129578;8241.093479717227;8839.911600883997;9009.459432434058;9594.904050959489;9623.566939487731;9060.864087038699;9351.438913665184;9418.670346537872;9447.196988256006;9487.051294870509;2459.0778458078175;2482.913098041569;2486.8880900359436;2490.091116742394;2494.114589320783;2415.1909110448023;2482.416632091466;2496.226169887341;2499.950020991179;2504.2236906559024;2461.618449140386;2470.8641024743633;2507.611320245365;2508.82438229324;2510.836795608289;2375.655529948165;2406;2408.0728919366084;2432.2824766693866;2442;2390.5696974544576;2411.7105947286436;2424.260600516842;2431.051889762994;2439.512097580491;9370.578323975438;9588.232941364675;9648.421094734338;9696.321257511978;9696.46669433181;5604.859878503029;5726.770929162829;5739.368669446358;5752.942470575283;5761.8559536011935;3644.125409901631;3735.9813200933822;3799.715021373408;3863.478430411915;3875.2636998970106;1204.9337286449243;1256.5664845628244;1256.9622911312674;1266.6200139957975;1278.603632873812;13236.536721214807;13250.3374831259;13315.600531984055;13350.933245333905;13403;4996.600271978233;5001.274815151783;5057.367829021372;5154.587632989352;5206.687598744087;10489.370637761758;10503.369797812156;10585.788284234271;10607.681769546925;10607.734806629896;5718.25662663851;5726.455986681259;5729.341125770507;5739.2252045973255;5753.33836608787;4642.79107440166;5250.789968401297;5278.841634750964;5318.893622127536;5359.330083739533;4130.173965206971;4153.626173644387;4163.146554956226;4165.396017577435;4228.78856057202;1207.5049229815734;1208.1542919955891;1228.993855030719;1231.513552146915;1251.8560365557896;931.855562387831;991.2615101749243;1032.0917592518686;1034.5137785240925;1053.7049626104704;6096.542759292982;6196.318404975449;6268;6475.6438395887735;6623.536352455379;470.35796138271013;474.964377671676;477.97474417374536;479.5085037836246;491.96064314854726;4178.477690288714;4206.810693518799;4249.915001699948;4264.978675106605;4298.355246712956;11543;11844.70388240301;11900.76198476043;12020.278783273032;12025.037996960222;10807.513661885234;11783.823242651368;11784.234024788362;11790.469428875722;11819.645410637522;8704.347173961978;8909.777255568533;8913.064128266567;8930;8972.86540701877;6638.933610663831;6665.933340666531;6752;6860.451163906975;6915.89626155598;10668.359898406121;10885.510152043336;10974.725631859268;10994;11104.222704410613;11029.062529685067;11064.723381915517;11074.944625277145;11237.831432528355;11239.887601123884;8484.872726908978;8656.0478347383;8672.176143266379;8745.212930836255;8748.69379571712;9115.042920493517;9159.084091590788;9177.632894684139;9259.814803703754;9312.068793120905;8210.343172546063;8370.497770133812;8426.705065322683;8483.533405662747;8621.568921553771;8264.297534709376;8300.460470069425;8326.45878017927;8413.70552030676;8492.447990880573;7549;7584.5070070445245;7645.503042302233;7650.273224043707;7658.923410765821;5600.4959553640365;5738.254026976467;5796.42035796417;5800.59395842287;5848.2689663792025;5732.16883551891;5748.827535173951;5864.354920958605;5895.7052147393315;5906.143609176731 09:11:23 INFO - PROCESS | 8828 | |4;prototype.html;328.76657573123083;334.07961067259697;335.9479280711489;339.3145845392307;339.9694027537521;5750.252467179266;5830.950428922797;5842.9707851460735;5881.647101173932;5897.233359663238;5763.337216220136;5786.900488907105;5796.594238403313;5809.157672137538;5811.506021988125;4288.935665965013;4339.761313127777;4439.511653718088;4469.530699276578;4470.843520476784;4418.558144185572;4447.177272204636;4450.154470650582;4498.190325741365;4525.705829121113;4485.372047913294;4490.383461953694;4500.324951257305;4508.909821803579;4514.729116253019;4360.869173924787;4445.866624001285;4452.79774460897;4471.9776401118115;4482.856871497747;3911.550171730259;3923.4114882767526;3924.1563063941103;3934.8426062957446;3943.428202910562;5595.468430499096;5674.687892165929;5692.121599872033;5721.141828725725;5728.166986564301;5030.434478415998;5099.235114732783;5128.589712822965;5161.41281809139;5185.585153187736;6000.969995149996;6015.969920150415;6034.5172386209;6038.607490513103;6068.4538391544975;4234.386014027979;4309.698321117523;4322.265214913472;4328.653707703407;4332.783360831977;6207.503399728011;6219.751209951596;6245.219347581552;6302.243730752293;6310.432061114522;4377.518472967971;4413.713108647928;4461.553844615512;4469.016816300409;4470.888227794266;4311.676624253194;4472.284434490466;4486.663500237495;4496.550344965477;4502.527234640315;5072.365954255718;5094.5669618082875;5111.539961403491;5122.308488354099;5141.408737995179;6064.75740970365;6070.2412198475195;6102.420270074336;6108.3280839107665;6213.254409470893;1456.8543145685346;1520.6426489774894;1532.3640689113893;1544.9922750386177;1547.5434746749736;972.9027097290215;990.2573070197352;1032.0608246495653;1047.3349423116376;1048.5124417146064;5919.999999999914;5925.970370148208;5965.224520812353;5980.43185897339;6018.127371531104;6197.938020619736;6247.75008999644;6271.686415679289;6277.96861015692;6328.6202827830475;5807.274090738658;5912.733926973297;5928.525717942554;5938.762449502058;5950.2264705587995;3299.3896129216173;3345.30702784261;3345.983270083634;3362.36115138123;3375.645557216457;6238.625682459067;6509.479241660656;6521.380468855451;6574.088417391645;6622.337766223339;6479.473005527848;6487.34572683972;6490.935090649127;6504.707288172043;6523.771667991692;6396.872062558723;6529.902051469232;6600.73597056122;6655.900161497581;6710.295418981034;6302.747890084529;6315.747370105144;6316.6841657916;6317.336679648754;6341.460975817107;6063.5452341073715;6231.9688401557705;6236.18929539157;6308.400701933309;6318.84202894913;6492.870142597028;6531.804045878631;6538.705758240986;6563.212414510289;6611.636360000246;4425.889352766207;4427.114577084661;4430.579094985971;4453.465584129795;4456.242438785479;6097.664628445478;6272.494601295747;6310.49516038725;6407.775727849503;6426.903596445964;6133.294671112879;6168.290646575701;6176.258848938156;6183.783567575113;6217.942949698471;5725.398833122629;6181.629102253879;6201.96899015502;6217.134859542029;6222.533310001678;5923.437273459187;5993;6039.6678182698615;6111.388861114031;6115.84710382244;6207.020630097488;6249.937500624936;6252.3743826604505;6252.687365631609;6286.591371560834;5926.881462370642;6047.818565443044;6075.693725848963;6081.726322315595;6100.664463454553 09:11:23 INFO - PROCESS | 8828 | |5;yui.html;830.6469750356105;831.779578411721;868.9752875799388;894.2756367342449;954.8138113067954;16753.832461675396;16882.07148606826;17696.115194240283;18276.634467310647;18487.260509579635;16148.111853848033;16370.918145409287;16399.4260200893;16447;16460.176991150456;722.3751454991448;867.761365624452;888.8089060851916;889.9199072083511;891.3136884598855;836.6486075848128;882.0165515450259;886.9645214191457;888.1651247827054;889.6975028490313;912.6760000199934;913.5934509143434;922.5986695787354;925.6482536636103;926.5876684875233;905.1491597897955;910.4127837544813;916.3493919317293;918.081918081918;919.1084647891535;673.0509980926919;673.2695025896908;677.864427114579;678.4301187002941;680.2619158213345;15887.443939462179;15958.840411595851;15964.281607327699;15971.680566388723;16011.839881601152;16210.604743573824;16219.91890040554;16448;16519.587010324718;16668.249928753234;13308.73382532344;13400.731985360335;13423.3959471824;13677.110987785762;13829.79255311161;4176.749395036308;4195.727277726938;4259.552746961555;4295.677824163169;4347.456567929009;91379;93065.53467232689;93486.53256733673;93749;95907;12742.745145097046;12747;12816.48734050646;12858.485660573473;12957.546485872948;25176;25336;25480.362990925376;25608.48783024329;25803.87098064535;8903.73288801337;8943.955280223558;9173.908260917306;9180.770480738034;9225.49259790718;5148.665336753099;5156.381234251914;5223.712695801767;5295.655782374133;5330.946690533045;4055.6958228132416;4250.957490425056;4257;4260.360945858146;4261.531231564525;711.4770643576967;745.7613563659577;786.7246463737761;803.5459965119805;808.720991258015;686.255412877024;765.8736308509145;817.2807929022422;834.6869923778584;844.5101840932244;10540.947295263475;10987.230893837515;11017;11256.718582035515;11543.36511491876;767.8963339949036;777.9183185765527;778.2140038561095;820.6635279535362;827.7392621324263;5125.9743701282005;5189.974050129801;5229.320188375486;5243.10867152585;5263.26314315996;72919;74200.25799741934;74266.6286668574;74290.628546858;74500.62749686325;112410.43794780974;119704;120184;123187;123592;81074.18925810666;94511;95798.52100739592;97389.51305243428;99454.0109197812;10706.518206680874;10752.13982881352;11017.614383496539;11228.698116886182;11420.714482138013;56298.1555276663;56463;56972.430275696715;57367.7131614356;57923.13115303358;78561.21438785539;82649.58675206585;84515.5774221125;85518.57240713756;86858;13822.792658109935;14383.345915219883;14458.421663133357;14513.492027778977;14982.550523484313;16237.51287461378;16256.105914174834;16310.918445407697;16706.16469176512;17106.48680539586;14986.250687465801;15357.23213839326;15415.768763468333;15535.689286214438;15925.442609508611;15325.846741532441;15392;15736.213189340717;15990.120543370227;16869.66260674755;14160.433582656578;15490.535283941499;16217.432389866299;16318.510444686679;16569.25484912691;11854.407279636156;12536.874631253571;12589.43347549344;12624.810627840407;12874.613761586792;12446.751064978469;12477.313747743961;12548.811767823672;12956.676083097998;12991.935040324737 09:11:23 INFO - PROCESS | 8828 | __end_tp_report 09:11:23 INFO - PROCESS | 8828 | __start_cc_report 09:11:23 INFO - PROCESS | 8828 | _x_x_mozilla_cycle_collect,354 09:11:23 INFO - PROCESS | 8828 | __end_cc_report 09:11:23 INFO - PROCESS | 8828 | __startTimestamp1472919083253__endTimestamp 09:11:23 INFO - PROCESS | 8828 | 09:11:23 INFO - PROCESS | 8828 | ------- Summary: start ------- 09:11:23 INFO - PROCESS | 8828 | Number of tests: 6 09:11:23 INFO - PROCESS | 8828 | 09:11:23 INFO - PROCESS | 8828 | [#0] dojo.html Cycles:165 Average:5688.15 Median:5947.94 stddev:643.17 (10.8%) stddev-sans-first:616.26 09:11:23 INFO - PROCESS | 8828 | Values: 3258.6 3273.0 3282.8 3291.2 3299.2 5663.2 5729.6 5732.8 5750.0 5752.4 5739.7 5805.6 5828.2 5842.1 5846.2 5213.4 5220.9 5262.8 5318.9 5322.2 5106.2 5127.4 5133.9 5166.3 5214.6 5204.8 5236.7 5240.9 5287.0 5313.0 5252.6 5299.8 5305.8 5306.5 5313.5 4995.7 5036.6 5168.2 5200.5 5250.7 5569.7 5640.0 5642.5 5660.2 5696.0 5972.9 5990.2 6077.1 6083.8 6100.5 5953.6 6065.0 6132.3 6135.9 6143.7 5655.2 5732.6 5737.8 5768.1 5768.4 6267.7 6268.0 6280.0 6282.6 6314.0 5853.5 5958.8 5984.9 5986.0 6025.8 6143.4 6172.2 6180.6 6180.8 6184.6 6018.3 6020.8 6032.5 6037.5 6044.5 5979.9 5987.3 6031.5 6044.3 6046.3 4649.4 4687.3 4698.4 4706.0 4720.5 4185.5 4193.6 4194.9 4196.3 4202.9 5643.5 5866.3 5896.8 5901.4 5903.8 6101.3 6164.6 6173.5 6190.8 6206.3 5946.5 5947.9 5954.2 5959.7 5984.2 5138.9 5296.8 5347.4 5348.9 5349.8 6331.2 6385.2 6428.9 6429.7 6430.8 6116.5 6126.5 6133.7 6134.0 6141.8 6139.7 6153.9 6234.5 6401.2 6402.0 5993.7 5994.9 6007.9 6009.3 6043.1 6075.5 6088.9 6122.4 6124.2 6144.5 5919.8 5953.1 5968.3 6021.8 6024.0 5983.1 6016.4 6017.6 6026.2 6040.2 5980.9 5980.9 6006.4 6016.6 6016.9 5829.8 5866.4 5877.8 5911.9 5998.3 5802.1 5836.5 5857.4 5872.7 5924.4 09:11:23 INFO - PROCESS | 8828 | 09:11:23 INFO - PROCESS | 8828 | [#1] ext.html Cycles:180 Average:72427.73 Median:46640.92 stddev:149474.40 (320.5%) stddev-sans-first:149796.40 09:11:23 INFO - PROCESS | 8828 | Values: 588.2 653.3 672.0 674.5 720.6 41629.4 46707.3 46768.5 46814.3 47110.5 46758.5 46787.0 47283.0 47354.5 47455.8 9134.4 9351.3 9352.0 9354.0 9368.7 9227.9 9373.3 9374.2 9380.9 9383.2 9471.1 9485.1 9497.3 9500.3 9507.9 9371.5 9411.4 9413.3 9417.9 9428.8 9336.0 9374.0 9401.7 9402.6 9426.6 44833.6 45043.5 45184.0 45301.1 45392.8 3802.6 3907.3 4465.8 4499.2 4556.4 35564.5 35843.5 36243.3 36387.5 37522.2 4259.7 4283.7 4295.2 4301.4 4348.8 410556.0 416214.0 416968.0 417738.0 616148.0 68982.0 69310.0 69515.7 69830.7 70113.0 73533.3 73887.3 74050.0 74148.0 74176.0 18908.1 19297.8 19418.0 19875.6 19994.4 15028.0 15116.9 15241.2 15248.2 15281.0 21567.7 21580.9 21602.8 21636.6 21737.5 7396.2 7490.7 7750.2 7807.3 7891.3 1010.4 1101.9 1103.3 1184.5 1212.2 34442.8 34519.3 34798.7 34893.8 34895.5 1190.7 1199.7 1210.5 1210.9 1303.4 17836.2 18202.2 18249.4 18251.5 18562.8 426060.0 680688.0 698652.0 703487.0 704030.0 66920.3 67694.3 67894.3 67957.7 68222.7 1492.1 1492.7 1500.3 1504.8 1512.8 35181.3 35611.8 35709.6 35767.8 36074.5 57385.1 57487.0 57872.4 57958.1 57998.4 547637.0 551929.0 553660.0 554816.0 559593.0 31611.5 32089.0 32133.4 32172.2 33788.5 54684.0 54820.6 54949.2 55139.0 55876.7 45843.8 47086.3 47695.3 47701.8 49194.0 43847.0 46898.0 47915.5 48025.0 48063.5 45652.0 46338.0 46574.5 46797.3 47414.3 38431.6 39698.0 40376.8 40563.4 41102.6 30651.8 31209.3 31489.0 31545.8 31644.7 09:11:23 INFO - PROCESS | 8828 | 09:11:23 INFO - PROCESS | 8828 | [#2] jquery.html Cycles:180 Average:30223.52 Median:21313.97 stddev:81109.00 (380.5%) stddev-sans-first:81305.62 09:11:23 INFO - PROCESS | 8828 | Values: 397.9 403.0 408.1 414.5 425.1 19281.4 20588.3 20602.7 21082.3 21316.5 20460.6 20557.4 20925.6 21415.8 21549.0 5833.6 6060.6 6065.1 6066.4 6082.6 5457.4 5687.8 5988.5 6001.5 6049.8 5682.5 5725.6 5746.0 5762.5 5780.4 6330.9 6364.9 6366.0 6373.1 6373.4 5506.4 5932.1 5962.8 5966.5 5987.9 14215.5 14402.9 14505.9 14597.7 14843.8 2504.5 2654.3 2660.9 2771.2 3086.1 10060.8 10462.6 10504.6 10687.3 10745.5 1963.3 1996.6 2095.0 2146.5 2155.2 92450.5 94186.5 94456.5 95116.0 96048.0 11450.6 11585.6 11690.1 11724.6 12007.2 16533.6 16604.1 16633.6 16686.0 16697.7 9040.5 9068.2 9076.1 9176.6 9194.0 8788.5 8838.2 8968.6 9021.6 9108.0 4837.6 4900.3 4910.1 5023.8 5084.8 2007.7 2112.4 2126.4 2137.8 2144.4 1010.4 1064.7 1069.4 1116.4 1117.0 20534.5 21230.4 21311.5 21450.9 21557.0 1059.6 1070.3 1087.9 1093.2 1111.1 11629.9 11641.2 11756.2 11864.6 12078.4 396753.0 406339.0 410198.0 583656.0 592792.0 103901.0 108387.5 110827.4 111040.4 114799.4 1070.7 1075.4 1121.8 1130.3 1135.0 18548.5 19225.3 19715.0 19775.3 19781.4 46040.3 47629.0 48051.3 48353.8 49245.4 64555.4 68402.3 69369.0 69768.7 70199.0 8645.6 8897.2 8936.6 9017.1 9036.7 10201.7 13230.1 13990.2 14196.3 14811.5 11822.0 11931.7 12023.6 12049.1 12514.1 11989.9 12000.2 12038.9 12272.6 12308.3 11964.7 12131.1 12206.9 12226.8 12260.2 8401.9 8508.7 8599.1 8662.0 8784.6 10491.9 11636.5 11920.0 11999.5 12305.6 09:11:23 INFO - PROCESS | 8828 | 09:11:23 INFO - PROCESS | 8828 | [#3] mootools.html Cycles:180 Average:6251.58 Median:476.47 stddev:3578.39 (751.0%) stddev-sans-first:3570.78 09:11:23 INFO - PROCESS | 8828 | Values: 1521.8 1538.0 1689.8 1786.3 1807.5 8241.1 8839.9 9009.5 9594.9 9623.6 9060.9 9351.4 9418.7 9447.2 9487.1 2459.1 2482.9 2486.9 2490.1 2494.1 2415.2 2482.4 2496.2 2500.0 2504.2 2461.6 2470.9 2507.6 2508.8 2510.8 2375.7 2406.0 2408.1 2432.3 2442.0 2390.6 2411.7 2424.3 2431.1 2439.5 9370.6 9588.2 9648.4 9696.3 9696.5 5604.9 5726.8 5739.4 5752.9 5761.9 3644.1 3736.0 3799.7 3863.5 3875.3 1204.9 1256.6 1257.0 1266.6 1278.6 13236.5 13250.3 13315.6 13350.9 13403.0 4996.6 5001.3 5057.4 5154.6 5206.7 10489.4 10503.4 10585.8 10607.7 10607.7 5718.3 5726.5 5729.3 5739.2 5753.3 4642.8 5250.8 5278.8 5318.9 5359.3 4130.2 4153.6 4163.1 4165.4 4228.8 1207.5 1208.2 1229.0 1231.5 1251.9 931.9 991.3 1032.1 1034.5 1053.7 6096.5 6196.3 6268.0 6475.6 6623.5 470.4 475.0 478.0 479.5 492.0 4178.5 4206.8 4249.9 4265.0 4298.4 11543.0 11844.7 11900.8 12020.3 12025.0 10807.5 11783.8 11784.2 11790.5 11819.6 8704.3 8909.8 8913.1 8930.0 8972.9 6638.9 6665.9 6752.0 6860.5 6915.9 10668.4 10885.5 10974.7 10994.0 11104.2 11029.1 11064.7 11074.9 11237.8 11239.9 8484.9 8656.0 8672.2 8745.2 8748.7 9115.0 9159.1 9177.6 9259.8 9312.1 8210.3 8370.5 8426.7 8483.5 8621.6 8264.3 8300.5 8326.5 8413.7 8492.4 7549.0 7584.5 7645.5 7650.3 7658.9 5600.5 5738.3 5796.4 5800.6 5848.3 5732.2 5748.8 5864.4 5895.7 5906.1 09:11:23 INFO - PROCESS | 8828 | 09:11:23 INFO - PROCESS | 8828 | [#4] prototype.html Cycles:180 Average:5146.29 Median:5916.37 stddev:1543.64 (26.1%) stddev-sans-first:1505.02 09:11:23 INFO - PROCESS | 8828 | Values: 328.8 334.1 335.9 339.3 340.0 5750.3 5831.0 5843.0 5881.6 5897.2 5763.3 5786.9 5796.6 5809.2 5811.5 4288.9 4339.8 4439.5 4469.5 4470.8 4418.6 4447.2 4450.2 4498.2 4525.7 4485.4 4490.4 4500.3 4508.9 4514.7 4360.9 4445.9 4452.8 4472.0 4482.9 3911.6 3923.4 3924.2 3934.8 3943.4 5595.5 5674.7 5692.1 5721.1 5728.2 5030.4 5099.2 5128.6 5161.4 5185.6 6001.0 6016.0 6034.5 6038.6 6068.5 4234.4 4309.7 4322.3 4328.7 4332.8 6207.5 6219.8 6245.2 6302.2 6310.4 4377.5 4413.7 4461.6 4469.0 4470.9 4311.7 4472.3 4486.7 4496.6 4502.5 5072.4 5094.6 5111.5 5122.3 5141.4 6064.8 6070.2 6102.4 6108.3 6213.3 1456.9 1520.6 1532.4 1545.0 1547.5 972.9 990.3 1032.1 1047.3 1048.5 5920.0 5926.0 5965.2 5980.4 6018.1 6197.9 6247.8 6271.7 6278.0 6328.6 5807.3 5912.7 5928.5 5938.8 5950.2 3299.4 3345.3 3346.0 3362.4 3375.6 6238.6 6509.5 6521.4 6574.1 6622.3 6479.5 6487.3 6490.9 6504.7 6523.8 6396.9 6529.9 6600.7 6655.9 6710.3 6302.7 6315.7 6316.7 6317.3 6341.5 6063.5 6232.0 6236.2 6308.4 6318.8 6492.9 6531.8 6538.7 6563.2 6611.6 4425.9 4427.1 4430.6 4453.5 4456.2 6097.7 6272.5 6310.5 6407.8 6426.9 6133.3 6168.3 6176.3 6183.8 6217.9 5725.4 6181.6 6202.0 6217.1 6222.5 5923.4 5993.0 6039.7 6111.4 6115.8 6207.0 6249.9 6252.4 6252.7 6286.6 5926.9 6047.8 6075.7 6081.7 6100.7 09:11:23 INFO - PROCESS | 8828 | 09:11:23 INFO - PROCESS | 8828 | [#5] yui.html Cycles:180 Average:22238.53 Median:4259.96 stddev:30781.67 (722.6%) stddev-sans-first:30826.04 09:11:23 INFO - PROCESS | 8828 | Values: 830.6 831.8 869.0 894.3 954.8 16753.8 16882.1 17696.1 18276.6 18487.3 16148.1 16370.9 16399.4 16447.0 16460.2 722.4 867.8 888.8 889.9 891.3 836.6 882.0 887.0 888.2 889.7 912.7 913.6 922.6 925.6 926.6 905.1 910.4 916.3 918.1 919.1 673.1 673.3 677.9 678.4 680.3 15887.4 15958.8 15964.3 15971.7 16011.8 16210.6 16219.9 16448.0 16519.6 16668.2 13308.7 13400.7 13423.4 13677.1 13829.8 4176.7 4195.7 4259.6 4295.7 4347.5 91379.0 93065.5 93486.5 93749.0 95907.0 12742.7 12747.0 12816.5 12858.5 12957.5 25176.0 25336.0 25480.4 25608.5 25803.9 8903.7 8944.0 9173.9 9180.8 9225.5 5148.7 5156.4 5223.7 5295.7 5330.9 4055.7 4251.0 4257.0 4260.4 4261.5 711.5 745.8 786.7 803.5 808.7 686.3 765.9 817.3 834.7 844.5 10540.9 10987.2 11017.0 11256.7 11543.4 767.9 777.9 778.2 820.7 827.7 5126.0 5190.0 5229.3 5243.1 5263.3 72919.0 74200.3 74266.6 74290.6 74500.6 112410.4 119704.0 120184.0 123187.0 123592.0 81074.2 94511.0 95798.5 97389.5 99454.0 10706.5 10752.1 11017.6 11228.7 11420.7 56298.2 56463.0 56972.4 57367.7 57923.1 78561.2 82649.6 84515.6 85518.6 86858.0 13822.8 14383.3 14458.4 14513.5 14982.6 16237.5 16256.1 16310.9 16706.2 17106.5 14986.3 15357.2 15415.8 15535.7 15925.4 15325.8 15392.0 15736.2 15990.1 16869.7 14160.4 15490.5 16217.4 16318.5 16569.3 11854.4 12536.9 12589.4 12624.8 12874.6 12446.8 12477.3 12548.8 12956.7 12991.9 09:11:23 INFO - PROCESS | 8828 | -------- Summary: end -------- 09:11:23 INFO - PROCESS | 8828 | 09:11:23 INFO - TEST-INFO | 8828: exit 0 09:11:23 INFO - TEST-OK | dromaeo_css | took 1111411ms 09:11:23 INFO - TEST-START | kraken 09:11:23 INFO - operating with platform_type : linux_ 09:11:23 INFO - Initialising browser for kraken test... 09:11:24 INFO - TEST-INFO | started process 9087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOuPfhc/profile http://localhost:43471/getInfo.html) 09:11:28 INFO - PROCESS | 9087 | __metrics Screen width/height:1600/1200 09:11:28 INFO - PROCESS | 9087 | colorDepth:24 09:11:28 INFO - PROCESS | 9087 | Browser inner width/height: 1024/697 09:11:28 INFO - PROCESS | 9087 | __metrics 09:11:29 ERROR - PROCESS | 9087 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:11:30 INFO - TEST-INFO | 9087: exit 0 09:11:30 INFO - Browser initialized. 09:11:30 INFO - Running cycle 1/1 for kraken test... 09:11:30 INFO - TEST-INFO | started process 9215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOuPfhc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:42 INFO - PROCESS | 9215 | RSS: Main: 152866816 09:11:42 INFO - PROCESS | 9215 | 09:11:44 INFO - PROCESS | 9215 | Cycle 1(1): loaded http://localhost:43471/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43471/tests/kraken/driver.html?testName=audio-beat-detection) 09:11:45 INFO - PROCESS | 9215 | RSS: Main: 158633984 09:11:45 INFO - PROCESS | 9215 | 09:11:48 INFO - PROCESS | 9215 | Cycle 1(1): loaded http://localhost:43471/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43471/tests/kraken/driver.html?testName=audio-dft) 09:11:48 INFO - PROCESS | 9215 | RSS: Main: 156991488 09:11:48 INFO - PROCESS | 9215 | 09:11:51 INFO - PROCESS | 9215 | Cycle 1(1): loaded http://localhost:43471/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43471/tests/kraken/driver.html?testName=audio-fft) 09:11:52 INFO - PROCESS | 9215 | RSS: Main: 157507584 09:11:52 INFO - PROCESS | 9215 | 09:11:54 INFO - PROCESS | 9215 | Cycle 1(1): loaded http://localhost:43471/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43471/tests/kraken/driver.html?testName=audio-oscillator) 09:11:54 INFO - PROCESS | 9215 | RSS: Main: 157028352 09:11:54 INFO - PROCESS | 9215 | 09:11:57 INFO - PROCESS | 9215 | Cycle 1(1): loaded http://localhost:43471/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43471/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:11:57 INFO - PROCESS | 9215 | RSS: Main: 157089792 09:11:57 INFO - PROCESS | 9215 | 09:12:00 INFO - PROCESS | 9215 | Cycle 1(1): loaded http://localhost:43471/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43471/tests/kraken/driver.html?testName=imaging-darkroom) 09:12:01 INFO - PROCESS | 9215 | RSS: Main: 156221440 09:12:01 INFO - PROCESS | 9215 | 09:12:04 INFO - PROCESS | 9215 | Cycle 1(1): loaded http://localhost:43471/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43471/tests/kraken/driver.html?testName=imaging-desaturate) 09:12:05 INFO - PROCESS | 9215 | RSS: Main: 154750976 09:12:05 INFO - PROCESS | 9215 | 09:12:08 INFO - PROCESS | 9215 | Cycle 1(1): loaded http://localhost:43471/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43471/tests/kraken/driver.html?testName=json-parse-financial) 09:12:09 INFO - PROCESS | 9215 | RSS: Main: 156426240 09:12:09 INFO - PROCESS | 9215 | 09:12:10 INFO - PROCESS | 9215 | Cycle 1(1): loaded http://localhost:43471/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43471/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:12:11 INFO - PROCESS | 9215 | RSS: Main: 156545024 09:12:11 INFO - PROCESS | 9215 | 09:12:12 INFO - PROCESS | 9215 | Cycle 1(1): loaded http://localhost:43471/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43471/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:12:13 INFO - PROCESS | 9215 | RSS: Main: 156254208 09:12:13 INFO - PROCESS | 9215 | 09:12:15 INFO - PROCESS | 9215 | Cycle 1(1): loaded http://localhost:43471/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43471/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:12:16 INFO - PROCESS | 9215 | RSS: Main: 157347840 09:12:16 INFO - PROCESS | 9215 | 09:12:18 INFO - PROCESS | 9215 | Cycle 1(1): loaded http://localhost:43471/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:12:19 INFO - PROCESS | 9215 | RSS: Main: 157302784 09:12:19 INFO - PROCESS | 9215 | 09:12:21 INFO - PROCESS | 9215 | Cycle 1(1): loaded http://localhost:43471/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:12:22 INFO - PROCESS | 9215 | RSS: Main: 157253632 09:12:22 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | Cycle 1(1): loaded http://localhost:43471/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43471/tests/kraken/driver.html?testName=ai-astar) 09:12:24 INFO - PROCESS | 9215 | RSS: Main: 158511104 09:12:24 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | __start_tp_report 09:12:24 INFO - PROCESS | 9215 | _x_x_mozilla_page_load 09:12:24 INFO - PROCESS | 9215 | _x_x_mozilla_page_load_details 09:12:24 INFO - PROCESS | 9215 | |i|pagename|runs| 09:12:24 INFO - PROCESS | 9215 | |0;ai-astar;102;111;105;113;110;111;110;109;112;112 09:12:24 INFO - PROCESS | 9215 | |1;audio-beat-detection;147;116;145;172;118;146;141;120;171;120 09:12:24 INFO - PROCESS | 9215 | |2;audio-dft;162;162;163;162;162;161;161;161;161;163 09:12:24 INFO - PROCESS | 9215 | |3;audio-fft;76;75;74;179;77;77;78;77;163;76 09:12:24 INFO - PROCESS | 9215 | |4;audio-oscillator;83;85;159;83;83;84;141;83;83;158 09:12:24 INFO - PROCESS | 9215 | |5;imaging-gaussian-blur;121;117;117;118;117;118;117;119;118;118 09:12:24 INFO - PROCESS | 9215 | |6;imaging-darkroom;148;149;148;146;148;148;146;147;147;147 09:12:24 INFO - PROCESS | 9215 | |7;imaging-desaturate;95;97;96;96;98;96;95;96;95;95 09:12:24 INFO - PROCESS | 9215 | |8;json-parse-financial;54;52;51;53;54;52;53;53;53;54 09:12:24 INFO - PROCESS | 9215 | |9;json-stringify-tinderbox;62;60;59;60;60;59;58;59;60;59 09:12:24 INFO - PROCESS | 9215 | |10;stanford-crypto-aes;75;78;73;73;72;73;73;71;73;73 09:12:24 INFO - PROCESS | 9215 | |11;stanford-crypto-ccm;119;134;120;120;121;121;117;119;159;117 09:12:24 INFO - PROCESS | 9215 | |12;stanford-crypto-pbkdf2;149;158;155;151;156;151;155;153;148;154 09:12:24 INFO - PROCESS | 9215 | |13;stanford-crypto-sha256-iterative;62;61;67;61;63;64;62;62;62;60 09:12:24 INFO - PROCESS | 9215 | __end_tp_report 09:12:24 INFO - PROCESS | 9215 | __start_cc_report 09:12:24 INFO - PROCESS | 9215 | _x_x_mozilla_cycle_collect,885 09:12:24 INFO - PROCESS | 9215 | __end_cc_report 09:12:24 INFO - PROCESS | 9215 | __startTimestamp1472919144508__endTimestamp 09:12:24 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | ------- Summary: start ------- 09:12:24 INFO - PROCESS | 9215 | Number of tests: 14 09:12:24 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.44 (3.1%) stddev-sans-first:2.35 09:12:24 INFO - PROCESS | 9215 | Values: 102.0 111.0 105.0 113.0 110.0 111.0 110.0 109.0 112.0 112.0 09:12:24 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:145.50 stddev:20.96 (14.4%) stddev-sans-first:22.06 09:12:24 INFO - PROCESS | 9215 | Values: 147.0 116.0 145.0 172.0 118.0 146.0 141.0 120.0 171.0 120.0 09:12:24 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 09:12:24 INFO - PROCESS | 9215 | Values: 162.0 162.0 163.0 162.0 162.0 161.0 161.0 161.0 161.0 163.0 09:12:24 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.50 stddev:40.14 (52.5%) stddev-sans-first:41.97 09:12:24 INFO - PROCESS | 9215 | Values: 76.0 75.0 74.0 179.0 77.0 77.0 78.0 77.0 163.0 76.0 09:12:24 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:83.00 stddev:33.79 (40.7%) stddev-sans-first:34.96 09:12:24 INFO - PROCESS | 9215 | Values: 83.0 85.0 159.0 83.0 83.0 84.0 141.0 83.0 83.0 158.0 09:12:24 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.25 (1.1%) stddev-sans-first:0.71 09:12:24 INFO - PROCESS | 9215 | Values: 121.0 117.0 117.0 118.0 117.0 118.0 117.0 119.0 118.0 118.0 09:12:24 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 09:12:24 INFO - PROCESS | 9215 | Values: 148.0 149.0 148.0 146.0 148.0 148.0 146.0 147.0 147.0 147.0 09:12:24 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:1.00 09:12:24 INFO - PROCESS | 9215 | Values: 95.0 97.0 96.0 96.0 98.0 96.0 95.0 96.0 95.0 95.0 09:12:24 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.99 (1.9%) stddev-sans-first:0.97 09:12:24 INFO - PROCESS | 9215 | Values: 54.0 52.0 51.0 53.0 54.0 52.0 53.0 53.0 53.0 54.0 09:12:24 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:1.07 (1.8%) stddev-sans-first:0.71 09:12:24 INFO - PROCESS | 9215 | Values: 62.0 60.0 59.0 60.0 60.0 59.0 58.0 59.0 60.0 59.0 09:12:24 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | [#10] stanford-crypto-aes Cycles:10 Average:73.40 Median:73.00 stddev:1.90 (2.6%) stddev-sans-first:1.92 09:12:24 INFO - PROCESS | 9215 | Values: 75.0 78.0 73.0 73.0 72.0 73.0 73.0 71.0 73.0 73.0 09:12:24 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:120.50 stddev:12.99 (10.8%) stddev-sans-first:13.61 09:12:24 INFO - PROCESS | 9215 | Values: 119.0 134.0 120.0 120.0 121.0 121.0 117.0 119.0 159.0 117.0 09:12:24 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.00 Median:154.50 stddev:3.20 (2.1%) stddev-sans-first:3.05 09:12:24 INFO - PROCESS | 9215 | Values: 149.0 158.0 155.0 151.0 156.0 151.0 155.0 153.0 148.0 154.0 09:12:24 INFO - PROCESS | 9215 | 09:12:24 INFO - PROCESS | 9215 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:1.96 (3.2%) stddev-sans-first:2.07 09:12:24 INFO - PROCESS | 9215 | Values: 62.0 61.0 67.0 61.0 63.0 64.0 62.0 62.0 62.0 60.0 09:12:24 INFO - PROCESS | 9215 | -------- Summary: end -------- 09:12:24 INFO - PROCESS | 9215 | 09:12:25 INFO - TEST-INFO | 9215: exit 0 09:12:25 INFO - TEST-OK | kraken | took 61554ms 09:12:25 INFO - SUITE-END | took 1172s 09:12:25 INFO - Completed test suite (00:19:33) 09:12:25 INFO - javascript benchmark 09:12:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7866.307889289529, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3258.6415494295625, 3272.9526551503527, 3282.819444930528, 3291.1936575539, 3299.208190034391, 5663.207150998858, 5729.570282228829, 5732.79935202268, 5749.971250143749, 5752.36723960364, 5739.684317362543, 5805.622634528752, 5828.154917536955, 5842.0652695568715, 5846.181534585162, 5213.426523082458, 5220.921686174692, 5262.789488420478, 5318.867028324285, 5322.175062865262, 5106.234064890277, 5127.435982041991, 5133.871653208662, 5166.250893620441, 5214.556762675177, 5204.765785539641, 5236.685798852062, 5240.868978275555, 5287.0, 5313.0, 5252.606054545905, 5299.814506492293, 5305.761240744157, 5306.469353064701, 5313.521783039507, 4995.700257984533, 5036.597072234213, 5168.173092305251, 5200.453952334989, 5250.7374631268285, 5569.693666848321, 5640.0, 5642.548596112301, 5660.2075709400715, 5696.0, 5972.880542389172, 5990.2212712347555, 6077.118817771398, 6083.847903802396, 6100.542459315525, 5953.553483488712, 6065.029595264737, 6132.264128304588, 6135.938640613582, 6143.662098584576, 5655.236543066674, 5732.627379220296, 5737.77048918047, 5768.077107662753, 5768.42315768424, 6267.71795269214, 6268.0, 6280.0, 6282.560220784501, 6313.968430157912, 5853.473187413068, 5958.791442299499, 5984.850378740566, 5986.0, 6025.849353766103, 6143.354947730424, 6172.197614310111, 6180.567360284737, 6180.81457556274, 6184.628922264678, 6018.337982821886, 6020.759169633253, 6032.487238584682, 6037.45662890342, 6044.516438684895, 5979.850503737354, 5987.31145918225, 6031.547633927473, 6044.304904935901, 6046.274447066292, 4649.372334734835, 4687.250039993584, 4698.436187657435, 4705.952940470552, 4720.480747117815, 4185.476815398075, 4193.643540299047, 4194.874153775391, 4196.265653510623, 4202.936955945664, 5643.492085712305, 5866.2960444746905, 5896.823095307148, 5901.3508514063415, 5903.76384944606, 6101.298350689727, 6164.630122192682, 6173.47525460332, 6190.845228869224, 6206.317305096436, 5946.494547963472, 5947.940520594825, 5954.166416701665, 5959.731812068468, 5984.162217289583, 5138.87152821175, 5296.788128474818, 5347.385050719139, 5348.893022139613, 5349.839504814861, 6331.240251169797, 6385.201849768779, 6428.935710642927, 6429.742810287629, 6430.77492287777, 6116.480099191618, 6126.479249263863, 6133.723982420891, 6133.969330153499, 6141.785037523665, 6139.706800529493, 6153.907691384722, 6234.532410069172, 6401.167848179707, 6402.0, 5993.730282137227, 5994.910076348945, 6007.87984240304, 6009.338972712911, 6043.093535969464, 6075.483583895419, 6088.908666370096, 6122.357152499102, 6124.173236613178, 6144.477719393902, 5919.822405327847, 5953.077273022688, 5968.313643931004, 6021.7591296347655, 6023.969880150571, 5983.072623743326, 6016.42843929826, 6017.608855424383, 6026.216591843032, 6040.154378386941, 5980.850478738066, 5980.880382392241, 6006.399360063959, 6016.578839481369, 6016.8796624068145, 5829.766809327749, 5866.41335866427, 5877.823665290048, 5911.911321330097, 5998.280206375263, 5802.129680547782, 5836.503897168788, 5857.384974577779, 5872.677002764718, 5924.407559244041], "value": 5644.510317141661, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.2088590845315, 653.340126472263, 671.963042032688, 674.5143496682389, 720.5640587444599, 41629.3755593666, 46707.29939050917, 46768.53231467684, 46814.29778553324, 47110.528894711046, 46758.53241467584, 46787.0, 47283.0, 47354.526454735445, 47455.762721186344, 9134.360594758353, 9351.251899847995, 9352.018038106004, 9353.95323023384, 9368.718938431824, 9227.861582076273, 9373.250139988784, 9374.203192728626, 9380.906190938105, 9383.202427793645, 9471.052894710543, 9485.051494850495, 9497.335186536946, 9500.28747843911, 9507.857382139273, 9371.484568348773, 9411.388259763093, 9413.341066125375, 9417.858732119024, 9428.811423771554, 9335.953320233424, 9373.953130234373, 9401.670941517013, 9402.62389504419, 9426.622935082589, 44833.55166448326, 45043.54956450426, 45184.0, 45301.09397812058, 45392.77303613461, 3802.6007269236607, 3907.2576210520197, 4465.776711164429, 4499.235130027903, 4556.430446194226, 35564.46653300203, 35843.4623480648, 36243.27513449716, 36387.4541881872, 37522.24955500902, 4259.70182087254, 4283.678724095706, 4295.183915056161, 4301.376300436419, 4348.804303806336, 410555.99999999703, 416214.0, 416968.0, 417738.0, 616148.0, 68982.0, 69310.0, 69515.65242173757, 69830.65084674544, 70113.0, 73533.26466735265, 73887.26112738911, 74050.0, 74148.0, 74176.0, 18908.149133289036, 19297.807021929882, 19418.0290985453, 19875.602487950448, 19994.400167994983, 15028.0, 15116.924415377853, 15241.1617361044, 15248.161351125573, 15281.0, 21567.67648485274, 21580.89209553942, 21602.783972160392, 21636.567268654853, 21737.45656358572, 7396.186419493852, 7490.700371985168, 7750.224977502205, 7807.336376407955, 7891.250331218525, 1010.3533738407425, 1101.895319944604, 1103.3214573037524, 1184.466989854569, 1212.1575505023923, 34442.82778586091, 34519.309613807585, 34798.65201347954, 34893.825530872185, 34895.4765678515, 1190.6547101340686, 1199.7120691034088, 1210.4855436439477, 1210.8728583498782, 1303.361352937054, 17836.19737111833, 18202.180901859447, 18249.361272355403, 18251.543711407056, 18562.814371856108, 426060.0, 680688.0, 698652.0, 703487.0, 704030.0, 66920.33079669239, 67694.3230567688, 67894.3210567888, 67957.66021169961, 68222.65888670624, 1492.0600021986297, 1492.6566889615233, 1500.2798656644873, 1504.7818066380314, 1512.8260250071162, 35181.29637407289, 35611.82194089013, 35709.64290357063, 35767.821160894026, 36074.45888311625, 57385.13922291253, 57487.0, 57872.421275786706, 57958.13062803977, 57998.420015799304, 547637.0, 551929.0, 553660.0, 554816.0, 559593.0, 31611.525827112153, 32089.0, 32133.35733285368, 32172.19569510781, 33788.493172602924, 54684.0, 54820.62948426321, 54949.1757623628, 55139.0, 55876.720616396655, 45843.77078114588, 47086.293705595126, 47695.28457073077, 47701.76149119232, 49194.0, 43847.0, 46898.0, 47915.520844791106, 48025.0, 48063.51936480591, 45652.0, 46338.0, 46574.53425465838, 46797.2980405301, 47414.288785668934, 38431.61568384281, 39698.0, 40376.79811600923, 40563.391549126194, 41102.58897411107, 30651.846740767047, 31209.255302724807, 31489.0, 31545.8422707885, 31644.683553164174], "value": 22577.92551436579, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.884613462096, 402.9979850100749, 408.10624731837277, 414.504666923027, 425.1497005988024, 19281.421557353286, 20588.279410220646, 20602.690959635616, 21082.348246795354, 21316.4670883228, 20460.59078818423, 20557.38327850163, 20925.581488370222, 21415.785842141573, 21549.0, 5833.562482813784, 6060.636361818283, 6065.090236464522, 6066.423689749467, 6082.604630699013, 5457.399686034533, 5687.829365119053, 5988.520918326523, 6001.549883758714, 6049.848753781169, 5682.51698605619, 5725.57058220633, 5746.02317606008, 5762.4525670061275, 5780.393058728836, 6330.873382532347, 6364.904526432108, 6366.045093236052, 6373.13962615048, 6373.426391624753, 5506.421825708283, 5932.050871860525, 5962.761489540413, 5966.463018328328, 5987.880242395127, 14215.502457414044, 14402.927985360111, 14505.927470362582, 14597.70804583913, 14843.777343339858, 2504.474060447308, 2654.32314759737, 2660.8536530490815, 2771.2240572639694, 3086.089603566953, 10060.849087263698, 10462.63380781669, 10504.632337868214, 10687.30532515384, 10745.51645175969, 1963.3226536844766, 1996.5807180492113, 2094.95810083799, 2146.495573540217, 2155.170259450107, 92450.53774731151, 94186.52906735422, 94456.52771736166, 95116.0, 96048.0, 11450.568678915135, 11585.594504192313, 11690.123240756977, 11724.58963936258, 12007.21953073065, 16533.58666033335, 16604.08677522748, 16633.584160396087, 16686.0, 16697.666046678998, 9040.457572545536, 9068.229200517899, 9076.09239076087, 9176.632934682671, 9194.03462636427, 8788.516631585197, 8838.248748856291, 8968.641254349883, 9021.639134434548, 9107.95446022779, 4837.612990960785, 4900.2894580286375, 4910.06708725341, 5023.844515761395, 5084.7966081356335, 2007.7389939308089, 2112.3979665795173, 2126.3727200475587, 2137.786221377881, 2144.3731428999663, 1010.434156872154, 1064.7284942339654, 1069.4385447639895, 1116.3636727065496, 1116.9888301116885, 20534.486637834172, 21230.36308910735, 21311.46721331948, 21450.892745536483, 21557.0, 1059.613241166984, 1070.288258308232, 1087.8857719939451, 1093.2456604942722, 1111.127764704703, 11629.88370116305, 11641.243319184226, 11756.23584467007, 11864.550285631827, 12078.396080196131, 396753.0, 406339.0, 410198.0, 583656.0, 592792.0, 103901.0, 108387.45806270918, 110827.44586277017, 111040.4447977771, 114799.42600286946, 1070.673444599389, 1075.419273592267, 1121.8429419881386, 1130.2992144870068, 1135.03522006294, 18548.536286592942, 19225.32711355096, 19715.0, 19775.307864224684, 19781.40655780329, 46040.309395358425, 47629.0, 48051.279230812266, 48353.758231208616, 49245.41223636792, 64555.354446454934, 68402.3159768396, 69369.0, 69768.65115674592, 70199.0, 8645.56772161402, 8897.154770296811, 8936.553172341228, 9017.143371379709, 9036.728898133066, 10201.693949181536, 13230.140040897311, 13990.160590364203, 14196.29018549089, 14811.481598144013, 11822.0, 11931.701707457383, 12023.579174728842, 12049.096317776377, 12514.12401131912, 11989.880101199225, 12000.219985700902, 12038.879611203776, 12272.631821045383, 12308.323042232763, 11964.700882478008, 12131.090168237593, 12206.87793122093, 12226.816597750863, 12260.203086799329, 8401.915980840113, 8508.74473765788, 8599.14008599135, 8662.0, 8784.604692788967, 10491.895081049091, 11636.476358563716, 11920.0, 11999.520019199133, 12305.630831075083], "value": 9755.609895963045, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1521.8478152184782, 1537.961550961226, 1689.7803285572875, 1786.258702638405, 1807.4848668129578, 8241.093479717227, 8839.911600883997, 9009.459432434058, 9594.904050959489, 9623.566939487731, 9060.864087038699, 9351.438913665184, 9418.670346537872, 9447.196988256006, 9487.051294870509, 2459.0778458078175, 2482.913098041569, 2486.8880900359436, 2490.091116742394, 2494.114589320783, 2415.1909110448023, 2482.416632091466, 2496.226169887341, 2499.950020991179, 2504.2236906559024, 2461.618449140386, 2470.8641024743633, 2507.611320245365, 2508.82438229324, 2510.836795608289, 2375.655529948165, 2406.0, 2408.0728919366084, 2432.2824766693866, 2442.0, 2390.5696974544576, 2411.7105947286436, 2424.260600516842, 2431.051889762994, 2439.512097580491, 9370.578323975438, 9588.232941364675, 9648.421094734338, 9696.321257511978, 9696.46669433181, 5604.859878503029, 5726.770929162829, 5739.368669446358, 5752.942470575283, 5761.8559536011935, 3644.125409901631, 3735.9813200933822, 3799.715021373408, 3863.478430411915, 3875.2636998970106, 1204.9337286449243, 1256.5664845628244, 1256.9622911312674, 1266.6200139957975, 1278.603632873812, 13236.536721214807, 13250.3374831259, 13315.600531984055, 13350.933245333905, 13403.0, 4996.600271978233, 5001.274815151783, 5057.367829021372, 5154.587632989352, 5206.687598744087, 10489.370637761758, 10503.369797812156, 10585.788284234271, 10607.681769546925, 10607.734806629896, 5718.25662663851, 5726.455986681259, 5729.341125770507, 5739.2252045973255, 5753.33836608787, 4642.79107440166, 5250.789968401297, 5278.841634750964, 5318.893622127536, 5359.330083739533, 4130.173965206971, 4153.626173644387, 4163.146554956226, 4165.396017577435, 4228.78856057202, 1207.5049229815734, 1208.1542919955891, 1228.993855030719, 1231.513552146915, 1251.8560365557896, 931.855562387831, 991.2615101749243, 1032.0917592518686, 1034.5137785240925, 1053.7049626104704, 6096.542759292982, 6196.318404975449, 6268.0, 6475.6438395887735, 6623.536352455379, 470.35796138271013, 474.964377671676, 477.97474417374536, 479.5085037836246, 491.96064314854726, 4178.477690288714, 4206.810693518799, 4249.915001699948, 4264.978675106605, 4298.355246712956, 11543.0, 11844.70388240301, 11900.76198476043, 12020.278783273032, 12025.037996960222, 10807.513661885234, 11783.823242651368, 11784.234024788362, 11790.469428875722, 11819.645410637522, 8704.347173961978, 8909.777255568533, 8913.064128266567, 8930.0, 8972.86540701877, 6638.933610663831, 6665.933340666531, 6752.0, 6860.451163906975, 6915.89626155598, 10668.359898406121, 10885.510152043336, 10974.725631859268, 10994.0, 11104.222704410613, 11029.062529685067, 11064.723381915517, 11074.944625277145, 11237.831432528355, 11239.887601123884, 8484.872726908978, 8656.0478347383, 8672.176143266379, 8745.212930836255, 8748.69379571712, 9115.042920493517, 9159.084091590788, 9177.632894684139, 9259.814803703754, 9312.068793120905, 8210.343172546063, 8370.497770133812, 8426.705065322683, 8483.533405662747, 8621.568921553771, 8264.297534709376, 8300.460470069425, 8326.45878017927, 8413.70552030676, 8492.447990880573, 7549.0, 7584.5070070445245, 7645.503042302233, 7650.273224043707, 7658.923410765821, 5600.4959553640365, 5738.254026976467, 5796.42035796417, 5800.59395842287, 5848.2689663792025, 5732.16883551891, 5748.827535173951, 5864.354920958605, 5895.7052147393315, 5906.143609176731], "value": 4893.41894838308, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.76657573123083, 334.07961067259697, 335.9479280711489, 339.3145845392307, 339.9694027537521, 5750.252467179266, 5830.950428922797, 5842.9707851460735, 5881.647101173932, 5897.233359663238, 5763.337216220136, 5786.900488907105, 5796.594238403313, 5809.157672137538, 5811.506021988125, 4288.935665965013, 4339.761313127777, 4439.511653718088, 4469.530699276578, 4470.843520476784, 4418.558144185572, 4447.177272204636, 4450.154470650582, 4498.190325741365, 4525.705829121113, 4485.372047913294, 4490.383461953694, 4500.324951257305, 4508.909821803579, 4514.729116253019, 4360.869173924787, 4445.866624001285, 4452.79774460897, 4471.9776401118115, 4482.856871497747, 3911.550171730259, 3923.4114882767526, 3924.1563063941103, 3934.8426062957446, 3943.428202910562, 5595.468430499096, 5674.687892165929, 5692.121599872033, 5721.141828725725, 5728.166986564301, 5030.434478415998, 5099.235114732783, 5128.589712822965, 5161.41281809139, 5185.585153187736, 6000.969995149996, 6015.969920150415, 6034.5172386209, 6038.607490513103, 6068.4538391544975, 4234.386014027979, 4309.698321117523, 4322.265214913472, 4328.653707703407, 4332.783360831977, 6207.503399728011, 6219.751209951596, 6245.219347581552, 6302.243730752293, 6310.432061114522, 4377.518472967971, 4413.713108647928, 4461.553844615512, 4469.016816300409, 4470.888227794266, 4311.676624253194, 4472.284434490466, 4486.663500237495, 4496.550344965477, 4502.527234640315, 5072.365954255718, 5094.5669618082875, 5111.539961403491, 5122.308488354099, 5141.408737995179, 6064.75740970365, 6070.2412198475195, 6102.420270074336, 6108.3280839107665, 6213.254409470893, 1456.8543145685346, 1520.6426489774894, 1532.3640689113893, 1544.9922750386177, 1547.5434746749736, 972.9027097290215, 990.2573070197352, 1032.0608246495653, 1047.3349423116376, 1048.5124417146064, 5919.999999999914, 5925.970370148208, 5965.224520812353, 5980.43185897339, 6018.127371531104, 6197.938020619736, 6247.75008999644, 6271.686415679289, 6277.96861015692, 6328.6202827830475, 5807.274090738658, 5912.733926973297, 5928.525717942554, 5938.762449502058, 5950.2264705587995, 3299.3896129216173, 3345.30702784261, 3345.983270083634, 3362.36115138123, 3375.645557216457, 6238.625682459067, 6509.479241660656, 6521.380468855451, 6574.088417391645, 6622.337766223339, 6479.473005527848, 6487.34572683972, 6490.935090649127, 6504.707288172043, 6523.771667991692, 6396.872062558723, 6529.902051469232, 6600.73597056122, 6655.900161497581, 6710.295418981034, 6302.747890084529, 6315.747370105144, 6316.6841657916, 6317.336679648754, 6341.460975817107, 6063.5452341073715, 6231.9688401557705, 6236.18929539157, 6308.400701933309, 6318.84202894913, 6492.870142597028, 6531.804045878631, 6538.705758240986, 6563.212414510289, 6611.636360000246, 4425.889352766207, 4427.114577084661, 4430.579094985971, 4453.465584129795, 4456.242438785479, 6097.664628445478, 6272.494601295747, 6310.49516038725, 6407.775727849503, 6426.903596445964, 6133.294671112879, 6168.290646575701, 6176.258848938156, 6183.783567575113, 6217.942949698471, 5725.398833122629, 6181.629102253879, 6201.96899015502, 6217.134859542029, 6222.533310001678, 5923.437273459187, 5993.0, 6039.6678182698615, 6111.388861114031, 6115.84710382244, 6207.020630097488, 6249.937500624936, 6252.3743826604505, 6252.687365631609, 6286.591371560834, 5926.881462370642, 6047.818565443044, 6075.693725848963, 6081.726322315595, 6100.664463454553], "value": 4643.014031388828, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.6469750356105, 831.779578411721, 868.9752875799388, 894.2756367342449, 954.8138113067954, 16753.832461675396, 16882.07148606826, 17696.115194240283, 18276.634467310647, 18487.260509579635, 16148.111853848033, 16370.918145409287, 16399.4260200893, 16447.0, 16460.176991150456, 722.3751454991448, 867.761365624452, 888.8089060851916, 889.9199072083511, 891.3136884598855, 836.6486075848128, 882.0165515450259, 886.9645214191457, 888.1651247827054, 889.6975028490313, 912.6760000199934, 913.5934509143434, 922.5986695787354, 925.6482536636103, 926.5876684875233, 905.1491597897955, 910.4127837544813, 916.3493919317293, 918.081918081918, 919.1084647891535, 673.0509980926919, 673.2695025896908, 677.864427114579, 678.4301187002941, 680.2619158213345, 15887.443939462179, 15958.840411595851, 15964.281607327699, 15971.680566388723, 16011.839881601152, 16210.604743573824, 16219.91890040554, 16448.0, 16519.587010324718, 16668.249928753234, 13308.73382532344, 13400.731985360335, 13423.3959471824, 13677.110987785762, 13829.79255311161, 4176.749395036308, 4195.727277726938, 4259.552746961555, 4295.677824163169, 4347.456567929009, 91379.0, 93065.53467232689, 93486.53256733673, 93749.0, 95907.0, 12742.745145097046, 12747.0, 12816.48734050646, 12858.485660573473, 12957.546485872948, 25176.0, 25336.0, 25480.362990925376, 25608.48783024329, 25803.87098064535, 8903.73288801337, 8943.955280223558, 9173.908260917306, 9180.770480738034, 9225.49259790718, 5148.665336753099, 5156.381234251914, 5223.712695801767, 5295.655782374133, 5330.946690533045, 4055.6958228132416, 4250.957490425056, 4257.0, 4260.360945858146, 4261.531231564525, 711.4770643576967, 745.7613563659577, 786.7246463737761, 803.5459965119805, 808.720991258015, 686.255412877024, 765.8736308509145, 817.2807929022422, 834.6869923778584, 844.5101840932244, 10540.947295263475, 10987.230893837515, 11017.0, 11256.718582035515, 11543.36511491876, 767.8963339949036, 777.9183185765527, 778.2140038561095, 820.6635279535362, 827.7392621324263, 5125.9743701282005, 5189.974050129801, 5229.320188375486, 5243.10867152585, 5263.26314315996, 72919.0, 74200.25799741934, 74266.6286668574, 74290.628546858, 74500.62749686325, 112410.43794780974, 119704.0, 120184.0, 123187.0, 123592.0, 81074.18925810666, 94511.0, 95798.52100739592, 97389.51305243428, 99454.0109197812, 10706.518206680874, 10752.13982881352, 11017.614383496539, 11228.698116886182, 11420.714482138013, 56298.1555276663, 56463.0, 56972.430275696715, 57367.7131614356, 57923.13115303358, 78561.21438785539, 82649.58675206585, 84515.5774221125, 85518.57240713756, 86858.0, 13822.792658109935, 14383.345915219883, 14458.421663133357, 14513.492027778977, 14982.550523484313, 16237.51287461378, 16256.105914174834, 16310.918445407697, 16706.16469176512, 17106.48680539586, 14986.250687465801, 15357.23213839326, 15415.768763468333, 15535.689286214438, 15925.442609508611, 15325.846741532441, 15392.0, 15736.213189340717, 15990.120543370227, 16869.66260674755, 14160.433582656578, 15490.535283941499, 16217.432389866299, 16318.510444686679, 16569.25484912691, 11854.407279636156, 12536.874631253571, 12589.43347549344, 12624.810627840407, 12874.613761586792, 12446.751064978469, 12477.313747743961, 12548.811767823672, 12956.676083097998, 12991.935040324737], "value": 8386.968661390942, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1497.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 105.0, 113.0, 110.0, 111.0, 110.0, 109.0, 112.0, 112.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 145.0, 172.0, 118.0, 146.0, 141.0, 120.0, 171.0, 120.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 162.0, 161.0, 161.0, 161.0, 161.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 179.0, 77.0, 77.0, 78.0, 77.0, 163.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 159.0, 83.0, 83.0, 84.0, 141.0, 83.0, 83.0, 158.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 119.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 146.0, 148.0, 148.0, 146.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 98.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 51.0, 53.0, 54.0, 52.0, 53.0, 53.0, 53.0, 54.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 59.0, 60.0, 60.0, 59.0, 58.0, 59.0, 60.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 73.0, 73.0, 72.0, 73.0, 73.0, 71.0, 73.0, 73.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 134.0, 120.0, 120.0, 121.0, 121.0, 117.0, 119.0, 159.0, 117.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 158.0, 155.0, 151.0, 156.0, 151.0, 155.0, 153.0, 148.0, 154.0], "value": 153.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 67.0, 61.0, 63.0, 64.0, 62.0, 62.0, 62.0, 60.0], "value": 62.4, "unit": "score"}]}]} 09:12:25 INFO - Return code: 0 09:12:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:12:25 ERROR - # TBPL SUCCESS # 09:12:25 INFO - Running post-action listener: _resource_record_post_action 09:12:25 INFO - [mozharness: 2016-09-03 16:12:25.833556Z] Finished run-tests step (success) 09:12:25 INFO - Running post-run listener: _resource_record_post_run 09:12:25 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 328368128; Read time: 0; Write time: 256532 09:12:25 INFO - TinderboxPrint: CPU usage
13.2% 09:12:25 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:12:25 INFO - TinderboxPrint: I/O write bytes / time
328,368,128 / 256,532 09:12:25 INFO - TinderboxPrint: CPU idle
8,240.5 (86.8%) 09:12:25 INFO - TinderboxPrint: CPU user
1,197.0 (12.6%) 09:12:25 INFO - TinderboxPrint: Swap in / out
0 / 0 09:12:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 79663104; Read time: 0; Write time: 100164 09:12:25 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 248705024; Read time: 0; Write time: 156368 09:12:26 INFO - Running post-run listener: _upload_blobber_files 09:12:26 INFO - Blob upload gear active. 09:12:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:12:26 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 09:12:26 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'] 09:12:26 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 09:12:26 INFO - (blobuploader) - INFO - Open directory for files ... 09:12:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:12:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:12:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:27 INFO - (blobuploader) - INFO - Done attempting. 09:12:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:12:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:12:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:28 INFO - (blobuploader) - INFO - Done attempting. 09:12:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:12:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:12:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:32 INFO - (blobuploader) - INFO - Done attempting. 09:12:32 INFO - (blobuploader) - INFO - Iteration through files over. 09:12:32 INFO - Return code: 0 09:12:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:12:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:12:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2bf4a65caf572d14a9bc0840959215eaa387eb83f8f4afec317eb11bb71d82ec83580a4f2ca54da75673a3cc3566402098864f85f79b27a352d83f037ef5c86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1226776c0e0b3c802e47887144e5b60b70a65af80bfa13222068cefbb71a904d9a3745256ef4fc0acdd1b138404ffa24b2db3e7069c6f5dbf0ef637c48417cb8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3aa5c04c483ca55934f752e73f161a8e89787143eb75a6c7450f208a7559d4f0e0d0bdf7ef60c21f30c29c7c356e9b3899f64e3169fd1e09f28c23960df04cbe"} 09:12:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:12:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:12:32 INFO - Contents: 09:12:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2bf4a65caf572d14a9bc0840959215eaa387eb83f8f4afec317eb11bb71d82ec83580a4f2ca54da75673a3cc3566402098864f85f79b27a352d83f037ef5c86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1226776c0e0b3c802e47887144e5b60b70a65af80bfa13222068cefbb71a904d9a3745256ef4fc0acdd1b138404ffa24b2db3e7069c6f5dbf0ef637c48417cb8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3aa5c04c483ca55934f752e73f161a8e89787143eb75a6c7450f208a7559d4f0e0d0bdf7ef60c21f30c29c7c356e9b3899f64e3169fd1e09f28c23960df04cbe"} 09:12:32 INFO - Running post-run listener: copy_logs_to_upload_dir 09:12:32 INFO - Copying logs to upload dir... 09:12:32 INFO - mkdir: /builds/slave/test/build/upload/logs 09:12:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1679.692969 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 59 secs) (at 2016-09-03 09:12:32.090436) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-03 09:12:32.095051) ========= 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=fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763 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/b2bf4a65caf572d14a9bc0840959215eaa387eb83f8f4afec317eb11bb71d82ec83580a4f2ca54da75673a3cc3566402098864f85f79b27a352d83f037ef5c86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1226776c0e0b3c802e47887144e5b60b70a65af80bfa13222068cefbb71a904d9a3745256ef4fc0acdd1b138404ffa24b2db3e7069c6f5dbf0ef637c48417cb8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3aa5c04c483ca55934f752e73f161a8e89787143eb75a6c7450f208a7559d4f0e0d0bdf7ef60c21f30c29c7c356e9b3899f64e3169fd1e09f28c23960df04cbe"} build_url:https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/OfNyQ8qgRByVmpXfRDQFhg/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/b2bf4a65caf572d14a9bc0840959215eaa387eb83f8f4afec317eb11bb71d82ec83580a4f2ca54da75673a3cc3566402098864f85f79b27a352d83f037ef5c86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1226776c0e0b3c802e47887144e5b60b70a65af80bfa13222068cefbb71a904d9a3745256ef4fc0acdd1b138404ffa24b2db3e7069c6f5dbf0ef637c48417cb8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3aa5c04c483ca55934f752e73f161a8e89787143eb75a6c7450f208a7559d4f0e0d0bdf7ef60c21f30c29c7c356e9b3899f64e3169fd1e09f28c23960df04cbe"}' ========= master_lag: 0.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-03 09:12:32.241308) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 09:12:32.241652) ========= 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=fa44defc139c4ba8574fe040000001db-1472904898.5510-325625763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.20 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 09:12:32.449046) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-03 09:12:32.449355) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-03 09:12:32.451240) ========= ========= Total master_lag: 0.49 =========