builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1470499153.12 results: success (0) buildid: 20160805072232 builduid: 16f5b19919d6424fb6c268c5705c0fd7 revision: 307fe134b473938131cb0f28db52cf371883f663 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.115929) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.116414) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.116700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.187294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.187578) ========= 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=41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-06 08:59:13-- 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% 96.8M=0s 2016-08-06 08:59:13 (96.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122923 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.328318) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.328605) ========= 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=41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017816 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.384742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:13.385067) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 307fe134b473938131cb0f28db52cf371883f663 --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 307fe134b473938131cb0f28db52cf371883f663 --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=41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-06 08:59:13,536 truncating revision to first 12 chars 2016-08-06 08:59:13,536 Setting DEBUG logging. 2016-08-06 08:59:13,536 attempt 1/10 2016-08-06 08:59:13,536 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/307fe134b473?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-06 08:59:13,848 unpacking tar archive at: mozilla-aurora-307fe134b473/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638016 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:14.039305) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:14.039680) ========= script_repo_revision: 307fe134b473938131cb0f28db52cf371883f663 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:14.040219) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:14.040502) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 08:59:14.049310) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 59 secs) (at 2016-08-06 08:59:14.049684) ========= /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=41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:59:14 INFO - MultiFileLogger online at 20160806 08:59:14 in /builds/slave/test 08:59:14 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:59:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:59:14 INFO - {'append_to_log': False, 08:59:14 INFO - 'base_work_dir': '/builds/slave/test', 08:59:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:59:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:59:14 INFO - 'branch': 'Mozilla-Aurora', 08:59:14 INFO - 'buildbot_json_path': 'buildprops.json', 08:59:14 INFO - 'config_files': ('talos/linux_config.py',), 08:59:14 INFO - 'default_actions': ('clobber', 08:59:14 INFO - 'read-buildbot-config', 08:59:14 INFO - 'download-and-extract', 08:59:14 INFO - 'populate-webroot', 08:59:14 INFO - 'create-virtualenv', 08:59:14 INFO - 'install', 08:59:14 INFO - 'run-tests'), 08:59:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:59:14 INFO - 'download_minidump_stackwalk': True, 08:59:14 INFO - 'download_symbols': 'ondemand', 08:59:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:59:14 INFO - 'tooltool.py': '/tools/tooltool.py', 08:59:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:59:14 INFO - '/tools/misc-python/virtualenv.py')}, 08:59:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:59:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:59:14 INFO - 'installer_path': 'installer.exe', 08:59:14 INFO - 'log_level': 'info', 08:59:14 INFO - 'log_name': 'talos', 08:59:14 INFO - 'log_to_console': True, 08:59:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:59:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:59:14 INFO - 'opt_config_files': (), 08:59:14 INFO - 'pip_index': False, 08:59:14 INFO - 'sps_profile': False, 08:59:14 INFO - 'sps_profile_interval': 0, 08:59:14 INFO - 'suite': 'dromaeojs-e10s', 08:59:14 INFO - 'system_bits': '32', 08:59:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:59:14 INFO - 'title': 'talos-linux64-ix-026', 08:59:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:59:14 INFO - 'use_talos_json': True, 08:59:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:59:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:59:14 INFO - 'work_dir': 'build'} 08:59:14 INFO - [mozharness: 2016-08-06 15:59:14.292073Z] Running clobber step. 08:59:14 INFO - Running pre-action listener: _resource_record_pre_action 08:59:14 INFO - Running main action method: clobber 08:59:14 INFO - rmtree: /builds/slave/test/build 08:59:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:59:14 INFO - Running post-action listener: _resource_record_post_action 08:59:14 INFO - [mozharness: 2016-08-06 15:59:14.742709Z] Finished clobber step (success) 08:59:14 INFO - [mozharness: 2016-08-06 15:59:14.742810Z] Running read-buildbot-config step. 08:59:14 INFO - Running pre-action listener: _resource_record_pre_action 08:59:14 INFO - Running main action method: read_buildbot_config 08:59:14 INFO - Using buildbot properties: 08:59:14 INFO - { 08:59:14 INFO - "project": "", 08:59:14 INFO - "product": "firefox", 08:59:14 INFO - "script_repo_revision": "production", 08:59:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 08:59:14 INFO - "repository": "", 08:59:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 08:59:14 INFO - "buildid": "20160805072232", 08:59:14 INFO - "pgo_build": "True", 08:59:14 INFO - "basedir": "/builds/slave/test", 08:59:14 INFO - "buildnumber": 440, 08:59:14 INFO - "slavename": "talos-linux64-ix-026", 08:59:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:59:14 INFO - "platform": "ubuntu64_hw", 08:59:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:59:14 INFO - "branch": "mozilla-aurora", 08:59:14 INFO - "repo_path": "releases/mozilla-aurora", 08:59:14 INFO - "revision": "307fe134b473938131cb0f28db52cf371883f663", 08:59:14 INFO - "stage_platform": "linux64-pgo", 08:59:14 INFO - "builduid": "16f5b19919d6424fb6c268c5705c0fd7", 08:59:14 INFO - "slavebuilddir": "test" 08:59:14 INFO - } 08:59:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 08:59:14 INFO - Running post-action listener: _resource_record_post_action 08:59:14 INFO - [mozharness: 2016-08-06 15:59:14.745258Z] Finished read-buildbot-config step (success) 08:59:14 INFO - [mozharness: 2016-08-06 15:59:14.745344Z] Running download-and-extract step. 08:59:14 INFO - Running pre-action listener: _resource_record_pre_action 08:59:14 INFO - Running main action method: download_and_extract 08:59:14 INFO - mkdir: /builds/slave/test/build/tests 08:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:14 INFO - https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:59:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:59:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:59:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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:59:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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:59:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:59:14 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:59:14 INFO - retry: Failed, sleeping 30 seconds before retrying 08:59:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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:59:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:59:44 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:59:44 INFO - retry: Failed, sleeping 60 seconds before retrying 09:00:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:00:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 09:00:44 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:00:44 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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! 09:00:44 INFO - Caught exception: HTTP Error 404: Not Found 09:00:44 INFO - Caught exception: HTTP Error 404: Not Found 09:00:44 INFO - Caught exception: HTTP Error 404: Not Found 09:00:44 INFO - trying https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 09:00:44 INFO - Downloading https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:00:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:00:45 INFO - Downloaded 1361 bytes. 09:00:45 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 09:00:45 INFO - Using the following test package requirements: 09:00:45 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 09:00:45 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:45 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:00:45 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:45 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:00:45 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:45 INFO - u'jsshell-linux-x86_64.zip'], 09:00:45 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:45 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:00:45 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 09:00:45 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:45 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:00:45 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:45 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:00:45 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:45 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:00:45 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:00:45 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:00:45 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:00:45 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')]} 09:00:45 INFO - https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:00:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:00:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:00:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:00:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:00:45 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:00:45 INFO - retry: Failed, sleeping 30 seconds before retrying 09:01:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:01:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:01:15 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:01:15 INFO - retry: Failed, sleeping 60 seconds before retrying 09:02:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:02:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:02:15 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:02:15 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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! 09:02:15 INFO - Caught exception: HTTP Error 404: Not Found 09:02:15 INFO - Caught exception: HTTP Error 404: Not Found 09:02:15 INFO - Caught exception: HTTP Error 404: Not Found 09:02:15 INFO - trying https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:02:15 INFO - Downloading https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:02:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:02:16 INFO - Downloaded 21765973 bytes. 09:02:16 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'] 09:02:16 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 09:02:17 INFO - Return code: 0 09:02:17 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 09:02:17 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')]} 09:02:17 INFO - https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:02:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:02:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:02:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:02:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:02:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:02:17 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:02:17 INFO - retry: Failed, sleeping 30 seconds before retrying 09:02:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:02:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:02:47 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:02:47 INFO - retry: Failed, sleeping 60 seconds before retrying 09:03:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:03:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:03:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:03:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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! 09:03:48 INFO - Caught exception: HTTP Error 404: Not Found 09:03:48 INFO - Caught exception: HTTP Error 404: Not Found 09:03:48 INFO - Caught exception: HTTP Error 404: Not Found 09:03:48 INFO - trying https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:03:48 INFO - Downloading https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:03:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:03:50 INFO - Downloaded 21765973 bytes. 09:03:50 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'] 09:03:50 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 09:03:51 INFO - Return code: 0 09:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:03:51 INFO - https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:03:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 09:03:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 09:03:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:03:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:03:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 09:03:51 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:03:51 INFO - retry: Failed, sleeping 30 seconds before retrying 09:04:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:04:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 09:04:21 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:04:21 INFO - retry: Failed, sleeping 60 seconds before retrying 09:05:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:05:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 09:05:21 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:05:21 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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! 09:05:21 INFO - Caught exception: HTTP Error 404: Not Found 09:05:21 INFO - Caught exception: HTTP Error 404: Not Found 09:05:21 INFO - Caught exception: HTTP Error 404: Not Found 09:05:21 INFO - trying https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 09:05:21 INFO - Downloading https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:05:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:05:22 INFO - Downloaded 14413723 bytes. 09:05:22 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'] 09:05:22 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 09:05:22 INFO - Return code: 0 09:05:22 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')]} 09:05:22 INFO - https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:05:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:05:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:05:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:05:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:05:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:05:22 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:05:22 INFO - retry: Failed, sleeping 30 seconds before retrying 09:05:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:05:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:05:52 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:05:52 INFO - retry: Failed, sleeping 60 seconds before retrying 09:06:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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 09:06:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:06:52 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:06:52 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btWqjEikQhmY-m4REu51dw/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! 09:06:52 INFO - Caught exception: HTTP Error 404: Not Found 09:06:52 INFO - Caught exception: HTTP Error 404: Not Found 09:06:52 INFO - Caught exception: HTTP Error 404: Not Found 09:06:52 INFO - trying https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:06:52 INFO - Downloading https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:06:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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 09:06:54 INFO - Downloaded 63764898 bytes. 09:06:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:06:54 INFO - mkdir: /builds/slave/test/properties 09:06:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:06:54 INFO - Writing to file /builds/slave/test/properties/build_url 09:06:54 INFO - Contents: 09:06:54 INFO - build_url:https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 09:06:55 INFO - Running post-action listener: _resource_record_post_action 09:06:55 INFO - Running post-action listener: set_extra_try_arguments 09:06:55 INFO - [mozharness: 2016-08-06 16:06:55.348613Z] Finished download-and-extract step (success) 09:06:55 INFO - [mozharness: 2016-08-06 16:06:55.348844Z] Running populate-webroot step. 09:06:55 INFO - Running pre-action listener: _resource_record_pre_action 09:06:55 INFO - Running main action method: populate_webroot 09:06:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:06:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:06:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:06:55 INFO - '--tppagecycles', 09:06:55 INFO - '7'], 09:06:55 INFO - 'tests': ['tsvgm']}}, 09:06:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:06:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:06:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:06:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:06:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:06:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:06:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:55 INFO - 'talos_options': ['--disable-e10s'], 09:06:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:06:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:55 INFO - 'talos_options': ['--disable-e10s'], 09:06:55 INFO - 'tests': ['damp', 'tps']}, 09:06:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:55 INFO - 'tests': ['damp', 'tps']}, 09:06:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:06:55 INFO - 'tests': ['dromaeo_dom']}, 09:06:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:06:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:06:55 INFO - 'tests': ['basic_compositor_video']}, 09:06:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:06:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:06:55 INFO - 'tests': ['a11yr', 09:06:55 INFO - 'ts_paint', 09:06:55 INFO - 'tpaint', 09:06:55 INFO - 'sessionrestore', 09:06:55 INFO - 'sessionrestore_no_auto_restore', 09:06:55 INFO - 'tabpaint']}, 09:06:55 INFO - 'other-e10s': {'tests': ['a11yr', 09:06:55 INFO - 'ts_paint', 09:06:55 INFO - 'tpaint', 09:06:55 INFO - 'sessionrestore', 09:06:55 INFO - 'sessionrestore_no_auto_restore', 09:06:55 INFO - 'tabpaint']}, 09:06:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:06:55 INFO - 'ts_paint', 09:06:55 INFO - 'tpaint', 09:06:55 INFO - 'sessionrestore', 09:06:55 INFO - 'sessionrestore_no_auto_restore', 09:06:55 INFO - 'tabpaint']}, 09:06:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:06:55 INFO - 'ts_paint', 09:06:55 INFO - 'tpaint', 09:06:55 INFO - 'sessionrestore', 09:06:55 INFO - 'sessionrestore_no_auto_restore', 09:06:55 INFO - 'tabpaint']}, 09:06:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:06:55 INFO - 'tests': ['a11yr', 09:06:55 INFO - 'ts_paint', 09:06:55 INFO - 'tpaint', 09:06:55 INFO - 'sessionrestore', 09:06:55 INFO - 'sessionrestore_no_auto_restore', 09:06:55 INFO - 'tabpaint']}, 09:06:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:06:55 INFO - 'tests': ['a11yr', 09:06:55 INFO - 'ts_paint', 09:06:55 INFO - 'tpaint', 09:06:55 INFO - 'sessionrestore', 09:06:55 INFO - 'sessionrestore_no_auto_restore', 09:06:55 INFO - 'tabpaint']}, 09:06:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:06:55 INFO - 'tests': ['tsvgx', 09:06:55 INFO - 'tsvgr_opacity', 09:06:55 INFO - 'tart', 09:06:55 INFO - 'tscrollx', 09:06:55 INFO - 'cart']}, 09:06:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:06:55 INFO - 'tsvgr_opacity', 09:06:55 INFO - 'tart', 09:06:55 INFO - 'tscrollx', 09:06:55 INFO - 'cart']}, 09:06:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:55 INFO - 'talos_options': ['--disable-e10s'], 09:06:55 INFO - 'tests': ['tp5o']}, 09:06:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:55 INFO - 'tests': ['tp5o']}, 09:06:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:55 INFO - 'talos_options': ['--disable-e10s', 09:06:55 INFO - '--xperf_path', 09:06:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:55 INFO - 'tests': ['tp5n']}, 09:06:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:06:55 INFO - 'talos_options': ['--xperf_path', 09:06:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:06:55 INFO - 'tests': ['tp5n']}}, 09:06:55 INFO - 'talos.zip': {'path': '', 09:06:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:06:55 INFO - Running post-action listener: _resource_record_post_action 09:06:55 INFO - [mozharness: 2016-08-06 16:06:55.366091Z] Finished populate-webroot step (success) 09:06:55 INFO - [mozharness: 2016-08-06 16:06:55.366180Z] Running create-virtualenv step. 09:06:55 INFO - Running pre-action listener: _resource_record_pre_action 09:06:55 INFO - Running main action method: create_virtualenv 09:06:55 INFO - Creating virtualenv /builds/slave/test/build/venv 09:06:55 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 09:06:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:06:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:06:55 INFO - Using real prefix '/usr' 09:06:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:06:55 INFO - Installing distribute.............................................................................................................................................................................................done. 09:06:57 INFO - Installing pip.................done. 09:06:57 INFO - Return code: 0 09:06:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da570>, '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 0x12db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12db900>, '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': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', '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 09:06:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:06:57 INFO - Using env: {'DISPLAY': ':0', 09:06:57 INFO - 'HOME': '/home/cltbld', 09:06:57 INFO - 'LANG': 'en_US.UTF-8', 09:06:57 INFO - 'LANGUAGE': 'en_US:en', 09:06:57 INFO - 'LOGNAME': 'cltbld', 09:06:57 INFO - 'MAIL': '/var/mail/cltbld', 09:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:57 INFO - 'MOZ_NO_REMOTE': '1', 09:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:57 INFO - 'NO_EM_RESTART': '1', 09:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:57 INFO - 'PWD': '/builds/slave/test', 09:06:57 INFO - 'SHELL': '/bin/bash', 09:06:57 INFO - 'SHLVL': '1', 09:06:57 INFO - 'TERM': 'linux', 09:06:57 INFO - 'TMOUT': '86400', 09:06:57 INFO - 'USER': 'cltbld', 09:06:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', 09:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:57 INFO - '_': '/tools/buildbot/bin/python'} 09:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:58 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 09:06:58 INFO - Cleaning up... 09:06:58 INFO - Return code: 0 09:06:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da570>, '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 0x12db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12db900>, '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': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', '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 09:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:06:58 INFO - Using env: {'DISPLAY': ':0', 09:06:58 INFO - 'HOME': '/home/cltbld', 09:06:58 INFO - 'LANG': 'en_US.UTF-8', 09:06:58 INFO - 'LANGUAGE': 'en_US:en', 09:06:58 INFO - 'LOGNAME': 'cltbld', 09:06:58 INFO - 'MAIL': '/var/mail/cltbld', 09:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:58 INFO - 'MOZ_NO_REMOTE': '1', 09:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:58 INFO - 'NO_EM_RESTART': '1', 09:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:58 INFO - 'PWD': '/builds/slave/test', 09:06:58 INFO - 'SHELL': '/bin/bash', 09:06:58 INFO - 'SHLVL': '1', 09:06:58 INFO - 'TERM': 'linux', 09:06:58 INFO - 'TMOUT': '86400', 09:06:58 INFO - 'USER': 'cltbld', 09:06:58 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', 09:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:58 INFO - '_': '/tools/buildbot/bin/python'} 09:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:58 INFO - Downloading/unpacking psutil>=3.1.1 09:06:58 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 09:06:58 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 09:06:58 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 09:06:58 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 09:06:58 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 09:06:58 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 09:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:07:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:00 INFO - Installing collected packages: psutil 09:07:00 INFO - Running setup.py install for psutil 09:07:00 INFO - building 'psutil._psutil_linux' extension 09:07:00 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 09:07:00 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 09:07:00 INFO - building 'psutil._psutil_posix' extension 09:07:00 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 09:07:00 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 09:07:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:00 INFO - Successfully installed psutil 09:07:00 INFO - Cleaning up... 09:07:00 INFO - Return code: 0 09:07:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:07:00 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')]} 09:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:00 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')]} 09:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:00 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 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da570>, '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 0x12db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12db900>, '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': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', '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 09:07:00 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 09:07:00 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 09:07:00 INFO - Using env: {'DISPLAY': ':0', 09:07:00 INFO - 'HOME': '/home/cltbld', 09:07:00 INFO - 'LANG': 'en_US.UTF-8', 09:07:00 INFO - 'LANGUAGE': 'en_US:en', 09:07:00 INFO - 'LOGNAME': 'cltbld', 09:07:00 INFO - 'MAIL': '/var/mail/cltbld', 09:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:00 INFO - 'MOZ_NO_REMOTE': '1', 09:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:00 INFO - 'NO_EM_RESTART': '1', 09:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:00 INFO - 'PWD': '/builds/slave/test', 09:07:00 INFO - 'SHELL': '/bin/bash', 09:07:00 INFO - 'SHLVL': '1', 09:07:00 INFO - 'TERM': 'linux', 09:07:00 INFO - 'TMOUT': '86400', 09:07:00 INFO - 'USER': 'cltbld', 09:07:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', 09:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:00 INFO - '_': '/tools/buildbot/bin/python'} 09:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:07:03 INFO - Installing collected packages: mozsystemmonitor 09:07:03 INFO - Running setup.py install for mozsystemmonitor 09:07:03 INFO - Successfully installed mozsystemmonitor 09:07:03 INFO - Cleaning up... 09:07:03 INFO - Return code: 0 09:07:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da570>, '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 0x12db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12db900>, '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': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', '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 09:07:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:07:03 INFO - Using env: {'DISPLAY': ':0', 09:07:03 INFO - 'HOME': '/home/cltbld', 09:07:03 INFO - 'LANG': 'en_US.UTF-8', 09:07:03 INFO - 'LANGUAGE': 'en_US:en', 09:07:03 INFO - 'LOGNAME': 'cltbld', 09:07:03 INFO - 'MAIL': '/var/mail/cltbld', 09:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:03 INFO - 'MOZ_NO_REMOTE': '1', 09:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:03 INFO - 'NO_EM_RESTART': '1', 09:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:03 INFO - 'PWD': '/builds/slave/test', 09:07:03 INFO - 'SHELL': '/bin/bash', 09:07:03 INFO - 'SHLVL': '1', 09:07:03 INFO - 'TERM': 'linux', 09:07:03 INFO - 'TMOUT': '86400', 09:07:03 INFO - 'USER': 'cltbld', 09:07:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', 09:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:03 INFO - '_': '/tools/buildbot/bin/python'} 09:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:03 INFO - Downloading/unpacking jsonschema==2.5.1 09:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:07:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:07:05 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 09:07:05 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 09:07:05 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 09:07:05 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 09:07:05 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 09:07:05 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 09:07:05 INFO - Downloading functools32-3.2.3-2.tar.gz 09:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:07:05 INFO - warning: no files found matching '*.txt' 09:07:05 INFO - no previously-included directories found matching 'build' 09:07:05 INFO - no previously-included directories found matching 'dist' 09:07:05 INFO - no previously-included directories found matching '.git*' 09:07:05 INFO - Installing collected packages: jsonschema, functools32 09:07:05 INFO - Running setup.py install for functools32 09:07:05 INFO - warning: no files found matching '*.txt' 09:07:05 INFO - no previously-included directories found matching 'build' 09:07:05 INFO - no previously-included directories found matching 'dist' 09:07:05 INFO - no previously-included directories found matching '.git*' 09:07:05 INFO - Successfully installed jsonschema functools32 09:07:05 INFO - Cleaning up... 09:07:05 INFO - Return code: 0 09:07:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:05 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 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da570>, '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 0x12db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12db900>, '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': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', '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 09:07:05 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 09:07:05 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 09:07:05 INFO - Using env: {'DISPLAY': ':0', 09:07:05 INFO - 'HOME': '/home/cltbld', 09:07:05 INFO - 'LANG': 'en_US.UTF-8', 09:07:05 INFO - 'LANGUAGE': 'en_US:en', 09:07:05 INFO - 'LOGNAME': 'cltbld', 09:07:05 INFO - 'MAIL': '/var/mail/cltbld', 09:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:05 INFO - 'MOZ_NO_REMOTE': '1', 09:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:05 INFO - 'NO_EM_RESTART': '1', 09:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:05 INFO - 'PWD': '/builds/slave/test', 09:07:05 INFO - 'SHELL': '/bin/bash', 09:07:05 INFO - 'SHLVL': '1', 09:07:05 INFO - 'TERM': 'linux', 09:07:05 INFO - 'TMOUT': '86400', 09:07:05 INFO - 'USER': 'cltbld', 09:07:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', 09:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:05 INFO - '_': '/tools/buildbot/bin/python'} 09:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:07:06 INFO - Cleaning up... 09:07:06 INFO - Return code: 0 09:07:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:07:06 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')]} 09:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:06 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')]} 09:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:06 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 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da570>, '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 0x12db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12db900>, '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': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', '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 09:07:06 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 09:07:06 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 09:07:06 INFO - Using env: {'DISPLAY': ':0', 09:07:06 INFO - 'HOME': '/home/cltbld', 09:07:06 INFO - 'LANG': 'en_US.UTF-8', 09:07:06 INFO - 'LANGUAGE': 'en_US:en', 09:07:06 INFO - 'LOGNAME': 'cltbld', 09:07:06 INFO - 'MAIL': '/var/mail/cltbld', 09:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:06 INFO - 'MOZ_NO_REMOTE': '1', 09:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:06 INFO - 'NO_EM_RESTART': '1', 09:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:06 INFO - 'PWD': '/builds/slave/test', 09:07:06 INFO - 'SHELL': '/bin/bash', 09:07:06 INFO - 'SHLVL': '1', 09:07:06 INFO - 'TERM': 'linux', 09:07:06 INFO - 'TMOUT': '86400', 09:07:06 INFO - 'USER': 'cltbld', 09:07:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', 09:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:06 INFO - '_': '/tools/buildbot/bin/python'} 09:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:06 INFO - Downloading/unpacking blobuploader==1.2.4 09:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:08 INFO - Downloading blobuploader-1.2.4.tar.gz 09:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:07:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:07:08 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 09:07:08 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 09:07:08 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 09:07:08 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 09:07:08 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 09:07:08 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 09:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:07:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:07:08 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 09:07:08 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 09:07:08 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 09:07:08 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 09:07:08 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 09:07:08 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 09:07:08 INFO - Downloading docopt-0.6.1.tar.gz 09:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:07:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:07:08 INFO - Running setup.py install for blobuploader 09:07:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:07:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:07:09 INFO - Running setup.py install for requests 09:07:09 INFO - Running setup.py install for docopt 09:07:09 INFO - Successfully installed blobuploader requests docopt 09:07:09 INFO - Cleaning up... 09:07:09 INFO - Return code: 0 09:07:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:09 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 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da570>, '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 0x12db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12db900>, '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': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', '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 09:07:09 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 09:07:09 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 09:07:09 INFO - Using env: {'DISPLAY': ':0', 09:07:09 INFO - 'HOME': '/home/cltbld', 09:07:09 INFO - 'LANG': 'en_US.UTF-8', 09:07:09 INFO - 'LANGUAGE': 'en_US:en', 09:07:09 INFO - 'LOGNAME': 'cltbld', 09:07:09 INFO - 'MAIL': '/var/mail/cltbld', 09:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:09 INFO - 'MOZ_NO_REMOTE': '1', 09:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:09 INFO - 'NO_EM_RESTART': '1', 09:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:09 INFO - 'PWD': '/builds/slave/test', 09:07:09 INFO - 'SHELL': '/bin/bash', 09:07:09 INFO - 'SHLVL': '1', 09:07:09 INFO - 'TERM': 'linux', 09:07:09 INFO - 'TMOUT': '86400', 09:07:09 INFO - 'USER': 'cltbld', 09:07:09 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', 09:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:09 INFO - '_': '/tools/buildbot/bin/python'} 09:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:09 INFO - Running setup.py (path:/tmp/pip-lfdzGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:09 INFO - Running setup.py (path:/tmp/pip-MTEAJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:09 INFO - Running setup.py (path:/tmp/pip-lWBSqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:09 INFO - Running setup.py (path:/tmp/pip-LDgKpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:10 INFO - Running setup.py (path:/tmp/pip-CcnOrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:10 INFO - Running setup.py (path:/tmp/pip-TRYdhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:10 INFO - Running setup.py (path:/tmp/pip-r6HHIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:10 INFO - Running setup.py (path:/tmp/pip-pnyRDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:10 INFO - Running setup.py (path:/tmp/pip-Z3n4Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:10 INFO - Running setup.py (path:/tmp/pip-R8Lcym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:10 INFO - Running setup.py (path:/tmp/pip-yDN42l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:10 INFO - Running setup.py (path:/tmp/pip-q1S1n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:10 INFO - Running setup.py (path:/tmp/pip-wmKpb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:10 INFO - Running setup.py (path:/tmp/pip-Wqtyx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:10 INFO - Running setup.py (path:/tmp/pip-YCb_ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:10 INFO - Running setup.py (path:/tmp/pip-zdDZr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:10 INFO - Running setup.py (path:/tmp/pip-qBYFeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:07:10 INFO - Running setup.py install for manifestparser 09:07:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Running setup.py install for mozcrash 09:07:11 INFO - Running setup.py install for mozdebug 09:07:11 INFO - Running setup.py install for mozdevice 09:07:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Running setup.py install for mozfile 09:07:11 INFO - Running setup.py install for mozhttpd 09:07:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Running setup.py install for mozinfo 09:07:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Running setup.py install for mozInstall 09:07:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:07:11 INFO - Running setup.py install for mozleak 09:07:11 INFO - Running setup.py install for mozlog 09:07:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:07:12 INFO - Running setup.py install for moznetwork 09:07:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:07:12 INFO - Running setup.py install for mozprocess 09:07:12 INFO - Running setup.py install for mozprofile 09:07:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:07:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:07:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:07:12 INFO - Running setup.py install for mozrunner 09:07:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:07:12 INFO - Running setup.py install for mozscreenshot 09:07:12 INFO - Running setup.py install for moztest 09:07:12 INFO - Running setup.py install for mozversion 09:07:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:07:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:07:12 INFO - Cleaning up... 09:07:12 INFO - Return code: 0 09:07:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:12 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 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da570>, '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 0x12db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12db900>, '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': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', '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 09:07:12 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 09:07:12 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 09:07:12 INFO - Using env: {'DISPLAY': ':0', 09:07:12 INFO - 'HOME': '/home/cltbld', 09:07:12 INFO - 'LANG': 'en_US.UTF-8', 09:07:12 INFO - 'LANGUAGE': 'en_US:en', 09:07:12 INFO - 'LOGNAME': 'cltbld', 09:07:12 INFO - 'MAIL': '/var/mail/cltbld', 09:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:12 INFO - 'MOZ_NO_REMOTE': '1', 09:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:12 INFO - 'NO_EM_RESTART': '1', 09:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:12 INFO - 'PWD': '/builds/slave/test', 09:07:12 INFO - 'SHELL': '/bin/bash', 09:07:12 INFO - 'SHLVL': '1', 09:07:12 INFO - 'TERM': 'linux', 09:07:12 INFO - 'TMOUT': '86400', 09:07:12 INFO - 'USER': 'cltbld', 09:07:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', 09:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:12 INFO - '_': '/tools/buildbot/bin/python'} 09:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:12 INFO - Running setup.py (path:/tmp/pip-859mkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:13 INFO - Running setup.py (path:/tmp/pip-sDdAJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:13 INFO - Running setup.py (path:/tmp/pip-bQQa8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:13 INFO - Running setup.py (path:/tmp/pip-GuP4xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:13 INFO - Running setup.py (path:/tmp/pip-phqXqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:13 INFO - Running setup.py (path:/tmp/pip-l3haQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:13 INFO - Running setup.py (path:/tmp/pip-ZrS_Rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:13 INFO - Running setup.py (path:/tmp/pip-Gcp139-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:13 INFO - Running setup.py (path:/tmp/pip-fpTHrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:13 INFO - Running setup.py (path:/tmp/pip-7W4z3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:13 INFO - Running setup.py (path:/tmp/pip-VI9mE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:13 INFO - Running setup.py (path:/tmp/pip-PlSxkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:13 INFO - Running setup.py (path:/tmp/pip-gAqUBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:13 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)) 09:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:13 INFO - Running setup.py (path:/tmp/pip-gw6UoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:14 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)) 09:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:14 INFO - Running setup.py (path:/tmp/pip-MsCBDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:14 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)) 09:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:14 INFO - Running setup.py (path:/tmp/pip-QUjh02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:14 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)) 09:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:14 INFO - Running setup.py (path:/tmp/pip-_0FEWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:14 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)) 09:07:14 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)) 09:07:14 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)) 09:07:14 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)) 09:07:14 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)) 09:07:14 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)) 09:07:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:07:14 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 09:07:14 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 09:07:14 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 09:07:14 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 09:07:14 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 09:07:14 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 09:07:16 INFO - Downloading blessings-1.6.tar.gz 09:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:07:16 INFO - Installing collected packages: blessings 09:07:16 INFO - Running setup.py install for blessings 09:07:16 INFO - Successfully installed blessings 09:07:16 INFO - Cleaning up... 09:07:16 INFO - Return code: 0 09:07:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:07:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:16 INFO - Reading from file tmpfile_stdout 09:07:16 INFO - Current package versions: 09:07:16 INFO - argparse == 1.2.1 09:07:16 INFO - blessings == 1.6 09:07:16 INFO - blobuploader == 1.2.4 09:07:16 INFO - docopt == 0.6.1 09:07:16 INFO - functools32 == 3.2.3-2 09:07:16 INFO - jsonschema == 2.5.1 09:07:16 INFO - manifestparser == 1.1 09:07:16 INFO - mozInstall == 1.12 09:07:16 INFO - mozcrash == 0.17 09:07:16 INFO - mozdebug == 0.1 09:07:16 INFO - mozdevice == 0.48 09:07:16 INFO - mozfile == 1.2 09:07:16 INFO - mozhttpd == 0.7 09:07:16 INFO - mozinfo == 0.9 09:07:16 INFO - mozleak == 0.1 09:07:16 INFO - mozlog == 3.3 09:07:16 INFO - moznetwork == 0.27 09:07:16 INFO - mozprocess == 0.23 09:07:16 INFO - mozprofile == 0.28 09:07:16 INFO - mozrunner == 6.12 09:07:16 INFO - mozscreenshot == 0.1 09:07:16 INFO - mozsystemmonitor == 0.3 09:07:16 INFO - moztest == 0.7 09:07:16 INFO - mozversion == 1.4 09:07:16 INFO - psutil == 3.1.1 09:07:16 INFO - requests == 1.2.3 09:07:16 INFO - wsgiref == 0.1.2 09:07:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:16 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 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da570>, '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 0x12db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12db900>, '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': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', '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 09:07:16 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 09:07:16 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 09:07:16 INFO - Using env: {'DISPLAY': ':0', 09:07:16 INFO - 'HOME': '/home/cltbld', 09:07:16 INFO - 'LANG': 'en_US.UTF-8', 09:07:16 INFO - 'LANGUAGE': 'en_US:en', 09:07:16 INFO - 'LOGNAME': 'cltbld', 09:07:16 INFO - 'MAIL': '/var/mail/cltbld', 09:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:16 INFO - 'MOZ_NO_REMOTE': '1', 09:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:16 INFO - 'NO_EM_RESTART': '1', 09:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:16 INFO - 'PWD': '/builds/slave/test', 09:07:16 INFO - 'SHELL': '/bin/bash', 09:07:16 INFO - 'SHLVL': '1', 09:07:16 INFO - 'TERM': 'linux', 09:07:16 INFO - 'TMOUT': '86400', 09:07:16 INFO - 'USER': 'cltbld', 09:07:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', 09:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:16 INFO - '_': '/tools/buildbot/bin/python'} 09:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 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)) 09:07:16 INFO - Cleaning up... 09:07:16 INFO - Return code: 0 09:07:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12da570>, '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 0x12db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12db900>, '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': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', '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 09:07: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', 'jsonschema'] in /builds/slave/test/build 09:07: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 jsonschema 09:07:16 INFO - Using env: {'DISPLAY': ':0', 09:07:16 INFO - 'HOME': '/home/cltbld', 09:07:16 INFO - 'LANG': 'en_US.UTF-8', 09:07:16 INFO - 'LANGUAGE': 'en_US:en', 09:07:16 INFO - 'LOGNAME': 'cltbld', 09:07:16 INFO - 'MAIL': '/var/mail/cltbld', 09:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:16 INFO - 'MOZ_NO_REMOTE': '1', 09:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:16 INFO - 'NO_EM_RESTART': '1', 09:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:16 INFO - 'PWD': '/builds/slave/test', 09:07:16 INFO - 'SHELL': '/bin/bash', 09:07:16 INFO - 'SHLVL': '1', 09:07:16 INFO - 'TERM': 'linux', 09:07:16 INFO - 'TMOUT': '86400', 09:07:16 INFO - 'USER': 'cltbld', 09:07:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', 09:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:16 INFO - '_': '/tools/buildbot/bin/python'} 09:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:07:17 INFO - Cleaning up... 09:07:17 INFO - Return code: 0 09:07:17 INFO - Running post-action listener: _resource_record_post_action 09:07:17 INFO - Running post-action listener: _start_resource_monitoring 09:07:17 INFO - Starting resource monitoring. 09:07:17 INFO - [mozharness: 2016-08-06 16:07:17.237984Z] Finished create-virtualenv step (success) 09:07:17 INFO - [mozharness: 2016-08-06 16:07:17.238448Z] Running install step. 09:07:17 INFO - Running pre-action listener: _resource_record_pre_action 09:07:17 INFO - Running main action method: install 09:07:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:17 INFO - Reading from file tmpfile_stdout 09:07:17 INFO - Detecting whether we're running mozinstall >=1.0... 09:07:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:07:17 INFO - Reading from file tmpfile_stdout 09:07:17 INFO - Output received: 09:07:17 INFO - Usage: mozinstall [options] installer 09:07:17 INFO - Options: 09:07:17 INFO - -h, --help show this help message and exit 09:07:17 INFO - -d DEST, --destination=DEST 09:07:17 INFO - Directory to install application into. [default: 09:07:17 INFO - "/builds/slave/test"] 09:07:17 INFO - --app=APP Application being installed. [default: firefox] 09:07:17 INFO - mkdir: /builds/slave/test/build/application 09:07:17 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'] 09:07:17 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 09:07:33 INFO - Reading from file tmpfile_stdout 09:07:33 INFO - Output received: 09:07:33 INFO - /builds/slave/test/build/application/firefox/firefox 09:07:33 INFO - Running post-action listener: _resource_record_post_action 09:07:33 INFO - [mozharness: 2016-08-06 16:07:33.929775Z] Finished install step (success) 09:07:33 INFO - [mozharness: 2016-08-06 16:07:33.930051Z] Running run-tests step. 09:07:33 INFO - Running pre-action listener: _resource_record_pre_action 09:07:33 INFO - Running main action method: run_tests 09:07:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:07:33 INFO - Python 2.7.3 09:07:33 INFO - Return code: 0 09:07:33 INFO - grabbing minidump binary from tooltool 09:07: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')]} 09:07:33 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 0x12da570>, '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 0x12db470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12db900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:07:33 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 09:07:33 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 09:07:33 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 09:07:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:07:34 INFO - Return code: 0 09:07:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:07:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:07:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:07:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:07:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:07:34 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/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 09:07:34 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/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 09:07:34 INFO - Using env: {'DISPLAY': ':0', 09:07:34 INFO - 'HOME': '/home/cltbld', 09:07:34 INFO - 'LANG': 'en_US.UTF-8', 09:07:34 INFO - 'LANGUAGE': 'en_US:en', 09:07:34 INFO - 'LOGNAME': 'cltbld', 09:07:34 INFO - 'MAIL': '/var/mail/cltbld', 09:07:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:07:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:34 INFO - 'MOZ_NO_REMOTE': '1', 09:07:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:34 INFO - 'NO_EM_RESTART': '1', 09:07:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:34 INFO - 'PWD': '/builds/slave/test', 09:07:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:07:34 INFO - 'SHELL': '/bin/bash', 09:07:34 INFO - 'SHLVL': '1', 09:07:34 INFO - 'TERM': 'linux', 09:07:34 INFO - 'TMOUT': '86400', 09:07:34 INFO - 'USER': 'cltbld', 09:07:34 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695', 09:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:34 INFO - '_': '/tools/buildbot/bin/python'} 09:07:34 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/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 09:07:34 INFO - mozversion application_buildid: 20160805072232 09:07:34 INFO - mozversion application_changeset: 307fe134b473938131cb0f28db52cf371883f663 09:07:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:07:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:07:34 INFO - mozversion application_name: Firefox 09:07:34 INFO - mozversion application_remotingname: firefox-dev 09:07:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:07:34 INFO - mozversion application_vendor: Mozilla 09:07:34 INFO - mozversion application_version: 50.0a2 09:07:34 INFO - mozversion platform_buildid: 20160805072232 09:07:34 INFO - mozversion platform_changeset: 307fe134b473938131cb0f28db52cf371883f663 09:07:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:07:34 INFO - mozversion platform_version: 50.0a2 09:07:34 INFO - using testdate: 1470499654 09:07:34 INFO - actual date: 1470499654 09:07:34 INFO - starting webserver on 'localhost:55682' 09:07:34 INFO - SUITE-START | Running 2 tests 09:07:34 INFO - TEST-START | dromaeo_css 09:07:34 INFO - operating with platform_type : linux_ 09:07:34 INFO - Initialising browser for dromaeo_css test... 09:07:34 INFO - TEST-INFO | started process 4295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBIeLBF/profile http://localhost:55682/getInfo.html) 09:07:38 INFO - PROCESS | 4295 | __metrics Screen width/height:1600/1200 09:07:38 INFO - PROCESS | 4295 | colorDepth:24 09:07:38 INFO - PROCESS | 4295 | Browser inner width/height: 1024/697 09:07:38 INFO - PROCESS | 4295 | __metrics 09:07:39 ERROR - PROCESS | 4295 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:07:40 INFO - TEST-INFO | 4295: exit 0 09:07:40 INFO - Browser initialized. 09:07:40 INFO - Running cycle 1/1 for dromaeo_css test... 09:07:40 INFO - TEST-INFO | started process 4419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBIeLBF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:51 INFO - PROCESS | 4419 | RSS: Main: 152330240 09:07:51 INFO - PROCESS | 4419 | 09:08:41 INFO - PROCESS | 4419 | 1470499721434 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] 09:10:49 INFO - PROCESS | 4419 | Cycle 1(1): loaded http://localhost:55682/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55682/tests/dromaeo/cssquery-ext.html) 09:10:51 INFO - PROCESS | 4419 | RSS: Main: 157507584 09:10:51 INFO - PROCESS | 4419 | 09:13:53 INFO - PROCESS | 4419 | Cycle 1(1): loaded http://localhost:55682/tests/dromaeo/cssquery-ext.html (next: http://localhost:55682/tests/dromaeo/cssquery-jquery.html) 09:13:53 INFO - PROCESS | 4419 | RSS: Main: 153776128 09:13:53 INFO - PROCESS | 4419 | 09:16:55 INFO - PROCESS | 4419 | Cycle 1(1): loaded http://localhost:55682/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55682/tests/dromaeo/cssquery-mootools.html) 09:16:55 INFO - PROCESS | 4419 | RSS: Main: 153903104 09:16:55 INFO - PROCESS | 4419 | 09:19:57 INFO - PROCESS | 4419 | Cycle 1(1): loaded http://localhost:55682/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55682/tests/dromaeo/cssquery-prototype.html) 09:19:58 INFO - PROCESS | 4419 | RSS: Main: 152662016 09:19:58 INFO - PROCESS | 4419 | 09:23:00 INFO - PROCESS | 4419 | Cycle 1(1): loaded http://localhost:55682/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55682/tests/dromaeo/cssquery-yui.html) 09:23:01 INFO - PROCESS | 4419 | RSS: Main: 155557888 09:23:01 INFO - PROCESS | 4419 | 09:26:03 INFO - PROCESS | 4419 | Cycle 1(1): loaded http://localhost:55682/tests/dromaeo/cssquery-yui.html (next: http://localhost:55682/tests/dromaeo/cssquery-dojo.html) 09:26:03 INFO - PROCESS | 4419 | RSS: Main: 155348992 09:26:03 INFO - PROCESS | 4419 | 09:26:03 INFO - PROCESS | 4419 | __start_tp_report 09:26:03 INFO - PROCESS | 4419 | _x_x_mozilla_page_load 09:26:03 INFO - PROCESS | 4419 | _x_x_mozilla_page_load_details 09:26:03 INFO - PROCESS | 4419 | |i|pagename|runs| 09:26:03 INFO - PROCESS | 4419 | |0;dojo.html;3321.4021476134294;3357.4124528207567;3368.5115658229556;3398.2184097657555;3404.3361544498816;5805.3323867755225;5859.121131830217;5860.853478663035;5883.705814709268;5889.823305300843;5793.739281732322;5845.269341332333;5850.385709500505;5865.76536938523;5866.970665146669;5207.3490813648295;5302.284191634138;5319.281896943921;5322.627416080876;5326.414094449627;5259.474052594748;5262;5311.654742441749;5325.121354976424;5370.677759334433;5270.393904700951;5281.287026251445;5288.206768984644;5355.946440535603;5439.374471935718;5344.839654810343;5358.169483730028;5364.409914909357;5375.75809088592;5394.541463975567;5139.023585518739;5190.195519694454;5190.558802501791;5283.128283833163;5340.759665815048;5737.139429085629;5821.970890145564;5833.88332233353;5842.561807864385;5866.618669786493;6217.129601855744;6274;6282.528810339243;6294.433500984934;6299.401556852092;6118.265808103056;6130.264368275791;6297.338779428185;6334.398232167937;6334.904976425358;5715.057015592422;5810.912836307459;5817.243758311392;5819.854503637401;5850.210221620069;6259;6317.873642527124;6321.557490975588;6322.272938612118;6324.683765811783;5938.584299099021;6000.819975400745;6065.5450841187085;6080.0879868019265;6083.482903953213;6198;6308.400701933309;6326.114343991845;6332.081848131995;6341.302456729756;6196.597221180609;6264.624122552661;6282.811515654537;6297.716602752887;6308.369163083747;6059.151718759377;6117.9492029047315;6240.095186197976;6272.968635156795;6288.937110628835;4700.929486057712;4740.45484769249;4757.3577567028005;4763.904721905543;4771.117343291502;4233.238017156941;4254.659627229814;4255.170241802819;4262.808173632194;4285.335772955197;5897.970510147507;5921.437463440966;5956.761729530857;5996.16053752475;6009.1587177795145;6195.2255968004;6300.30696623371;6326.588771729915;6349.619022858643;6356.936430635635;5973.313068997034;6055.122007308915;6068.969655151696;6073;6082.574219804571;5185.274061631375;5301.3373328333955;5411.675299482044;5412.242286079952;5426.864328391822;6344.904826427607;6547.34526547351;6547.377999090078;6548.70530826114;6561.573497722633;6326.4622507087415;6327.145835312266;6331.683415829282;6335.176427064452;6335.65153916539;6221.4089661482085;6359.8092057238355;6380.968095159495;6518.380753828379;6537.378948999837;6092.847678808065;6144.354842741448;6147.815565533041;6154.353792851686;6166.075088736726;6264.279607844974;6275.560710750204;6287.779927702509;6298.7480500781285;6299.6535190564955;6002;6082.391760823883;6112.716259964451;6182.258129024366;6193.163922870355;6133.172021777182;6160.845978850564;6174.9073763892675;6175.783847565313;6197.411245931629;6054.357733052438;6120.17377654011;6121.908171377522;6123.969380153071;6145.293291271382;5986.4013598639785;6100.938990610037;6141.8464538385115;6194.225721784777;6230.7507699691505;6076.817695469143;6086.513078953584;6091.908621370594;6102.176206212104;6109.450149486567 09:26:03 INFO - PROCESS | 4419 | |1;ext.html;578.8205656246564;637.2639601260544;639.5395315372933;643.7392855893363;681.6319187638676;40877;45297.54702452975;45699.31451028233;45767.313490297674;45806.7709661452;46275.76862115685;46339.30491042628;46813;46862;46945.53054469454;9061.41100828444;9166.037566055567;9200.171984521392;9204.769880753001;9212.170904618582;9108.316876234276;9179.219766319871;9201.355905086646;9218.17036466718;9221.031791661879;9308.394954327947;9316.8602470963;9317.72046838596;9321.067893210658;9323.440593564408;9127.26981841451;9237.861432078524;9245.16793488586;9261.72214833556;9283.953580232055;9088.818223635557;9118.498482583454;9129.908700912973;9145.725628231165;9162.083791620784;43313.35029974553;43484.13031739347;43694.12611747747;43768.12463750707;43782.781086094685;3804.5624753153465;3958.168784555247;4086.6730661547003;4166.979165104185;4174.833006679729;35007.702328530395;35153.82423087894;35435.468467973;35562;36712.63287367146;3939.665128464084;4136.110736191733;4136.379543068564;4143.958560414418;4200.285951388271;359347;361359;362157;365834;367569;64659.353406466274;64970.675146623966;64991.35008649853;65041;65095.67452162709;40259.79870100631;40420.19159616791;41114.794426028275;42864.57135428606;42867.35698964518;20097.6985345217;20288.289909853083;20291.28980485676;20292.797072029385;20327.288544900857;15500.5349839505;15596.688066238612;15631.374745010073;15691.293891774898;15706.9214653926;21206.681899771516;21509.784902151092;21526.56946861054;21727.891360543097;21735.67396489054;7484.438667099989;7741.806454838674;7875.881861772078;7904.604769761489;8047.235512626291;1049.627382279295;1111.6831702964616;1157.9536818527333;1189.1913498820884;1201.5794471934753;33697.938788257336;33970.660293397246;34315.82842085774;34430.48354274688;34788;1123.326004397355;1170.9648710538697;1209.4678341529698;1241.9254844709346;1267.4233223883111;17655.558611034827;17986.730199047026;18030.36893708714;18224.544386390182;18255.90872045631;595735;596494;598909;602296;603084;66345;66940.33059669439;67106;67130.66434667795;67218.66390668016;1441.9062760920506;1444.2850788859582;1483.7477628803128;1484.3097959448908;1503.9022463539834;33531.16172095717;33979.66020339765;34166;34179.65820341864;34184.48723269103;50839.49160508347;51185.48814511956;51274.743626283125;58293.12560311514;58615.70692146512;465737;467880;467900;470657;471049;31313.217169570944;31687.52468713017;31698.68301316957;32135.517967230044;32279.838600806845;53750.46249537611;53962.46037539731;54119;55063.72468137794;55349.72325138348;44818.77590612026;46867.296990544484;47517.287240690726;47609;48363;45516.54483455256;46395;46407.303890441;46672.533274668174;47460;41586.168276634904;43631.12737745291;44912.94953617975;45418.77290613526;45941.310880336154;38557.42163867488;39040.41439378355;39307.80346098251;42583;42695.146097078505;30177.245568860075;30372.544411833398;30718.84640576783;30825;31056.22359441032 09:26:03 INFO - PROCESS | 4419 | |2;jquery.html;411.8187997281198;416.6354439865118;417.6366561091851;420.16806722689074;448.60522739988807;19070.42788716339;19950.900245498753;20243.49391265219;20453.48866278344;20684.27605033824;19950.900245498753;20097.397078087644;20343.28798492053;20663.17347306106;20980.370588882357;5784.739686714087;5971.820845374624;5998.910016349736;6002.309734380537;6012.819615411545;5733.569982251348;5876.794312199074;5927.644341339534;5935.52515798735;5941.465268125868;5989.281286245657;6021.578489505737;6047.969760151215;6050.939490605082;6053;5922.378150294243;5982.162497250389;5995.85010374742;6032.819015429544;6041.184440100574;5726.713664316768;5980.372060933583;6046.244219472566;6059.212302400704;6099.634021958653;15001.624959375993;15294.388224471008;15320.616984575363;19526.414207573795;24636.753632463624;2452.914148004811;2488.7760101590943;2600.89596416145;3004.354063876277;3143.465610846162;11175.888241117565;11427.885721142848;11516.827247591209;12818.679533011657;14499.42002319906;1994.411648563677;2051.312810208582;2075.792420757927;2112.6302896992966;2132.6201400867953;75159.62420187918;76436;81788.59105704493;85725.57137214275;87477.56261218654;11536.365499897585;11920.46357913896;12026;12074.818877716842;12158.230948406022;16834.494965151065;16920.407785727686;16964.321427143022;16978.151092445576;17130.229139688745;8983.865242021375;9074.86387704185;9202.171804537624;9282;9319.16127548524;9039.412438191497;9044.095590440904;9070.81858362829;9274.350795444254;9278.67524636648;5115.104856650071;5133.6919784813035;5149.845504634867;5201.401838788588;5211.530962213419;2145.324222869791;2198.9120435182735;2206.5035367042287;2220.9000594973263;2229.955400891973;976.6776963601994;1078.2021304234809;1085.0560012788924;1105.4251789069638;1146.6388087752332;19725.60548789045;20460.897695511427;21233;21540.676889846665;22976.080956761878;1057.3127467146417;1058.8411738239172;1090.5801266512292;1090.8472813806075;1132.64887884756;11483.42582870853;11629.767404651859;11674.533018679158;11740.58907938218;11894.88105118955;479696;491891;498158;501772;503029;98770;99412;101351.49324253331;102494.48752756338;103055;1059.5708737961138;1098.9945050274698;1104.4974536585835;1118.5302173087323;1123.1520202247414;18386.81613183851;18768;19050.90474547674;19097.809021910158;19201.943893086016;44439.33340999952;44721;45310.546894530635;45827.77086114548;47012.7649361751;63534;63685.3631463698;64028.67985660042;64179.35820641734;64343.35656643561;9068.727938161866;9163.99196088443;9332.906670933204;9375.390599611004;9436.764080897758;13006;14425.711485770016;14478.493252736525;14622.488212912922;14705.92647036758;11757.176997610086;12316.815247771112;12336.62990110298;12689.492420303084;12754.872451275369;11974.161808673309;11989.76020479568;12109.0918181135;12404.503819847467;12694.936525317315;12301.692457688629;12468.625941221779;12566.937165314115;12840.743185136058;12877;9076;9319.6272149116;9374.876203303875;9423.623055077995;9672.468014259282;12098.213616114925;12236.69408264765;12300.569480068154;12483.687907802014;12619.49522019109 09:26:03 INFO - PROCESS | 4419 | |3;mootools.html;1541.6993686231185;1551.49576387674;1712.6403455274392;1771.840534351908;1810.2035104553995;8443.155684431555;9066.229370503506;9153.954230228856;9768.804623907517;9788.951055244723;9101.499417532033;9375.76560585984;9440.905590944089;9467.857982130274;9522.619095236183;2438.4147804526874;2474.64117702933;2483.552960467115;2489.8630575318352;2498.962515562268;2413.794827439661;2492.8753562321813;2501.8999240030375;2512.170983575416;2519.8992040318367;2420.3102115896972;2423.127674037345;2501.8991643676814;2523.268252206867;2525.8231923765343;2421.104191449166;2424.539337525873;2432.85402875828;2442.926712198637;2449.436629575199;2443.5235129149823;2460.1389513670074;2460.5324988252173;2465.3713303107593;2466.8149888758417;9352.812943741155;9366.063393660648;9500.192483638899;9500.477473738942;9512.571934262975;5638.35158956717;5774.307083150007;5777.45114214149;5783.913241301384;5787.536997040227;3360.512725654766;3380.864765409405;3456.3778519866414;3469.9132521686906;3513.8243087845503;1187.4181650990952;1225.1424003197797;1226.0865655087018;1236.4744983382027;1247.2516490105954;13289.800652990212;13443.126196797177;13448.193108413428;13469.461221551126;13483.191008539421;4777.713337199779;4818.855434336975;4948.183549714328;4977.104121258136;5106.336176297058;11232.55069797199;11269.380184089954;11292.040176585082;11312.490937907649;11370;5819.127130930395;5844.590878638454;5846.239988801513;5852.034414321674;5862.648241105548;4631.0506346198945;5147.794088236428;5238.5023422774775;5255.290535777697;5365.195220716923;4201.789910504463;4250.808713607895;4315.546867578922;4323.654107671378;4323.740575565476;1322.6759443936296;1331.0549509847922;1344.596621013692;1349.2174538767492;1360.9659758505918;1027.291169093323;1036.486938965217;1050.56926660069;1051.358671210561;1068.930519516229;5888.793892213837;6011;6370.203724534434;6399.968000159969;6633.4693224541925;498.56873804159864;504.0775381052738;506.42014892948106;520.8385400525773;525.2384043137466;4236.406903033578;4339.500957389878;4345.630621397154;4374.431323927869;4381.5618438155925;11503.76992460163;11510.654680359603;11604;11651.708707282385;11914.344711040976;11606.941965290289;11669.533218671328;11675.416229188506;11696.941515292368;11735.119866010084;8474.957625211835;8673.132686731276;8844.115588441233;8845.027047024822;9036.909630903738;6390.968045159931;6397.072424498515;6537.934620653733;6600.174978127734;6655.900161497679;10512.316699414514;10735.892641073802;10778.89221107779;10806.35161890289;10861.945690271497;10601.41692206936;10893.910608939359;10916.672499825017;10978;11004.284721493077;7832.960835195788;8185.4270201085355;8376.832463350576;8462.576871156294;8669.739907802776;9347.859782103409;9422.952885235803;9427.95286023593;9456.2907781918;9470.19503342196;8167.754967350989;8332.958335208285;8553.230209281195;8572.699955501528;8643.956780216058;8206;8261.628226729932;8280.544570048463;8343.332533397435;8356.122607126164;7561.3194812467145;7813.335866451415;7894.447388682737;7915.683372665029;7917.208279172037;5471.151971444432;5642.125470552071;5660.88678226425;5706.115552089433;5726.455986681259;5662.745176467151;5717.742701578522;5750.30996280449;5758.452946970031;5802.274715660543 09:26:03 INFO - PROCESS | 4419 | |4;prototype.html;340.6236109099445;344.8913592218453;345.3869381847221;345.52490325802023;350.7334425836364;5750.923256058009;5843.79546715865;5859.209006784088;5873.794417195394;5881.206037184978;5757;5773.451522105393;5774.6535207887455;5780.364159942414;5791.131330300457;4348.608625223737;4439.75581343026;4476.820927162909;4509.72941623502;4527.773611319437;4495.325701144838;4497;4497.572730590588;4513.187626227278;4523.6607254455885;4483.417155769762;4516.751578663172;4529.230030894756;4532.501424843264;4532.614727748129;4438.356438316442;4495.550444955511;4505.098980203956;4521.886952826173;4524.547545245482;4014.8394064237395;4040.7979601020124;4055.776932268724;4058.269511487931;4062.979685101556;5694.259746233005;5700.515456186229;5712.857178570527;5733.88532229353;5747.2241247431475;4874.610031197496;5053.444121146671;5115.590752739772;5126.71803050832;5149.227615857614;6018.488428483584;6050.54620903434;6053.636781793107;6107.969460152671;6109.236345456818;4144.378343248507;4260.7656578888145;4266.935995960063;4289.206496798102;4313.374560688714;6252.3747625237565;6261.749530018794;6328.208973878265;6354.682265886687;6382.936170638327;4444.28891377378;4457.729547079067;4479.17135329965;4484.977575112103;4487.227545119659;4388.429504164502;4471.23988921884;4552.681312308173;4553.749543775058;4564.977175114103;5113.565346945476;5128.230765385148;5132.8460146195675;5141.203113517411;5197.324347834758;6115.510759139258;6134.693265336716;6138.631682099089;6140.990914451976;6159.6612186329285;1490.970180596382;1546.427821705976;1564.6166689161;1567.6942996115877;1583.762435634641;984.8276551603441;988.8134238913333;1016.9338992965434;1040.2510192661273;1070.063694267516;5840.8539786504825;5845.181674565564;5865.824025279248;5873.032534101038;5897.7935772247765;6116.204893363834;6222.968885155636;6274.905876411857;6279.748810047547;6281.937180628135;5709.375217317895;5827.883442331215;5881.323647780475;5892.292924849045;5898.528117750569;3303.9174020649675;3309.2885029718245;3309.907730448946;3312;3323.7507186960593;6133.570650054453;6402.295747467775;6428.325025872309;6430.324815894357;6555;6395.42441180296;6401.711922963478;6407.679616019181;6412.262589802139;6437.0988061671405;6323.399277068671;6489.18885139367;6536.411722944958;6538.869222615616;6613.272540020594;6289.213848268966;6294.496440284858;6301.464375528131;6308.589941653961;6369.745210191726;6147.815565533041;6256.718447669775;6258.748250349857;6294.968525157345;6304.5271604628915;6367.554271201157;6431.292557818542;6520.902186467112;6525.347465253437;6537.640429776217;4481.865544033684;4509.188346097734;4513.119941611486;4526.977365113154;4527.479339875957;6177.382261773787;6349.9682501587195;6350.650714210763;6415.775447859302;6446.226452825691;6166.828302622487;6212.254529456494;6216.689165541795;6216.906746398898;6240.188775459162;5988.311344195299;6151;6193.81418557426;6202.503799696104;6206.782762603287;5939.316978547522;6097.298810636834;6107.603005804608;6116.847078823065;6122.469382654336;6183.783567575113;6187.659678717534;6195.411435913581;6195.504359651307;6234.501239900887;5980.979605299296;6045.428188671065;6047.576669633084;6076.513878889767;6092.543059270483 09:26:03 INFO - PROCESS | 4419 | |5;yui.html;804.8068463568743;807.6971135824068;823.2220551578757;849.6941101203565;877.8068824858536;16313.102779347131;17458.912705436487;17528.91235543824;17566.209520571574;17593.91203043986;15988.12065336406;16247.756283655755;16311.265993030313;16321.10233937133;16349.754753678704;858.6994551906829;867.7266661001796;889.7330800759779;893.7274131389923;896.8116695493954;889.7063968890251;890.1632465482459;890.1854802855412;890.2210565754964;891.9687810926619;914.5747227539193;915.8122584870085;920.6593560382668;921.3964853021282;922.6401703335671;895.1719659315172;905.8958219804708;906.8322360363354;908.7182973278304;908.8182363527255;670.1154476091561;673.3434900971563;673.804596666966;678.1726293921408;678.304737643914;16382.426615068416;16405.58986025359;16425.67148657032;16486.422975195932;16550.089745064015;13854.93072534641;13948.2328471934;14186.787198192036;15673.294701738336;16064.59838504035;13200.6699832504;13428.932855335759;13491.595252142451;13695.315234238347;13912.165270083726;4755.856407804215;4810.663253572251;4854.12625727369;4862.44081930579;4872.9756351218375;86430.99999999937;88893.11106888913;90191.54904225502;95142.52428737881;95274;12297.323647199311;12368.44342004612;12437.315947622968;12513.186642868184;12645.747085058247;23109.191178309015;23115.422114447272;23159.53680926372;23195.188168414024;23868.64197037046;8907.153820387053;8952.776180595538;9314.34799564024;9483.857742133736;9548.522573871278;5110.48895110486;5164.483551644806;5189.610779191576;5212.895742085213;5338.065838478328;3851.8651847185215;4023.9195216095513;4028.939565906514;4035.959640403617;4040.3535434330365;688.0607970120749;692.425287011779;699.0562740300553;708.348319546019;719.2950908110081;630.6752022708309;718.500642053778;733.6515155301189;748.9514679448706;837.8617528107794;9176.44941303524;9827.656032038843;10115.836678781887;10486.528106235237;10661.466926653637;753.9434542409341;764.8852672099118;776.1384862802284;788.5820515126992;800.9439339246197;4953.925691114636;5158.948410515847;5181.4300426953005;5263.157894736823;5279.630425870152;77459.61270193725;78816.60591697005;90941;130062;133485;64447.35552644507;65454.34545654578;66216.33783662102;66351.33648663548;94934;69574.95637565441;79523;92750;96323;98268;9797.06927841854;9925.211434961711;9940.552675129491;9967.750806229613;10104.494775261355;58808.41191588029;59394;59536.70231648814;60198.699006504685;61117;85067.5746621263;85080.57459712662;86566.56716716629;87695.56152219199;89825.55087224522;12947.482100715866;12949.741005180033;12958.546450874173;13385.263810490516;13465.057445978688;13270.071095023255;13296.734065318833;13536.458541658223;13593.388297526437;13700.040997130503;13720.86279137196;13752.106113102616;13760.089451063866;13959.302034898417;13962.511312104027;12759.80860287115;12939.805902911276;12976.091673582758;13066.477340906638;13084.476620935056;12333.198342107735;12827.935860321011;12901.612951611467;12973;13126.803097953347;11059.612913547988;11336.716582085513;11466;11608.767824643292;11711.531538738696;11946.462409191781;12243.387830608612;12469.625911222678;12879.935600322313;13362.331883405985 09:26:03 INFO - PROCESS | 4419 | __end_tp_report 09:26:03 INFO - PROCESS | 4419 | __start_cc_report 09:26:03 INFO - PROCESS | 4419 | _x_x_mozilla_cycle_collect,321 09:26:03 INFO - PROCESS | 4419 | __end_cc_report 09:26:03 INFO - PROCESS | 4419 | __startTimestamp1470500763951__endTimestamp 09:26:03 INFO - PROCESS | 4419 | 09:26:03 INFO - PROCESS | 4419 | ------- Summary: start ------- 09:26:03 INFO - PROCESS | 4419 | Number of tests: 6 09:26:03 INFO - PROCESS | 4419 | 09:26:03 INFO - PROCESS | 4419 | [#0] dojo.html Cycles:165 Average:5812.27 Median:6080.09 stddev:668.71 (11.0%) stddev-sans-first:641.58 09:26:03 INFO - PROCESS | 4419 | Values: 3321.4 3357.4 3368.5 3398.2 3404.3 5805.3 5859.1 5860.9 5883.7 5889.8 5793.7 5845.3 5850.4 5865.8 5867.0 5207.3 5302.3 5319.3 5322.6 5326.4 5259.5 5262.0 5311.7 5325.1 5370.7 5270.4 5281.3 5288.2 5355.9 5439.4 5344.8 5358.2 5364.4 5375.8 5394.5 5139.0 5190.2 5190.6 5283.1 5340.8 5737.1 5822.0 5833.9 5842.6 5866.6 6217.1 6274.0 6282.5 6294.4 6299.4 6118.3 6130.3 6297.3 6334.4 6334.9 5715.1 5810.9 5817.2 5819.9 5850.2 6259.0 6317.9 6321.6 6322.3 6324.7 5938.6 6000.8 6065.5 6080.1 6083.5 6198.0 6308.4 6326.1 6332.1 6341.3 6196.6 6264.6 6282.8 6297.7 6308.4 6059.2 6117.9 6240.1 6273.0 6288.9 4700.9 4740.5 4757.4 4763.9 4771.1 4233.2 4254.7 4255.2 4262.8 4285.3 5898.0 5921.4 5956.8 5996.2 6009.2 6195.2 6300.3 6326.6 6349.6 6356.9 5973.3 6055.1 6069.0 6073.0 6082.6 5185.3 5301.3 5411.7 5412.2 5426.9 6344.9 6547.3 6547.4 6548.7 6561.6 6326.5 6327.1 6331.7 6335.2 6335.7 6221.4 6359.8 6381.0 6518.4 6537.4 6092.8 6144.4 6147.8 6154.4 6166.1 6264.3 6275.6 6287.8 6298.7 6299.7 6002.0 6082.4 6112.7 6182.3 6193.2 6133.2 6160.8 6174.9 6175.8 6197.4 6054.4 6120.2 6121.9 6124.0 6145.3 5986.4 6100.9 6141.8 6194.2 6230.8 6076.8 6086.5 6091.9 6102.2 6109.5 09:26:03 INFO - PROCESS | 4419 | 09:26:03 INFO - PROCESS | 4419 | [#1] ext.html Cycles:180 Average:64846.68 Median:43731.13 stddev:129165.58 (295.4%) stddev-sans-first:129437.79 09:26:03 INFO - PROCESS | 4419 | Values: 578.8 637.3 639.5 643.7 681.6 40877.0 45297.5 45699.3 45767.3 45806.8 46275.8 46339.3 46813.0 46862.0 46945.5 9061.4 9166.0 9200.2 9204.8 9212.2 9108.3 9179.2 9201.4 9218.2 9221.0 9308.4 9316.9 9317.7 9321.1 9323.4 9127.3 9237.9 9245.2 9261.7 9284.0 9088.8 9118.5 9129.9 9145.7 9162.1 43313.4 43484.1 43694.1 43768.1 43782.8 3804.6 3958.2 4086.7 4167.0 4174.8 35007.7 35153.8 35435.5 35562.0 36712.6 3939.7 4136.1 4136.4 4144.0 4200.3 359347.0 361359.0 362157.0 365834.0 367569.0 64659.4 64970.7 64991.4 65041.0 65095.7 40259.8 40420.2 41114.8 42864.6 42867.4 20097.7 20288.3 20291.3 20292.8 20327.3 15500.5 15596.7 15631.4 15691.3 15706.9 21206.7 21509.8 21526.6 21727.9 21735.7 7484.4 7741.8 7875.9 7904.6 8047.2 1049.6 1111.7 1158.0 1189.2 1201.6 33697.9 33970.7 34315.8 34430.5 34788.0 1123.3 1171.0 1209.5 1241.9 1267.4 17655.6 17986.7 18030.4 18224.5 18255.9 595735.0 596494.0 598909.0 602296.0 603084.0 66345.0 66940.3 67106.0 67130.7 67218.7 1441.9 1444.3 1483.7 1484.3 1503.9 33531.2 33979.7 34166.0 34179.7 34184.5 50839.5 51185.5 51274.7 58293.1 58615.7 465737.0 467880.0 467900.0 470657.0 471049.0 31313.2 31687.5 31698.7 32135.5 32279.8 53750.5 53962.5 54119.0 55063.7 55349.7 44818.8 46867.3 47517.3 47609.0 48363.0 45516.5 46395.0 46407.3 46672.5 47460.0 41586.2 43631.1 44912.9 45418.8 45941.3 38557.4 39040.4 39307.8 42583.0 42695.1 30177.2 30372.5 30718.8 30825.0 31056.2 09:26:03 INFO - PROCESS | 4419 | 09:26:03 INFO - PROCESS | 4419 | [#2] jquery.html Cycles:180 Average:30126.58 Median:11869.79 stddev:81775.66 (688.9%) stddev-sans-first:81974.63 09:26:03 INFO - PROCESS | 4419 | Values: 411.8 416.6 417.6 420.2 448.6 19070.4 19950.9 20243.5 20453.5 20684.3 19950.9 20097.4 20343.3 20663.2 20980.4 5784.7 5971.8 5998.9 6002.3 6012.8 5733.6 5876.8 5927.6 5935.5 5941.5 5989.3 6021.6 6048.0 6050.9 6053.0 5922.4 5982.2 5995.9 6032.8 6041.2 5726.7 5980.4 6046.2 6059.2 6099.6 15001.6 15294.4 15320.6 19526.4 24636.8 2452.9 2488.8 2600.9 3004.4 3143.5 11175.9 11427.9 11516.8 12818.7 14499.4 1994.4 2051.3 2075.8 2112.6 2132.6 75159.6 76436.0 81788.6 85725.6 87477.6 11536.4 11920.5 12026.0 12074.8 12158.2 16834.5 16920.4 16964.3 16978.2 17130.2 8983.9 9074.9 9202.2 9282.0 9319.2 9039.4 9044.1 9070.8 9274.4 9278.7 5115.1 5133.7 5149.8 5201.4 5211.5 2145.3 2198.9 2206.5 2220.9 2230.0 976.7 1078.2 1085.1 1105.4 1146.6 19725.6 20460.9 21233.0 21540.7 22976.1 1057.3 1058.8 1090.6 1090.8 1132.6 11483.4 11629.8 11674.5 11740.6 11894.9 479696.0 491891.0 498158.0 501772.0 503029.0 98770.0 99412.0 101351.5 102494.5 103055.0 1059.6 1099.0 1104.5 1118.5 1123.2 18386.8 18768.0 19050.9 19097.8 19201.9 44439.3 44721.0 45310.5 45827.8 47012.8 63534.0 63685.4 64028.7 64179.4 64343.4 9068.7 9164.0 9332.9 9375.4 9436.8 13006.0 14425.7 14478.5 14622.5 14705.9 11757.2 12316.8 12336.6 12689.5 12754.9 11974.2 11989.8 12109.1 12404.5 12694.9 12301.7 12468.6 12566.9 12840.7 12877.0 9076.0 9319.6 9374.9 9423.6 9672.5 12098.2 12236.7 12300.6 12483.7 12619.5 09:26:03 INFO - PROCESS | 4419 | 09:26:03 INFO - PROCESS | 4419 | [#3] mootools.html Cycles:180 Average:6244.36 Median:4704.38 stddev:3585.59 (76.2%) stddev-sans-first:3578.23 09:26:03 INFO - PROCESS | 4419 | Values: 1541.7 1551.5 1712.6 1771.8 1810.2 8443.2 9066.2 9154.0 9768.8 9789.0 9101.5 9375.8 9440.9 9467.9 9522.6 2438.4 2474.6 2483.6 2489.9 2499.0 2413.8 2492.9 2501.9 2512.2 2519.9 2420.3 2423.1 2501.9 2523.3 2525.8 2421.1 2424.5 2432.9 2442.9 2449.4 2443.5 2460.1 2460.5 2465.4 2466.8 9352.8 9366.1 9500.2 9500.5 9512.6 5638.4 5774.3 5777.5 5783.9 5787.5 3360.5 3380.9 3456.4 3469.9 3513.8 1187.4 1225.1 1226.1 1236.5 1247.3 13289.8 13443.1 13448.2 13469.5 13483.2 4777.7 4818.9 4948.2 4977.1 5106.3 11232.6 11269.4 11292.0 11312.5 11370.0 5819.1 5844.6 5846.2 5852.0 5862.6 4631.1 5147.8 5238.5 5255.3 5365.2 4201.8 4250.8 4315.5 4323.7 4323.7 1322.7 1331.1 1344.6 1349.2 1361.0 1027.3 1036.5 1050.6 1051.4 1068.9 5888.8 6011.0 6370.2 6400.0 6633.5 498.6 504.1 506.4 520.8 525.2 4236.4 4339.5 4345.6 4374.4 4381.6 11503.8 11510.7 11604.0 11651.7 11914.3 11606.9 11669.5 11675.4 11696.9 11735.1 8475.0 8673.1 8844.1 8845.0 9036.9 6391.0 6397.1 6537.9 6600.2 6655.9 10512.3 10735.9 10778.9 10806.4 10861.9 10601.4 10893.9 10916.7 10978.0 11004.3 7833.0 8185.4 8376.8 8462.6 8669.7 9347.9 9423.0 9428.0 9456.3 9470.2 8167.8 8333.0 8553.2 8572.7 8644.0 8206.0 8261.6 8280.5 8343.3 8356.1 7561.3 7813.3 7894.4 7915.7 7917.2 5471.2 5642.1 5660.9 5706.1 5726.5 5662.7 5717.7 5750.3 5758.5 5802.3 09:26:03 INFO - PROCESS | 4419 | 09:26:03 INFO - PROCESS | 4419 | [#4] prototype.html Cycles:180 Average:5149.43 Median:5869.43 stddev:1529.42 (26.1%) stddev-sans-first:1490.51 09:26:03 INFO - PROCESS | 4419 | Values: 340.6 344.9 345.4 345.5 350.7 5750.9 5843.8 5859.2 5873.8 5881.2 5757.0 5773.5 5774.7 5780.4 5791.1 4348.6 4439.8 4476.8 4509.7 4527.8 4495.3 4497.0 4497.6 4513.2 4523.7 4483.4 4516.8 4529.2 4532.5 4532.6 4438.4 4495.6 4505.1 4521.9 4524.5 4014.8 4040.8 4055.8 4058.3 4063.0 5694.3 5700.5 5712.9 5733.9 5747.2 4874.6 5053.4 5115.6 5126.7 5149.2 6018.5 6050.5 6053.6 6108.0 6109.2 4144.4 4260.8 4266.9 4289.2 4313.4 6252.4 6261.7 6328.2 6354.7 6382.9 4444.3 4457.7 4479.2 4485.0 4487.2 4388.4 4471.2 4552.7 4553.7 4565.0 5113.6 5128.2 5132.8 5141.2 5197.3 6115.5 6134.7 6138.6 6141.0 6159.7 1491.0 1546.4 1564.6 1567.7 1583.8 984.8 988.8 1016.9 1040.3 1070.1 5840.9 5845.2 5865.8 5873.0 5897.8 6116.2 6223.0 6274.9 6279.7 6281.9 5709.4 5827.9 5881.3 5892.3 5898.5 3303.9 3309.3 3309.9 3312.0 3323.8 6133.6 6402.3 6428.3 6430.3 6555.0 6395.4 6401.7 6407.7 6412.3 6437.1 6323.4 6489.2 6536.4 6538.9 6613.3 6289.2 6294.5 6301.5 6308.6 6369.7 6147.8 6256.7 6258.7 6295.0 6304.5 6367.6 6431.3 6520.9 6525.3 6537.6 4481.9 4509.2 4513.1 4527.0 4527.5 6177.4 6350.0 6350.7 6415.8 6446.2 6166.8 6212.3 6216.7 6216.9 6240.2 5988.3 6151.0 6193.8 6202.5 6206.8 5939.3 6097.3 6107.6 6116.8 6122.5 6183.8 6187.7 6195.4 6195.5 6234.5 5981.0 6045.4 6047.6 6076.5 6092.5 09:26:03 INFO - PROCESS | 4419 | 09:26:03 INFO - PROCESS | 4419 | [#5] yui.html Cycles:180 Average:21077.96 Median:5185.52 stddev:29414.17 (567.2%) stddev-sans-first:29457.30 09:26:03 INFO - PROCESS | 4419 | Values: 804.8 807.7 823.2 849.7 877.8 16313.1 17458.9 17528.9 17566.2 17593.9 15988.1 16247.8 16311.3 16321.1 16349.8 858.7 867.7 889.7 893.7 896.8 889.7 890.2 890.2 890.2 892.0 914.6 915.8 920.7 921.4 922.6 895.2 905.9 906.8 908.7 908.8 670.1 673.3 673.8 678.2 678.3 16382.4 16405.6 16425.7 16486.4 16550.1 13854.9 13948.2 14186.8 15673.3 16064.6 13200.7 13428.9 13491.6 13695.3 13912.2 4755.9 4810.7 4854.1 4862.4 4873.0 86431.0 88893.1 90191.5 95142.5 95274.0 12297.3 12368.4 12437.3 12513.2 12645.7 23109.2 23115.4 23159.5 23195.2 23868.6 8907.2 8952.8 9314.3 9483.9 9548.5 5110.5 5164.5 5189.6 5212.9 5338.1 3851.9 4023.9 4028.9 4036.0 4040.4 688.1 692.4 699.1 708.3 719.3 630.7 718.5 733.7 749.0 837.9 9176.4 9827.7 10115.8 10486.5 10661.5 753.9 764.9 776.1 788.6 800.9 4953.9 5158.9 5181.4 5263.2 5279.6 77459.6 78816.6 90941.0 130062.0 133485.0 64447.4 65454.3 66216.3 66351.3 94934.0 69575.0 79523.0 92750.0 96323.0 98268.0 9797.1 9925.2 9940.6 9967.8 10104.5 58808.4 59394.0 59536.7 60198.7 61117.0 85067.6 85080.6 86566.6 87695.6 89825.6 12947.5 12949.7 12958.5 13385.3 13465.1 13270.1 13296.7 13536.5 13593.4 13700.0 13720.9 13752.1 13760.1 13959.3 13962.5 12759.8 12939.8 12976.1 13066.5 13084.5 12333.2 12827.9 12901.6 12973.0 13126.8 11059.6 11336.7 11466.0 11608.8 11711.5 11946.5 12243.4 12469.6 12879.9 13362.3 09:26:03 INFO - PROCESS | 4419 | -------- Summary: end -------- 09:26:03 INFO - PROCESS | 4419 | 09:26:04 INFO - TEST-INFO | 4419: exit 0 09:26:04 INFO - TEST-OK | dromaeo_css | took 1110458ms 09:26:04 INFO - TEST-START | kraken 09:26:04 INFO - operating with platform_type : linux_ 09:26:04 INFO - Initialising browser for kraken test... 09:26:04 INFO - TEST-INFO | started process 4689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8PU5vd/profile http://localhost:55682/getInfo.html) 09:26:08 INFO - PROCESS | 4689 | __metrics Screen width/height:1600/1200 09:26:08 INFO - PROCESS | 4689 | colorDepth:24 09:26:08 INFO - PROCESS | 4689 | Browser inner width/height: 1024/697 09:26:08 INFO - PROCESS | 4689 | __metrics 09:26:09 ERROR - PROCESS | 4689 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:26:10 INFO - TEST-INFO | 4689: exit 0 09:26:10 INFO - Browser initialized. 09:26:10 INFO - Running cycle 1/1 for kraken test... 09:26:10 INFO - TEST-INFO | started process 4817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8PU5vd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:26:22 INFO - PROCESS | 4817 | RSS: Main: 152436736 09:26:22 INFO - PROCESS | 4817 | 09:26:24 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55682/tests/kraken/driver.html?testName=audio-beat-detection) 09:26:25 INFO - PROCESS | 4817 | RSS: Main: 157843456 09:26:25 INFO - PROCESS | 4817 | 09:26:28 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55682/tests/kraken/driver.html?testName=audio-dft) 09:26:28 INFO - PROCESS | 4817 | RSS: Main: 156336128 09:26:28 INFO - PROCESS | 4817 | 09:26:31 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55682/tests/kraken/driver.html?testName=audio-fft) 09:26:32 INFO - PROCESS | 4817 | RSS: Main: 157368320 09:26:32 INFO - PROCESS | 4817 | 09:26:34 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55682/tests/kraken/driver.html?testName=audio-oscillator) 09:26:35 INFO - PROCESS | 4817 | RSS: Main: 156844032 09:26:35 INFO - PROCESS | 4817 | 09:26:37 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55682/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:26:37 INFO - PROCESS | 4817 | RSS: Main: 157343744 09:26:37 INFO - PROCESS | 4817 | 09:26:40 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55682/tests/kraken/driver.html?testName=imaging-darkroom) 09:26:41 INFO - PROCESS | 4817 | RSS: Main: 156172288 09:26:41 INFO - PROCESS | 4817 | 09:26:44 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55682/tests/kraken/driver.html?testName=imaging-desaturate) 09:26:45 INFO - PROCESS | 4817 | RSS: Main: 156520448 09:26:45 INFO - PROCESS | 4817 | 09:26:48 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55682/tests/kraken/driver.html?testName=json-parse-financial) 09:26:49 INFO - PROCESS | 4817 | RSS: Main: 157822976 09:26:49 INFO - PROCESS | 4817 | 09:26:50 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55682/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:26:51 INFO - PROCESS | 4817 | RSS: Main: 157151232 09:26:51 INFO - PROCESS | 4817 | 09:26:52 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55682/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:26:53 INFO - PROCESS | 4817 | RSS: Main: 156749824 09:26:53 INFO - PROCESS | 4817 | 09:26:55 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55682/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:26:56 INFO - PROCESS | 4817 | RSS: Main: 156856320 09:26:56 INFO - PROCESS | 4817 | 09:26:58 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:26:59 INFO - PROCESS | 4817 | RSS: Main: 157392896 09:26:59 INFO - PROCESS | 4817 | 09:27:02 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:27:02 INFO - PROCESS | 4817 | RSS: Main: 157741056 09:27:02 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55682/tests/kraken/driver.html?testName=ai-astar) 09:27:04 INFO - PROCESS | 4817 | RSS: Main: 158806016 09:27:04 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | __start_tp_report 09:27:04 INFO - PROCESS | 4817 | _x_x_mozilla_page_load 09:27:04 INFO - PROCESS | 4817 | _x_x_mozilla_page_load_details 09:27:04 INFO - PROCESS | 4817 | |i|pagename|runs| 09:27:04 INFO - PROCESS | 4817 | |0;ai-astar;102;113;105;110;112;111;112;112;112;109 09:27:04 INFO - PROCESS | 4817 | |1;audio-beat-detection;140;117;142;163;128;148;150;120;171;125 09:27:04 INFO - PROCESS | 4817 | |2;audio-dft;163;161;164;161;162;164;165;161;162;162 09:27:04 INFO - PROCESS | 4817 | |3;audio-fft;76;74;77;168;75;75;77;77;166;75 09:27:04 INFO - PROCESS | 4817 | |4;audio-oscillator;83;84;143;84;83;84;140;83;83;148 09:27:04 INFO - PROCESS | 4817 | |5;imaging-gaussian-blur;117;117;119;117;116;117;117;118;117;117 09:27:04 INFO - PROCESS | 4817 | |6;imaging-darkroom;148;150;151;150;151;147;148;149;147;147 09:27:04 INFO - PROCESS | 4817 | |7;imaging-desaturate;95;95;96;94;95;95;95;96;95;95 09:27:04 INFO - PROCESS | 4817 | |8;json-parse-financial;51;50;50;54;51;51;54;50;50;54 09:27:04 INFO - PROCESS | 4817 | |9;json-stringify-tinderbox;63;62;61;61;61;61;61;61;62;62 09:27:04 INFO - PROCESS | 4817 | |10;stanford-crypto-aes;72;76;78;72;78;72;76;74;72;71 09:27:04 INFO - PROCESS | 4817 | |11;stanford-crypto-ccm;120;122;121;119;116;117;117;138;158;119 09:27:04 INFO - PROCESS | 4817 | |12;stanford-crypto-pbkdf2;158;158;153;152;154;159;150;152;155;152 09:27:04 INFO - PROCESS | 4817 | |13;stanford-crypto-sha256-iterative;62;65;63;63;61;67;61;61;61;62 09:27:04 INFO - PROCESS | 4817 | __end_tp_report 09:27:04 INFO - PROCESS | 4817 | __start_cc_report 09:27:04 INFO - PROCESS | 4817 | _x_x_mozilla_cycle_collect,908 09:27:04 INFO - PROCESS | 4817 | __end_cc_report 09:27:04 INFO - PROCESS | 4817 | __startTimestamp1470500824613__endTimestamp 09:27:04 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | ------- Summary: start ------- 09:27:04 INFO - PROCESS | 4817 | Number of tests: 14 09:27:04 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | [#0] ai-astar Cycles:10 Average:109.80 Median:112.00 stddev:3.58 (3.2%) stddev-sans-first:2.45 09:27:04 INFO - PROCESS | 4817 | Values: 102.0 113.0 105.0 110.0 112.0 111.0 112.0 112.0 112.0 109.0 09:27:04 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:145.00 stddev:18.12 (12.5%) stddev-sans-first:19.22 09:27:04 INFO - PROCESS | 4817 | Values: 140.0 117.0 142.0 163.0 128.0 148.0 150.0 120.0 171.0 125.0 09:27:04 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.43 (0.9%) stddev-sans-first:1.51 09:27:04 INFO - PROCESS | 4817 | Values: 163.0 161.0 164.0 161.0 162.0 164.0 165.0 161.0 162.0 162.0 09:27:04 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.50 stddev:38.49 (51.0%) stddev-sans-first:40.27 09:27:04 INFO - PROCESS | 4817 | Values: 76.0 74.0 77.0 168.0 75.0 75.0 77.0 77.0 166.0 75.0 09:27:04 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:83.00 stddev:29.16 (35.1%) stddev-sans-first:30.15 09:27:04 INFO - PROCESS | 4817 | Values: 83.0 84.0 143.0 84.0 83.0 84.0 140.0 83.0 83.0 148.0 09:27:04 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 09:27:04 INFO - PROCESS | 4817 | Values: 117.0 117.0 119.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 09:27:04 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.50 stddev:1.62 (1.1%) stddev-sans-first:1.69 09:27:04 INFO - PROCESS | 4817 | Values: 148.0 150.0 151.0 150.0 151.0 147.0 148.0 149.0 147.0 147.0 09:27:04 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:27:04 INFO - PROCESS | 4817 | Values: 95.0 95.0 96.0 94.0 95.0 95.0 95.0 96.0 95.0 95.0 09:27:04 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.00 stddev:1.78 (3.5%) stddev-sans-first:1.88 09:27:04 INFO - PROCESS | 4817 | Values: 51.0 50.0 50.0 54.0 51.0 51.0 54.0 50.0 50.0 54.0 09:27:04 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.50 09:27:04 INFO - PROCESS | 4817 | Values: 63.0 62.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 62.0 09:27:04 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:75.00 stddev:2.69 (3.6%) stddev-sans-first:2.74 09:27:04 INFO - PROCESS | 4817 | Values: 72.0 76.0 78.0 72.0 78.0 72.0 76.0 74.0 72.0 71.0 09:27:04 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:120.50 stddev:13.28 (11.0%) stddev-sans-first:13.98 09:27:04 INFO - PROCESS | 4817 | Values: 120.0 122.0 121.0 119.0 116.0 117.0 117.0 138.0 158.0 119.0 09:27:04 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.30 Median:154.50 stddev:3.09 (2.0%) stddev-sans-first:2.98 09:27:04 INFO - PROCESS | 4817 | Values: 158.0 158.0 153.0 152.0 154.0 159.0 150.0 152.0 155.0 152.0 09:27:04 INFO - PROCESS | 4817 | 09:27:04 INFO - PROCESS | 4817 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.50 stddev:2.01 (3.2%) stddev-sans-first:2.12 09:27:04 INFO - PROCESS | 4817 | Values: 62.0 65.0 63.0 63.0 61.0 67.0 61.0 61.0 61.0 62.0 09:27:04 INFO - PROCESS | 4817 | -------- Summary: end -------- 09:27:04 INFO - PROCESS | 4817 | 09:27:05 INFO - TEST-INFO | 4817: exit 0 09:27:05 INFO - TEST-OK | kraken | took 60931ms 09:27:05 INFO - SUITE-END | took 1171s 09:27:05 INFO - Completed test suite (00:19:31) 09:27:05 INFO - javascript benchmark 09:27:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7797.944760730008, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3321.4021476134294, 3357.4124528207567, 3368.5115658229556, 3398.2184097657555, 3404.3361544498816, 5805.3323867755225, 5859.121131830217, 5860.853478663035, 5883.705814709268, 5889.823305300843, 5793.739281732322, 5845.269341332333, 5850.385709500505, 5865.76536938523, 5866.970665146669, 5207.3490813648295, 5302.284191634138, 5319.281896943921, 5322.627416080876, 5326.414094449627, 5259.474052594748, 5262.0, 5311.654742441749, 5325.121354976424, 5370.677759334433, 5270.393904700951, 5281.287026251445, 5288.206768984644, 5355.946440535603, 5439.374471935718, 5344.839654810343, 5358.169483730028, 5364.409914909357, 5375.75809088592, 5394.541463975567, 5139.023585518739, 5190.195519694454, 5190.558802501791, 5283.128283833163, 5340.759665815048, 5737.139429085629, 5821.970890145564, 5833.88332233353, 5842.561807864385, 5866.618669786493, 6217.129601855744, 6274.0, 6282.528810339243, 6294.433500984934, 6299.401556852092, 6118.265808103056, 6130.264368275791, 6297.338779428185, 6334.398232167937, 6334.904976425358, 5715.057015592422, 5810.912836307459, 5817.243758311392, 5819.854503637401, 5850.210221620069, 6259.0, 6317.873642527124, 6321.557490975588, 6322.272938612118, 6324.683765811783, 5938.584299099021, 6000.819975400745, 6065.5450841187085, 6080.0879868019265, 6083.482903953213, 6198.0, 6308.400701933309, 6326.114343991845, 6332.081848131995, 6341.302456729756, 6196.597221180609, 6264.624122552661, 6282.811515654537, 6297.716602752887, 6308.369163083747, 6059.151718759377, 6117.9492029047315, 6240.095186197976, 6272.968635156795, 6288.937110628835, 4700.929486057712, 4740.45484769249, 4757.3577567028005, 4763.904721905543, 4771.117343291502, 4233.238017156941, 4254.659627229814, 4255.170241802819, 4262.808173632194, 4285.335772955197, 5897.970510147507, 5921.437463440966, 5956.761729530857, 5996.16053752475, 6009.1587177795145, 6195.2255968004, 6300.30696623371, 6326.588771729915, 6349.619022858643, 6356.936430635635, 5973.313068997034, 6055.122007308915, 6068.969655151696, 6073.0, 6082.574219804571, 5185.274061631375, 5301.3373328333955, 5411.675299482044, 5412.242286079952, 5426.864328391822, 6344.904826427607, 6547.34526547351, 6547.377999090078, 6548.70530826114, 6561.573497722633, 6326.4622507087415, 6327.145835312266, 6331.683415829282, 6335.176427064452, 6335.65153916539, 6221.4089661482085, 6359.8092057238355, 6380.968095159495, 6518.380753828379, 6537.378948999837, 6092.847678808065, 6144.354842741448, 6147.815565533041, 6154.353792851686, 6166.075088736726, 6264.279607844974, 6275.560710750204, 6287.779927702509, 6298.7480500781285, 6299.6535190564955, 6002.0, 6082.391760823883, 6112.716259964451, 6182.258129024366, 6193.163922870355, 6133.172021777182, 6160.845978850564, 6174.9073763892675, 6175.783847565313, 6197.411245931629, 6054.357733052438, 6120.17377654011, 6121.908171377522, 6123.969380153071, 6145.293291271382, 5986.4013598639785, 6100.938990610037, 6141.8464538385115, 6194.225721784777, 6230.7507699691505, 6076.817695469143, 6086.513078953584, 6091.908621370594, 6102.176206212104, 6109.450149486567], "value": 5766.434337393853, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.8205656246564, 637.2639601260544, 639.5395315372933, 643.7392855893363, 681.6319187638676, 40877.0, 45297.54702452975, 45699.31451028233, 45767.313490297674, 45806.7709661452, 46275.76862115685, 46339.30491042628, 46813.0, 46862.0, 46945.53054469454, 9061.41100828444, 9166.037566055567, 9200.171984521392, 9204.769880753001, 9212.170904618582, 9108.316876234276, 9179.219766319871, 9201.355905086646, 9218.17036466718, 9221.031791661879, 9308.394954327947, 9316.8602470963, 9317.72046838596, 9321.067893210658, 9323.440593564408, 9127.26981841451, 9237.861432078524, 9245.16793488586, 9261.72214833556, 9283.953580232055, 9088.818223635557, 9118.498482583454, 9129.908700912973, 9145.725628231165, 9162.083791620784, 43313.35029974553, 43484.13031739347, 43694.12611747747, 43768.12463750707, 43782.781086094685, 3804.5624753153465, 3958.168784555247, 4086.6730661547003, 4166.979165104185, 4174.833006679729, 35007.702328530395, 35153.82423087894, 35435.468467973, 35562.0, 36712.63287367146, 3939.665128464084, 4136.110736191733, 4136.379543068564, 4143.958560414418, 4200.285951388271, 359347.0, 361359.0, 362157.0, 365834.0, 367569.0, 64659.353406466274, 64970.675146623966, 64991.35008649853, 65041.0, 65095.67452162709, 40259.79870100631, 40420.19159616791, 41114.794426028275, 42864.57135428606, 42867.35698964518, 20097.6985345217, 20288.289909853083, 20291.28980485676, 20292.797072029385, 20327.288544900857, 15500.5349839505, 15596.688066238612, 15631.374745010073, 15691.293891774898, 15706.9214653926, 21206.681899771516, 21509.784902151092, 21526.56946861054, 21727.891360543097, 21735.67396489054, 7484.438667099989, 7741.806454838674, 7875.881861772078, 7904.604769761489, 8047.235512626291, 1049.627382279295, 1111.6831702964616, 1157.9536818527333, 1189.1913498820884, 1201.5794471934753, 33697.938788257336, 33970.660293397246, 34315.82842085774, 34430.48354274688, 34788.0, 1123.326004397355, 1170.9648710538697, 1209.4678341529698, 1241.9254844709346, 1267.4233223883111, 17655.558611034827, 17986.730199047026, 18030.36893708714, 18224.544386390182, 18255.90872045631, 595735.0, 596494.0, 598909.0, 602296.0, 603084.0, 66345.0, 66940.33059669439, 67106.0, 67130.66434667795, 67218.66390668016, 1441.9062760920506, 1444.2850788859582, 1483.7477628803128, 1484.3097959448908, 1503.9022463539834, 33531.16172095717, 33979.66020339765, 34166.0, 34179.65820341864, 34184.48723269103, 50839.49160508347, 51185.48814511956, 51274.743626283125, 58293.12560311514, 58615.70692146512, 465737.0, 467880.0, 467900.0, 470657.0, 471049.0, 31313.217169570944, 31687.52468713017, 31698.68301316957, 32135.517967230044, 32279.838600806845, 53750.46249537611, 53962.46037539731, 54119.0, 55063.72468137794, 55349.72325138348, 44818.77590612026, 46867.296990544484, 47517.287240690726, 47609.0, 48363.0, 45516.54483455256, 46395.0, 46407.303890441, 46672.533274668174, 47460.0, 41586.168276634904, 43631.12737745291, 44912.94953617975, 45418.77290613526, 45941.310880336154, 38557.42163867488, 39040.41439378355, 39307.80346098251, 42583.0, 42695.146097078505, 30177.245568860075, 30372.544411833398, 30718.84640576783, 30825.0, 31056.22359441032], "value": 21579.53935252461, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.8187997281198, 416.6354439865118, 417.6366561091851, 420.16806722689074, 448.60522739988807, 19070.42788716339, 19950.900245498753, 20243.49391265219, 20453.48866278344, 20684.27605033824, 19950.900245498753, 20097.397078087644, 20343.28798492053, 20663.17347306106, 20980.370588882357, 5784.739686714087, 5971.820845374624, 5998.910016349736, 6002.309734380537, 6012.819615411545, 5733.569982251348, 5876.794312199074, 5927.644341339534, 5935.52515798735, 5941.465268125868, 5989.281286245657, 6021.578489505737, 6047.969760151215, 6050.939490605082, 6053.0, 5922.378150294243, 5982.162497250389, 5995.85010374742, 6032.819015429544, 6041.184440100574, 5726.713664316768, 5980.372060933583, 6046.244219472566, 6059.212302400704, 6099.634021958653, 15001.624959375993, 15294.388224471008, 15320.616984575363, 19526.414207573795, 24636.753632463624, 2452.914148004811, 2488.7760101590943, 2600.89596416145, 3004.354063876277, 3143.465610846162, 11175.888241117565, 11427.885721142848, 11516.827247591209, 12818.679533011657, 14499.42002319906, 1994.411648563677, 2051.312810208582, 2075.792420757927, 2112.6302896992966, 2132.6201400867953, 75159.62420187918, 76436.0, 81788.59105704493, 85725.57137214275, 87477.56261218654, 11536.365499897585, 11920.46357913896, 12026.0, 12074.818877716842, 12158.230948406022, 16834.494965151065, 16920.407785727686, 16964.321427143022, 16978.151092445576, 17130.229139688745, 8983.865242021375, 9074.86387704185, 9202.171804537624, 9282.0, 9319.16127548524, 9039.412438191497, 9044.095590440904, 9070.81858362829, 9274.350795444254, 9278.67524636648, 5115.104856650071, 5133.6919784813035, 5149.845504634867, 5201.401838788588, 5211.530962213419, 2145.324222869791, 2198.9120435182735, 2206.5035367042287, 2220.9000594973263, 2229.955400891973, 976.6776963601994, 1078.2021304234809, 1085.0560012788924, 1105.4251789069638, 1146.6388087752332, 19725.60548789045, 20460.897695511427, 21233.0, 21540.676889846665, 22976.080956761878, 1057.3127467146417, 1058.8411738239172, 1090.5801266512292, 1090.8472813806075, 1132.64887884756, 11483.42582870853, 11629.767404651859, 11674.533018679158, 11740.58907938218, 11894.88105118955, 479696.0, 491891.0, 498158.0, 501772.0, 503029.0, 98770.0, 99412.0, 101351.49324253331, 102494.48752756338, 103055.0, 1059.5708737961138, 1098.9945050274698, 1104.4974536585835, 1118.5302173087323, 1123.1520202247414, 18386.81613183851, 18768.0, 19050.90474547674, 19097.809021910158, 19201.943893086016, 44439.33340999952, 44721.0, 45310.546894530635, 45827.77086114548, 47012.7649361751, 63534.0, 63685.3631463698, 64028.67985660042, 64179.35820641734, 64343.35656643561, 9068.727938161866, 9163.99196088443, 9332.906670933204, 9375.390599611004, 9436.764080897758, 13006.0, 14425.711485770016, 14478.493252736525, 14622.488212912922, 14705.92647036758, 11757.176997610086, 12316.815247771112, 12336.62990110298, 12689.492420303084, 12754.872451275369, 11974.161808673309, 11989.76020479568, 12109.0918181135, 12404.503819847467, 12694.936525317315, 12301.692457688629, 12468.625941221779, 12566.937165314115, 12840.743185136058, 12877.0, 9076.0, 9319.6272149116, 9374.876203303875, 9423.623055077995, 9672.468014259282, 12098.213616114925, 12236.69408264765, 12300.569480068154, 12483.687907802014, 12619.49522019109], "value": 9887.140499089224, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1541.6993686231185, 1551.49576387674, 1712.6403455274392, 1771.840534351908, 1810.2035104553995, 8443.155684431555, 9066.229370503506, 9153.954230228856, 9768.804623907517, 9788.951055244723, 9101.499417532033, 9375.76560585984, 9440.905590944089, 9467.857982130274, 9522.619095236183, 2438.4147804526874, 2474.64117702933, 2483.552960467115, 2489.8630575318352, 2498.962515562268, 2413.794827439661, 2492.8753562321813, 2501.8999240030375, 2512.170983575416, 2519.8992040318367, 2420.3102115896972, 2423.127674037345, 2501.8991643676814, 2523.268252206867, 2525.8231923765343, 2421.104191449166, 2424.539337525873, 2432.85402875828, 2442.926712198637, 2449.436629575199, 2443.5235129149823, 2460.1389513670074, 2460.5324988252173, 2465.3713303107593, 2466.8149888758417, 9352.812943741155, 9366.063393660648, 9500.192483638899, 9500.477473738942, 9512.571934262975, 5638.35158956717, 5774.307083150007, 5777.45114214149, 5783.913241301384, 5787.536997040227, 3360.512725654766, 3380.864765409405, 3456.3778519866414, 3469.9132521686906, 3513.8243087845503, 1187.4181650990952, 1225.1424003197797, 1226.0865655087018, 1236.4744983382027, 1247.2516490105954, 13289.800652990212, 13443.126196797177, 13448.193108413428, 13469.461221551126, 13483.191008539421, 4777.713337199779, 4818.855434336975, 4948.183549714328, 4977.104121258136, 5106.336176297058, 11232.55069797199, 11269.380184089954, 11292.040176585082, 11312.490937907649, 11370.0, 5819.127130930395, 5844.590878638454, 5846.239988801513, 5852.034414321674, 5862.648241105548, 4631.0506346198945, 5147.794088236428, 5238.5023422774775, 5255.290535777697, 5365.195220716923, 4201.789910504463, 4250.808713607895, 4315.546867578922, 4323.654107671378, 4323.740575565476, 1322.6759443936296, 1331.0549509847922, 1344.596621013692, 1349.2174538767492, 1360.9659758505918, 1027.291169093323, 1036.486938965217, 1050.56926660069, 1051.358671210561, 1068.930519516229, 5888.793892213837, 6011.0, 6370.203724534434, 6399.968000159969, 6633.4693224541925, 498.56873804159864, 504.0775381052738, 506.42014892948106, 520.8385400525773, 525.2384043137466, 4236.406903033578, 4339.500957389878, 4345.630621397154, 4374.431323927869, 4381.5618438155925, 11503.76992460163, 11510.654680359603, 11604.0, 11651.708707282385, 11914.344711040976, 11606.941965290289, 11669.533218671328, 11675.416229188506, 11696.941515292368, 11735.119866010084, 8474.957625211835, 8673.132686731276, 8844.115588441233, 8845.027047024822, 9036.909630903738, 6390.968045159931, 6397.072424498515, 6537.934620653733, 6600.174978127734, 6655.900161497679, 10512.316699414514, 10735.892641073802, 10778.89221107779, 10806.35161890289, 10861.945690271497, 10601.41692206936, 10893.910608939359, 10916.672499825017, 10978.0, 11004.284721493077, 7832.960835195788, 8185.4270201085355, 8376.832463350576, 8462.576871156294, 8669.739907802776, 9347.859782103409, 9422.952885235803, 9427.95286023593, 9456.2907781918, 9470.19503342196, 8167.754967350989, 8332.958335208285, 8553.230209281195, 8572.699955501528, 8643.956780216058, 8206.0, 8261.628226729932, 8280.544570048463, 8343.332533397435, 8356.122607126164, 7561.3194812467145, 7813.335866451415, 7894.447388682737, 7915.683372665029, 7917.208279172037, 5471.151971444432, 5642.125470552071, 5660.88678226425, 5706.115552089433, 5726.455986681259, 5662.745176467151, 5717.742701578522, 5750.30996280449, 5758.452946970031, 5802.274715660543], "value": 4903.047566705371, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.6236109099445, 344.8913592218453, 345.3869381847221, 345.52490325802023, 350.7334425836364, 5750.923256058009, 5843.79546715865, 5859.209006784088, 5873.794417195394, 5881.206037184978, 5757.0, 5773.451522105393, 5774.6535207887455, 5780.364159942414, 5791.131330300457, 4348.608625223737, 4439.75581343026, 4476.820927162909, 4509.72941623502, 4527.773611319437, 4495.325701144838, 4497.0, 4497.572730590588, 4513.187626227278, 4523.6607254455885, 4483.417155769762, 4516.751578663172, 4529.230030894756, 4532.501424843264, 4532.614727748129, 4438.356438316442, 4495.550444955511, 4505.098980203956, 4521.886952826173, 4524.547545245482, 4014.8394064237395, 4040.7979601020124, 4055.776932268724, 4058.269511487931, 4062.979685101556, 5694.259746233005, 5700.515456186229, 5712.857178570527, 5733.88532229353, 5747.2241247431475, 4874.610031197496, 5053.444121146671, 5115.590752739772, 5126.71803050832, 5149.227615857614, 6018.488428483584, 6050.54620903434, 6053.636781793107, 6107.969460152671, 6109.236345456818, 4144.378343248507, 4260.7656578888145, 4266.935995960063, 4289.206496798102, 4313.374560688714, 6252.3747625237565, 6261.749530018794, 6328.208973878265, 6354.682265886687, 6382.936170638327, 4444.28891377378, 4457.729547079067, 4479.17135329965, 4484.977575112103, 4487.227545119659, 4388.429504164502, 4471.23988921884, 4552.681312308173, 4553.749543775058, 4564.977175114103, 5113.565346945476, 5128.230765385148, 5132.8460146195675, 5141.203113517411, 5197.324347834758, 6115.510759139258, 6134.693265336716, 6138.631682099089, 6140.990914451976, 6159.6612186329285, 1490.970180596382, 1546.427821705976, 1564.6166689161, 1567.6942996115877, 1583.762435634641, 984.8276551603441, 988.8134238913333, 1016.9338992965434, 1040.2510192661273, 1070.063694267516, 5840.8539786504825, 5845.181674565564, 5865.824025279248, 5873.032534101038, 5897.7935772247765, 6116.204893363834, 6222.968885155636, 6274.905876411857, 6279.748810047547, 6281.937180628135, 5709.375217317895, 5827.883442331215, 5881.323647780475, 5892.292924849045, 5898.528117750569, 3303.9174020649675, 3309.2885029718245, 3309.907730448946, 3312.0, 3323.7507186960593, 6133.570650054453, 6402.295747467775, 6428.325025872309, 6430.324815894357, 6555.0, 6395.42441180296, 6401.711922963478, 6407.679616019181, 6412.262589802139, 6437.0988061671405, 6323.399277068671, 6489.18885139367, 6536.411722944958, 6538.869222615616, 6613.272540020594, 6289.213848268966, 6294.496440284858, 6301.464375528131, 6308.589941653961, 6369.745210191726, 6147.815565533041, 6256.718447669775, 6258.748250349857, 6294.968525157345, 6304.5271604628915, 6367.554271201157, 6431.292557818542, 6520.902186467112, 6525.347465253437, 6537.640429776217, 4481.865544033684, 4509.188346097734, 4513.119941611486, 4526.977365113154, 4527.479339875957, 6177.382261773787, 6349.9682501587195, 6350.650714210763, 6415.775447859302, 6446.226452825691, 6166.828302622487, 6212.254529456494, 6216.689165541795, 6216.906746398898, 6240.188775459162, 5988.311344195299, 6151.0, 6193.81418557426, 6202.503799696104, 6206.782762603287, 5939.316978547522, 6097.298810636834, 6107.603005804608, 6116.847078823065, 6122.469382654336, 6183.783567575113, 6187.659678717534, 6195.411435913581, 6195.504359651307, 6234.501239900887, 5980.979605299296, 6045.428188671065, 6047.576669633084, 6076.513878889767, 6092.543059270483], "value": 4654.015599773039, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.8068463568743, 807.6971135824068, 823.2220551578757, 849.6941101203565, 877.8068824858536, 16313.102779347131, 17458.912705436487, 17528.91235543824, 17566.209520571574, 17593.91203043986, 15988.12065336406, 16247.756283655755, 16311.265993030313, 16321.10233937133, 16349.754753678704, 858.6994551906829, 867.7266661001796, 889.7330800759779, 893.7274131389923, 896.8116695493954, 889.7063968890251, 890.1632465482459, 890.1854802855412, 890.2210565754964, 891.9687810926619, 914.5747227539193, 915.8122584870085, 920.6593560382668, 921.3964853021282, 922.6401703335671, 895.1719659315172, 905.8958219804708, 906.8322360363354, 908.7182973278304, 908.8182363527255, 670.1154476091561, 673.3434900971563, 673.804596666966, 678.1726293921408, 678.304737643914, 16382.426615068416, 16405.58986025359, 16425.67148657032, 16486.422975195932, 16550.089745064015, 13854.93072534641, 13948.2328471934, 14186.787198192036, 15673.294701738336, 16064.59838504035, 13200.6699832504, 13428.932855335759, 13491.595252142451, 13695.315234238347, 13912.165270083726, 4755.856407804215, 4810.663253572251, 4854.12625727369, 4862.44081930579, 4872.9756351218375, 86430.99999999937, 88893.11106888913, 90191.54904225502, 95142.52428737881, 95274.0, 12297.323647199311, 12368.44342004612, 12437.315947622968, 12513.186642868184, 12645.747085058247, 23109.191178309015, 23115.422114447272, 23159.53680926372, 23195.188168414024, 23868.64197037046, 8907.153820387053, 8952.776180595538, 9314.34799564024, 9483.857742133736, 9548.522573871278, 5110.48895110486, 5164.483551644806, 5189.610779191576, 5212.895742085213, 5338.065838478328, 3851.8651847185215, 4023.9195216095513, 4028.939565906514, 4035.959640403617, 4040.3535434330365, 688.0607970120749, 692.425287011779, 699.0562740300553, 708.348319546019, 719.2950908110081, 630.6752022708309, 718.500642053778, 733.6515155301189, 748.9514679448706, 837.8617528107794, 9176.44941303524, 9827.656032038843, 10115.836678781887, 10486.528106235237, 10661.466926653637, 753.9434542409341, 764.8852672099118, 776.1384862802284, 788.5820515126992, 800.9439339246197, 4953.925691114636, 5158.948410515847, 5181.4300426953005, 5263.157894736823, 5279.630425870152, 77459.61270193725, 78816.60591697005, 90941.0, 130062.0, 133485.0, 64447.35552644507, 65454.34545654578, 66216.33783662102, 66351.33648663548, 94934.0, 69574.95637565441, 79523.0, 92750.0, 96323.0, 98268.0, 9797.06927841854, 9925.211434961711, 9940.552675129491, 9967.750806229613, 10104.494775261355, 58808.41191588029, 59394.0, 59536.70231648814, 60198.699006504685, 61117.0, 85067.5746621263, 85080.57459712662, 86566.56716716629, 87695.56152219199, 89825.55087224522, 12947.482100715866, 12949.741005180033, 12958.546450874173, 13385.263810490516, 13465.057445978688, 13270.071095023255, 13296.734065318833, 13536.458541658223, 13593.388297526437, 13700.040997130503, 13720.86279137196, 13752.106113102616, 13760.089451063866, 13959.302034898417, 13962.511312104027, 12759.80860287115, 12939.805902911276, 12976.091673582758, 13066.477340906638, 13084.476620935056, 12333.198342107735, 12827.935860321011, 12901.612951611467, 12973.0, 13126.803097953347, 11059.612913547988, 11336.716582085513, 11466.0, 11608.767824643292, 11711.531538738696, 11946.462409191781, 12243.387830608612, 12469.625911222678, 12879.935600322313, 13362.331883405985], "value": 8008.025363890049, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1498.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 105.0, 110.0, 112.0, 111.0, 112.0, 112.0, 112.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 117.0, 142.0, 163.0, 128.0, 148.0, 150.0, 120.0, 171.0, 125.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 161.0, 162.0, 164.0, 165.0, 161.0, 162.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 168.0, 75.0, 75.0, 77.0, 77.0, 166.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 143.0, 84.0, 83.0, 84.0, 140.0, 83.0, 83.0, 148.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 119.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 151.0, 150.0, 151.0, 147.0, 148.0, 149.0, 147.0, 147.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 54.0, 51.0, 51.0, 54.0, 50.0, 50.0, 54.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 78.0, 72.0, 78.0, 72.0, 76.0, 74.0, 72.0, 71.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 122.0, 121.0, 119.0, 116.0, 117.0, 117.0, 138.0, 158.0, 119.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 158.0, 153.0, 152.0, 154.0, 159.0, 150.0, 152.0, 155.0, 152.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 63.0, 63.0, 61.0, 67.0, 61.0, 61.0, 61.0, 62.0], "value": 62.6, "unit": "score"}]}]} 09:27:05 INFO - Return code: 0 09:27:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:27:05 ERROR - # TBPL SUCCESS # 09:27:05 INFO - Running post-action listener: _resource_record_post_action 09:27:05 INFO - [mozharness: 2016-08-06 16:27:05.921277Z] Finished run-tests step (success) 09:27:05 INFO - Running post-run listener: _resource_record_post_run 09:27:05 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 329719808; Read time: 32; Write time: 266876 09:27:05 INFO - TinderboxPrint: CPU usage
13.2% 09:27:05 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 09:27:05 INFO - TinderboxPrint: I/O write bytes / time
329,719,808 / 266,876 09:27:05 INFO - TinderboxPrint: CPU idle
8,226.9 (86.8%) 09:27:05 INFO - TinderboxPrint: CPU user
1,195.8 (12.6%) 09:27:05 INFO - TinderboxPrint: Swap in / out
0 / 0 09:27:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 79097856; Read time: 0; Write time: 101120 09:27:06 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 262144; Write bytes: 250007552; Read time: 20; Write time: 165752 09:27:06 INFO - Running post-run listener: _upload_blobber_files 09:27:06 INFO - Blob upload gear active. 09:27:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:27:06 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:27:06 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:27:06 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:27:06 INFO - (blobuploader) - INFO - Open directory for files ... 09:27:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:27:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:27:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:07 INFO - (blobuploader) - INFO - Done attempting. 09:27:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:27:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:27:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:08 INFO - (blobuploader) - INFO - Done attempting. 09:27:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:27:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:27:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:12 INFO - (blobuploader) - INFO - Done attempting. 09:27:12 INFO - (blobuploader) - INFO - Iteration through files over. 09:27:12 INFO - Return code: 0 09:27:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:27:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:27:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4912e3906f83ecc6aa14d39a40e6009ad3b22ab416ad1955165d775916de3180cfce08d4212d81c5ea5e9f038850f0f215f111643c9c88db3f382a754a44894", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b3a621793b26b85fb04b77d89f70cfb6e6969086ce9f863217d5d2875bdbcc1c00f8fc736056d699c0859a2bb1891f62b40751b64c96f5fb956f19c52433baa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28815141ece56da6a355d2b59f94b4e08acb4aa530a8599eb535e6ef5cd1878beffae2196095400ed4258fed3fba682838e9a6e428534f684b5f9d77e1c04736"} 09:27:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:27:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:27:12 INFO - Contents: 09:27:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4912e3906f83ecc6aa14d39a40e6009ad3b22ab416ad1955165d775916de3180cfce08d4212d81c5ea5e9f038850f0f215f111643c9c88db3f382a754a44894", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b3a621793b26b85fb04b77d89f70cfb6e6969086ce9f863217d5d2875bdbcc1c00f8fc736056d699c0859a2bb1891f62b40751b64c96f5fb956f19c52433baa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28815141ece56da6a355d2b59f94b4e08acb4aa530a8599eb535e6ef5cd1878beffae2196095400ed4258fed3fba682838e9a6e428534f684b5f9d77e1c04736"} 09:27:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:27:12 INFO - Copying logs to upload dir... 09:27:12 INFO - mkdir: /builds/slave/test/build/upload/logs 09:27:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.922253 ========= master_lag: 1.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 59 secs) (at 2016-08-06 09:27:13.093266) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 09:27:13.101658) ========= 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=41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695 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/e4912e3906f83ecc6aa14d39a40e6009ad3b22ab416ad1955165d775916de3180cfce08d4212d81c5ea5e9f038850f0f215f111643c9c88db3f382a754a44894", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b3a621793b26b85fb04b77d89f70cfb6e6969086ce9f863217d5d2875bdbcc1c00f8fc736056d699c0859a2bb1891f62b40751b64c96f5fb956f19c52433baa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28815141ece56da6a355d2b59f94b4e08acb4aa530a8599eb535e6ef5cd1878beffae2196095400ed4258fed3fba682838e9a6e428534f684b5f9d77e1c04736"} build_url:https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/btWqjEikQhmY-m4REu51dw/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/e4912e3906f83ecc6aa14d39a40e6009ad3b22ab416ad1955165d775916de3180cfce08d4212d81c5ea5e9f038850f0f215f111643c9c88db3f382a754a44894", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b3a621793b26b85fb04b77d89f70cfb6e6969086ce9f863217d5d2875bdbcc1c00f8fc736056d699c0859a2bb1891f62b40751b64c96f5fb956f19c52433baa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28815141ece56da6a355d2b59f94b4e08acb4aa530a8599eb535e6ef5cd1878beffae2196095400ed4258fed3fba682838e9a6e428534f684b5f9d77e1c04736"}' ========= master_lag: 0.64 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 09:27:13.750865) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-08-06 09:27:13.755274) ========= 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=41bf3e9aed84707956354da8000001c5-1470491208.822004-1179862695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 1.72 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-08-06 09:27:15.482095) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 09:27:15.482416) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 09:27:15.541275) ========= ========= Total master_lag: 3.55 =========