builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1467933678.53 results: success (0) buildid: 20160707133059 builduid: 70472f32ba9f4ad1beee9b93297c0e6c revision: 752282c3e152f3c56de2c66dd56cb05e79b05807 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 16:21:18.525777) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 16:21:18.526179) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 16:21:18.526472) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 16:21:18.550909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 16:21:18.551166) ========= 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-1467931322.140484-755944837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 16:21:18-- 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% 23.7M=0s 2016-07-07 16:21:18 (23.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075444 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 16:21:18.644033) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 16:21:18.644358) ========= 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-1467931322.140484-755944837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021982 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 16:21:18.694314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 16:21:18.694683) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 752282c3e152f3c56de2c66dd56cb05e79b05807 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 752282c3e152f3c56de2c66dd56cb05e79b05807 --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-1467931322.140484-755944837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 16:21:19,111 truncating revision to first 12 chars 2016-07-07 16:21:19,111 Setting DEBUG logging. 2016-07-07 16:21:19,111 attempt 1/10 2016-07-07 16:21:19,111 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/752282c3e152?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 16:21:19,419 unpacking tar archive at: mozilla-inbound-752282c3e152/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655444 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 16:21:19.363791) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 16:21:19.364084) ========= script_repo_revision: 752282c3e152f3c56de2c66dd56cb05e79b05807 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 16:21:19.364480) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 16:21:19.364808) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 16:21:19.373700) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-07 16:21:19.373991) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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-1467931322.140484-755944837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:21:19 INFO - MultiFileLogger online at 20160707 16:21:19 in /builds/slave/test 16:21:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:21:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:21:19 INFO - {'append_to_log': False, 16:21:19 INFO - 'base_work_dir': '/builds/slave/test', 16:21:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:21:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:21:19 INFO - 'branch': 'Mozilla-Inbound', 16:21:19 INFO - 'buildbot_json_path': 'buildprops.json', 16:21:19 INFO - 'config_files': ('talos/linux_config.py',), 16:21:19 INFO - 'default_actions': ('clobber', 16:21:19 INFO - 'read-buildbot-config', 16:21:19 INFO - 'download-and-extract', 16:21:19 INFO - 'populate-webroot', 16:21:19 INFO - 'create-virtualenv', 16:21:19 INFO - 'install', 16:21:19 INFO - 'run-tests'), 16:21:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:21:19 INFO - 'download_minidump_stackwalk': True, 16:21:19 INFO - 'download_symbols': 'ondemand', 16:21:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:21:19 INFO - 'tooltool.py': '/tools/tooltool.py', 16:21:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:21:19 INFO - '/tools/misc-python/virtualenv.py')}, 16:21:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:21:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:21:19 INFO - 'installer_path': 'installer.exe', 16:21:19 INFO - 'log_level': 'info', 16:21:19 INFO - 'log_name': 'talos', 16:21:19 INFO - 'log_to_console': True, 16:21:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:21:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:21:19 INFO - 'opt_config_files': (), 16:21:19 INFO - 'pip_index': False, 16:21:19 INFO - 'sps_profile': False, 16:21:19 INFO - 'sps_profile_interval': 0, 16:21:19 INFO - 'suite': 'dromaeojs', 16:21:19 INFO - 'system_bits': '32', 16:21:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:21:19 INFO - 'title': 'talos-linux64-ix-026', 16:21:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:21:19 INFO - 'use_talos_json': True, 16:21:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:21:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:21:19 INFO - 'work_dir': 'build'} 16:21:19 INFO - ##### 16:21:19 INFO - ##### Running clobber step. 16:21:19 INFO - ##### 16:21:19 INFO - Running pre-action listener: _resource_record_pre_action 16:21:19 INFO - Running main action method: clobber 16:21:19 INFO - rmtree: /builds/slave/test/build 16:21:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:21:20 INFO - Running post-action listener: _resource_record_post_action 16:21:20 INFO - ##### 16:21:20 INFO - ##### Finished clobber step (success) 16:21:20 INFO - ##### 16:21:20 INFO - ##### 16:21:20 INFO - ##### Running read-buildbot-config step. 16:21:20 INFO - ##### 16:21:20 INFO - Running pre-action listener: _resource_record_pre_action 16:21:20 INFO - Running main action method: read_buildbot_config 16:21:20 INFO - Using buildbot properties: 16:21:20 INFO - { 16:21:20 INFO - "project": "", 16:21:20 INFO - "product": "firefox", 16:21:20 INFO - "script_repo_revision": "production", 16:21:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:21:20 INFO - "repository": "", 16:21:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:21:20 INFO - "buildid": "20160707133059", 16:21:20 INFO - "pgo_build": "True", 16:21:20 INFO - "basedir": "/builds/slave/test", 16:21:20 INFO - "buildnumber": 1298, 16:21:20 INFO - "slavename": "talos-linux64-ix-026", 16:21:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:21:20 INFO - "platform": "ubuntu64_hw", 16:21:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:21:20 INFO - "branch": "mozilla-inbound", 16:21:20 INFO - "repo_path": "integration/mozilla-inbound", 16:21:20 INFO - "revision": "752282c3e152f3c56de2c66dd56cb05e79b05807", 16:21:20 INFO - "stage_platform": "linux64-pgo", 16:21:20 INFO - "builduid": "70472f32ba9f4ad1beee9b93297c0e6c", 16:21:20 INFO - "slavebuilddir": "test" 16:21:20 INFO - } 16:21:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:21:20 INFO - Running post-action listener: _resource_record_post_action 16:21:20 INFO - ##### 16:21:20 INFO - ##### Finished read-buildbot-config step (success) 16:21:20 INFO - ##### 16:21:20 INFO - ##### 16:21:20 INFO - ##### Running download-and-extract step. 16:21:20 INFO - ##### 16:21:20 INFO - Running pre-action listener: _resource_record_pre_action 16:21:20 INFO - Running main action method: download_and_extract 16:21:20 INFO - mkdir: /builds/slave/test/build/tests 16:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:20 INFO - https://queue.taskcluster.net/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:21:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:21:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:21:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:21:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:21:38 INFO - Downloaded 1361 bytes. 16:21:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:21:38 INFO - Using the following test package requirements: 16:21:38 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:21:38 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:21:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:21:38 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:21:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:21:38 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:21:38 INFO - u'jsshell-linux-x86_64.zip'], 16:21:38 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:21:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:21:38 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:21:38 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:21:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:21:38 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:21:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:21:38 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:21:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:21:38 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:21:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:21:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:21:38 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')]} 16:21:38 INFO - https://queue.taskcluster.net/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:21:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:21:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:21:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:21:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:21:41 INFO - Downloaded 24304744 bytes. 16:21:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:21:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:21:42 INFO - Return code: 0 16:21:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:42 INFO - https://queue.taskcluster.net/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:21:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:21:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:21:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:21:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:21:43 INFO - Downloaded 24304744 bytes. 16:21:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:21:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:21:45 INFO - Return code: 0 16:21: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')]} 16:21:45 INFO - https://queue.taskcluster.net/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:21:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:21:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:21:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:21:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:21:46 INFO - Downloaded 14403333 bytes. 16:21:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:21:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:21:46 INFO - Return code: 0 16:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:46 INFO - https://queue.taskcluster.net/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:21:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:21:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:21:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:21:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:21:48 INFO - Downloaded 60455628 bytes. 16:21:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:21:48 INFO - mkdir: /builds/slave/test/properties 16:21:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:21:48 INFO - Writing to file /builds/slave/test/properties/build_url 16:21:48 INFO - Contents: 16:21:48 INFO - build_url:https://queue.taskcluster.net/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:21:49 INFO - Running post-action listener: _resource_record_post_action 16:21:49 INFO - Running post-action listener: set_extra_try_arguments 16:21:49 INFO - ##### 16:21:49 INFO - ##### Finished download-and-extract step (success) 16:21:49 INFO - ##### 16:21:49 INFO - ##### 16:21:49 INFO - ##### Running populate-webroot step. 16:21:49 INFO - ##### 16:21:49 INFO - Running pre-action listener: _resource_record_pre_action 16:21:49 INFO - Running main action method: populate_webroot 16:21:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:21:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:21:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:21:49 INFO - '--tppagecycles', 16:21:49 INFO - '7'], 16:21:49 INFO - 'tests': ['tsvgm']}}, 16:21:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:21:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:21:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:21:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:21:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:21:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:21:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:49 INFO - 'talos_options': ['--disable-e10s'], 16:21:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:49 INFO - 'talos_options': ['--disable-e10s'], 16:21:49 INFO - 'tests': ['damp', 'tps']}, 16:21:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:49 INFO - 'tests': ['damp', 'tps']}, 16:21:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:21:49 INFO - 'tests': ['dromaeo_dom']}, 16:21:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:21:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:21:49 INFO - 'tests': ['basic_compositor_video']}, 16:21:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:21:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:21:49 INFO - 'tests': ['a11yr', 16:21:49 INFO - 'ts_paint', 16:21:49 INFO - 'tpaint', 16:21:49 INFO - 'sessionrestore', 16:21:49 INFO - 'sessionrestore_no_auto_restore', 16:21:49 INFO - 'tabpaint']}, 16:21:49 INFO - 'other-e10s': {'tests': ['a11yr', 16:21:49 INFO - 'ts_paint', 16:21:49 INFO - 'tpaint', 16:21:49 INFO - 'sessionrestore', 16:21:49 INFO - 'sessionrestore_no_auto_restore', 16:21:49 INFO - 'tabpaint']}, 16:21:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:21:49 INFO - 'ts_paint', 16:21:49 INFO - 'tpaint', 16:21:49 INFO - 'sessionrestore', 16:21:49 INFO - 'sessionrestore_no_auto_restore', 16:21:49 INFO - 'tabpaint']}, 16:21:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:21:49 INFO - 'ts_paint', 16:21:49 INFO - 'tpaint', 16:21:49 INFO - 'sessionrestore', 16:21:49 INFO - 'sessionrestore_no_auto_restore', 16:21:49 INFO - 'tabpaint']}, 16:21:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:21:49 INFO - 'tests': ['a11yr', 16:21:49 INFO - 'ts_paint', 16:21:49 INFO - 'tpaint', 16:21:49 INFO - 'sessionrestore', 16:21:49 INFO - 'sessionrestore_no_auto_restore', 16:21:49 INFO - 'tabpaint']}, 16:21:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:21:49 INFO - 'tests': ['a11yr', 16:21:49 INFO - 'ts_paint', 16:21:49 INFO - 'tpaint', 16:21:49 INFO - 'sessionrestore', 16:21:49 INFO - 'sessionrestore_no_auto_restore', 16:21:49 INFO - 'tabpaint']}, 16:21:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:21:49 INFO - 'tests': ['tsvgx', 16:21:49 INFO - 'tsvgr_opacity', 16:21:49 INFO - 'tart', 16:21:49 INFO - 'tscrollx', 16:21:49 INFO - 'cart']}, 16:21:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:21:49 INFO - 'tsvgr_opacity', 16:21:49 INFO - 'tart', 16:21:49 INFO - 'tscrollx', 16:21:49 INFO - 'cart']}, 16:21:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:49 INFO - 'talos_options': ['--disable-e10s'], 16:21:49 INFO - 'tests': ['tp5o']}, 16:21:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:49 INFO - 'tests': ['tp5o']}, 16:21:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:49 INFO - 'talos_options': ['--disable-e10s', 16:21:49 INFO - '--xperf_path', 16:21:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:49 INFO - 'tests': ['tp5n']}, 16:21:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:49 INFO - 'talos_options': ['--xperf_path', 16:21:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:49 INFO - 'tests': ['tp5n']}}, 16:21:49 INFO - 'talos.zip': {'path': '', 16:21:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:21:49 INFO - Running post-action listener: _resource_record_post_action 16:21:49 INFO - ##### 16:21:49 INFO - ##### Finished populate-webroot step (success) 16:21:49 INFO - ##### 16:21:49 INFO - ##### 16:21:49 INFO - ##### Running create-virtualenv step. 16:21:49 INFO - ##### 16:21:49 INFO - Running pre-action listener: _resource_record_pre_action 16:21:49 INFO - Running main action method: create_virtualenv 16:21:49 INFO - Creating virtualenv /builds/slave/test/build/venv 16:21:49 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 16:21:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:21:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:21:49 INFO - Using real prefix '/usr' 16:21:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:21:49 INFO - Installing distribute.............................................................................................................................................................................................done. 16:21:51 INFO - Installing pip.................done. 16:21:51 INFO - Return code: 0 16:21:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:21: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')]} 16:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21: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')]} 16:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:51 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 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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-1467931322.140484-755944837', '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 16:21:51 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 16:21:51 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 16:21:51 INFO - Using env: {'DISPLAY': ':0', 16:21:51 INFO - 'HOME': '/home/cltbld', 16:21:51 INFO - 'LANG': 'en_US.UTF-8', 16:21:51 INFO - 'LANGUAGE': 'en_US:en', 16:21:51 INFO - 'LOGNAME': 'cltbld', 16:21:51 INFO - 'MAIL': '/var/mail/cltbld', 16:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:51 INFO - 'MOZ_NO_REMOTE': '1', 16:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:51 INFO - 'NO_EM_RESTART': '1', 16:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:51 INFO - 'PWD': '/builds/slave/test', 16:21:51 INFO - 'SHELL': '/bin/bash', 16:21:51 INFO - 'SHLVL': '1', 16:21:51 INFO - 'TERM': 'linux', 16:21:51 INFO - 'TMOUT': '86400', 16:21:51 INFO - 'USER': 'cltbld', 16:21:51 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467931322.140484-755944837', 16:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:51 INFO - '_': '/tools/buildbot/bin/python'} 16:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:51 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 16:21:51 INFO - Cleaning up... 16:21:51 INFO - Return code: 0 16:21:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:21: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')]} 16:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21: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')]} 16:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:51 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 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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-1467931322.140484-755944837', '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 16:21:51 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 16:21:51 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 16:21:51 INFO - Using env: {'DISPLAY': ':0', 16:21:51 INFO - 'HOME': '/home/cltbld', 16:21:51 INFO - 'LANG': 'en_US.UTF-8', 16:21:51 INFO - 'LANGUAGE': 'en_US:en', 16:21:51 INFO - 'LOGNAME': 'cltbld', 16:21:51 INFO - 'MAIL': '/var/mail/cltbld', 16:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:51 INFO - 'MOZ_NO_REMOTE': '1', 16:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:51 INFO - 'NO_EM_RESTART': '1', 16:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:51 INFO - 'PWD': '/builds/slave/test', 16:21:51 INFO - 'SHELL': '/bin/bash', 16:21:51 INFO - 'SHLVL': '1', 16:21:51 INFO - 'TERM': 'linux', 16:21:51 INFO - 'TMOUT': '86400', 16:21:51 INFO - 'USER': 'cltbld', 16:21:51 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467931322.140484-755944837', 16:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:51 INFO - '_': '/tools/buildbot/bin/python'} 16:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:52 INFO - Downloading/unpacking psutil>=3.1.1 16:21:52 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 16:21:52 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 16:21:52 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 16:21:52 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 16:21:52 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 16:21:52 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 16:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:21:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:21:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:21:54 INFO - Installing collected packages: psutil 16:21:54 INFO - Running setup.py install for psutil 16:21:54 INFO - building 'psutil._psutil_linux' extension 16:21:54 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 16:21:54 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 16:21:54 INFO - building 'psutil._psutil_posix' extension 16:21:54 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 16:21:54 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 16:21:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:21:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:21:54 INFO - Successfully installed psutil 16:21:54 INFO - Cleaning up... 16:21:54 INFO - Return code: 0 16:21:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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-1467931322.140484-755944837', '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 16:21:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:21:54 INFO - Using env: {'DISPLAY': ':0', 16:21:54 INFO - 'HOME': '/home/cltbld', 16:21:54 INFO - 'LANG': 'en_US.UTF-8', 16:21:54 INFO - 'LANGUAGE': 'en_US:en', 16:21:54 INFO - 'LOGNAME': 'cltbld', 16:21:54 INFO - 'MAIL': '/var/mail/cltbld', 16:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:54 INFO - 'MOZ_NO_REMOTE': '1', 16:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:54 INFO - 'NO_EM_RESTART': '1', 16:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:54 INFO - 'PWD': '/builds/slave/test', 16:21:54 INFO - 'SHELL': '/bin/bash', 16:21:54 INFO - 'SHLVL': '1', 16:21:54 INFO - 'TERM': 'linux', 16:21:54 INFO - 'TMOUT': '86400', 16:21:54 INFO - 'USER': 'cltbld', 16:21:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467931322.140484-755944837', 16:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:54 INFO - '_': '/tools/buildbot/bin/python'} 16:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:21:56 INFO - Installing collected packages: mozsystemmonitor 16:21:56 INFO - Running setup.py install for mozsystemmonitor 16:21:56 INFO - Successfully installed mozsystemmonitor 16:21:56 INFO - Cleaning up... 16:21:57 INFO - Return code: 0 16:21:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:21: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')]} 16:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21: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')]} 16:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21: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', '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 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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-1467931322.140484-755944837', '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 16:21: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:21: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 jsonschema==2.5.1 16:21:57 INFO - Using env: {'DISPLAY': ':0', 16:21:57 INFO - 'HOME': '/home/cltbld', 16:21:57 INFO - 'LANG': 'en_US.UTF-8', 16:21:57 INFO - 'LANGUAGE': 'en_US:en', 16:21:57 INFO - 'LOGNAME': 'cltbld', 16:21:57 INFO - 'MAIL': '/var/mail/cltbld', 16:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:57 INFO - 'MOZ_NO_REMOTE': '1', 16:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:57 INFO - 'NO_EM_RESTART': '1', 16:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:57 INFO - 'PWD': '/builds/slave/test', 16:21:57 INFO - 'SHELL': '/bin/bash', 16:21:57 INFO - 'SHLVL': '1', 16:21:57 INFO - 'TERM': 'linux', 16:21:57 INFO - 'TMOUT': '86400', 16:21:57 INFO - 'USER': 'cltbld', 16:21:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467931322.140484-755944837', 16:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:57 INFO - '_': '/tools/buildbot/bin/python'} 16:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:57 INFO - Downloading/unpacking jsonschema==2.5.1 16:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:21:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:59 INFO - Downloading functools32-3.2.3-2.tar.gz 16:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:21:59 INFO - warning: no files found matching '*.txt' 16:21:59 INFO - no previously-included directories found matching 'build' 16:21:59 INFO - no previously-included directories found matching 'dist' 16:21:59 INFO - no previously-included directories found matching '.git*' 16:21:59 INFO - Installing collected packages: jsonschema, functools32 16:21:59 INFO - Running setup.py install for functools32 16:21:59 INFO - warning: no files found matching '*.txt' 16:21:59 INFO - no previously-included directories found matching 'build' 16:21:59 INFO - no previously-included directories found matching 'dist' 16:21:59 INFO - no previously-included directories found matching '.git*' 16:21:59 INFO - Successfully installed jsonschema functools32 16:21:59 INFO - Cleaning up... 16:21:59 INFO - Return code: 0 16:21:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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-1467931322.140484-755944837', '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 16:21:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:21:59 INFO - Using env: {'DISPLAY': ':0', 16:21:59 INFO - 'HOME': '/home/cltbld', 16:21:59 INFO - 'LANG': 'en_US.UTF-8', 16:21:59 INFO - 'LANGUAGE': 'en_US:en', 16:21:59 INFO - 'LOGNAME': 'cltbld', 16:21:59 INFO - 'MAIL': '/var/mail/cltbld', 16:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:59 INFO - 'MOZ_NO_REMOTE': '1', 16:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:59 INFO - 'NO_EM_RESTART': '1', 16:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:59 INFO - 'PWD': '/builds/slave/test', 16:21:59 INFO - 'SHELL': '/bin/bash', 16:21:59 INFO - 'SHLVL': '1', 16:21:59 INFO - 'TERM': 'linux', 16:21:59 INFO - 'TMOUT': '86400', 16:21:59 INFO - 'USER': 'cltbld', 16:21:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467931322.140484-755944837', 16:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:59 INFO - '_': '/tools/buildbot/bin/python'} 16:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:59 INFO - Downloading/unpacking blobuploader==1.2.4 16:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:01 INFO - Downloading blobuploader-1.2.4.tar.gz 16:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:22:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:22:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:02 INFO - Downloading docopt-0.6.1.tar.gz 16:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:22:02 INFO - Installing collected packages: blobuploader, requests, docopt 16:22:02 INFO - Running setup.py install for blobuploader 16:22:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:22:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:22:02 INFO - Running setup.py install for requests 16:22:03 INFO - Running setup.py install for docopt 16:22:03 INFO - Successfully installed blobuploader requests docopt 16:22:03 INFO - Cleaning up... 16:22:03 INFO - Return code: 0 16:22:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22: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')]} 16:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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')]} 16:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:03 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 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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-1467931322.140484-755944837', '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 16:22:03 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 16:22:03 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 16:22:03 INFO - Using env: {'DISPLAY': ':0', 16:22:03 INFO - 'HOME': '/home/cltbld', 16:22:03 INFO - 'LANG': 'en_US.UTF-8', 16:22:03 INFO - 'LANGUAGE': 'en_US:en', 16:22:03 INFO - 'LOGNAME': 'cltbld', 16:22:03 INFO - 'MAIL': '/var/mail/cltbld', 16:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:03 INFO - 'MOZ_NO_REMOTE': '1', 16:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:03 INFO - 'NO_EM_RESTART': '1', 16:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:03 INFO - 'PWD': '/builds/slave/test', 16:22:03 INFO - 'SHELL': '/bin/bash', 16:22:03 INFO - 'SHLVL': '1', 16:22:03 INFO - 'TERM': 'linux', 16:22:03 INFO - 'TMOUT': '86400', 16:22:03 INFO - 'USER': 'cltbld', 16:22:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467931322.140484-755944837', 16:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:03 INFO - '_': '/tools/buildbot/bin/python'} 16:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:22:03 INFO - Running setup.py (path:/tmp/pip-Q6e7N4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:22:03 INFO - Running setup.py (path:/tmp/pip-MRlupO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:22:03 INFO - Running setup.py (path:/tmp/pip-p2Z4UB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:22:03 INFO - Running setup.py (path:/tmp/pip-ep76Dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:22:03 INFO - Running setup.py (path:/tmp/pip-p1wFY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:22:03 INFO - Running setup.py (path:/tmp/pip-vjg6il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:22:04 INFO - Running setup.py (path:/tmp/pip-npuIhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:22:04 INFO - Running setup.py (path:/tmp/pip-lbz6YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:22:04 INFO - Running setup.py (path:/tmp/pip-YUDXgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:22:04 INFO - Running setup.py (path:/tmp/pip-aj06Ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:22:04 INFO - Running setup.py (path:/tmp/pip-O0w4_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:22:04 INFO - Running setup.py (path:/tmp/pip-0ZRt00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:22:04 INFO - Running setup.py (path:/tmp/pip-NaZkRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:22:04 INFO - Running setup.py (path:/tmp/pip-7o5QLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:04 INFO - Running setup.py (path:/tmp/pip-cpOJeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:22:04 INFO - Running setup.py (path:/tmp/pip-AP7_Ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:22:04 INFO - Running setup.py (path:/tmp/pip-0jWcR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:22:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:22:04 INFO - Running setup.py install for manifestparser 16:22:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:22:04 INFO - Running setup.py install for mozcrash 16:22:05 INFO - Running setup.py install for mozdebug 16:22:05 INFO - Running setup.py install for mozdevice 16:22:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:22:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:22:05 INFO - Running setup.py install for mozfile 16:22:05 INFO - Running setup.py install for mozhttpd 16:22:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:22:05 INFO - Running setup.py install for mozinfo 16:22:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:22:05 INFO - Running setup.py install for mozInstall 16:22:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:22:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:22:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:22:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:22:05 INFO - Running setup.py install for mozleak 16:22:05 INFO - Running setup.py install for mozlog 16:22:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:22:05 INFO - Running setup.py install for moznetwork 16:22:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:22:05 INFO - Running setup.py install for mozprocess 16:22:06 INFO - Running setup.py install for mozprofile 16:22:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:22:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:22:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:22:06 INFO - Running setup.py install for mozrunner 16:22:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:22:06 INFO - Running setup.py install for mozscreenshot 16:22:06 INFO - Running setup.py install for moztest 16:22:06 INFO - Running setup.py install for mozversion 16:22:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:22:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:22:06 INFO - Cleaning up... 16:22:06 INFO - Return code: 0 16:22:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22: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')]} 16:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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')]} 16:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:06 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 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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-1467931322.140484-755944837', '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 16:22:06 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 16:22:06 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 16:22:06 INFO - Using env: {'DISPLAY': ':0', 16:22:06 INFO - 'HOME': '/home/cltbld', 16:22:06 INFO - 'LANG': 'en_US.UTF-8', 16:22:06 INFO - 'LANGUAGE': 'en_US:en', 16:22:06 INFO - 'LOGNAME': 'cltbld', 16:22:06 INFO - 'MAIL': '/var/mail/cltbld', 16:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:06 INFO - 'MOZ_NO_REMOTE': '1', 16:22:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:06 INFO - 'NO_EM_RESTART': '1', 16:22:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:06 INFO - 'PWD': '/builds/slave/test', 16:22:06 INFO - 'SHELL': '/bin/bash', 16:22:06 INFO - 'SHLVL': '1', 16:22:06 INFO - 'TERM': 'linux', 16:22:06 INFO - 'TMOUT': '86400', 16:22:06 INFO - 'USER': 'cltbld', 16:22:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467931322.140484-755944837', 16:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:06 INFO - '_': '/tools/buildbot/bin/python'} 16:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:22:06 INFO - Running setup.py (path:/tmp/pip-6YQ2jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:22:06 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)) 16:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:22:06 INFO - Running setup.py (path:/tmp/pip-i12WwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:22:06 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)) 16:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:22:06 INFO - Running setup.py (path:/tmp/pip-LYmewn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:22:07 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)) 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:22:07 INFO - Running setup.py (path:/tmp/pip-srfUHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:22:07 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)) 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:22:07 INFO - Running setup.py (path:/tmp/pip-65mjxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:22:07 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)) 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:22:07 INFO - Running setup.py (path:/tmp/pip-9NDoSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:22:07 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)) 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:22:07 INFO - Running setup.py (path:/tmp/pip-URByYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:22:07 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)) 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:22:07 INFO - Running setup.py (path:/tmp/pip-K_IzEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:22:07 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)) 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:22:07 INFO - Running setup.py (path:/tmp/pip-jVu9s6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:22:07 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)) 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:22:07 INFO - Running setup.py (path:/tmp/pip-QJVCDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:22:07 INFO - Running setup.py (path:/tmp/pip-ZZKqSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:22:07 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)) 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:22:07 INFO - Running setup.py (path:/tmp/pip-RULJvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:22:07 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)) 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:22:07 INFO - Running setup.py (path:/tmp/pip-w19atm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:22:07 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)) 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:22:07 INFO - Running setup.py (path:/tmp/pip-T5RlSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:22:07 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)) 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:07 INFO - Running setup.py (path:/tmp/pip-Xv81B0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:07 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)) 16:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:22:07 INFO - Running setup.py (path:/tmp/pip-ANwDj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:22:08 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)) 16:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:22:08 INFO - Running setup.py (path:/tmp/pip-J2Dnuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:22:08 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)) 16:22:08 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)) 16:22:08 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)) 16:22:08 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)) 16:22:08 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)) 16:22:08 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)) 16:22:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22:10 INFO - Downloading blessings-1.6.tar.gz 16:22:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:22:10 INFO - Installing collected packages: blessings 16:22:10 INFO - Running setup.py install for blessings 16:22:10 INFO - Successfully installed blessings 16:22:10 INFO - Cleaning up... 16:22:10 INFO - Return code: 0 16:22:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:22:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:22:10 INFO - Reading from file tmpfile_stdout 16:22:10 INFO - Current package versions: 16:22:10 INFO - argparse == 1.2.1 16:22:10 INFO - blessings == 1.6 16:22:10 INFO - blobuploader == 1.2.4 16:22:10 INFO - docopt == 0.6.1 16:22:10 INFO - functools32 == 3.2.3-2 16:22:10 INFO - jsonschema == 2.5.1 16:22:10 INFO - manifestparser == 1.1 16:22:10 INFO - mozInstall == 1.12 16:22:10 INFO - mozcrash == 0.17 16:22:10 INFO - mozdebug == 0.1 16:22:10 INFO - mozdevice == 0.48 16:22:10 INFO - mozfile == 1.2 16:22:10 INFO - mozhttpd == 0.7 16:22:10 INFO - mozinfo == 0.9 16:22:10 INFO - mozleak == 0.1 16:22:10 INFO - mozlog == 3.2 16:22:10 INFO - moznetwork == 0.27 16:22:10 INFO - mozprocess == 0.23 16:22:10 INFO - mozprofile == 0.28 16:22:10 INFO - mozrunner == 6.12 16:22:10 INFO - mozscreenshot == 0.1 16:22:10 INFO - mozsystemmonitor == 0.3 16:22:10 INFO - moztest == 0.7 16:22:10 INFO - mozversion == 1.4 16:22:10 INFO - psutil == 3.1.1 16:22:10 INFO - requests == 1.2.3 16:22:10 INFO - wsgiref == 0.1.2 16:22:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:10 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 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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-1467931322.140484-755944837', '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 16:22:10 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 16:22:10 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 16:22:10 INFO - Using env: {'DISPLAY': ':0', 16:22:10 INFO - 'HOME': '/home/cltbld', 16:22:10 INFO - 'LANG': 'en_US.UTF-8', 16:22:10 INFO - 'LANGUAGE': 'en_US:en', 16:22:10 INFO - 'LOGNAME': 'cltbld', 16:22:10 INFO - 'MAIL': '/var/mail/cltbld', 16:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:10 INFO - 'MOZ_NO_REMOTE': '1', 16:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:10 INFO - 'NO_EM_RESTART': '1', 16:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:10 INFO - 'PWD': '/builds/slave/test', 16:22:10 INFO - 'SHELL': '/bin/bash', 16:22:10 INFO - 'SHLVL': '1', 16:22:10 INFO - 'TERM': 'linux', 16:22:10 INFO - 'TMOUT': '86400', 16:22:10 INFO - 'USER': 'cltbld', 16:22:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467931322.140484-755944837', 16:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:10 INFO - '_': '/tools/buildbot/bin/python'} 16:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:10 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)) 16:22:10 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)) 16:22:10 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)) 16:22:10 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)) 16:22:10 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)) 16:22:10 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)) 16:22:10 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)) 16:22:10 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)) 16:22:10 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)) 16:22:10 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)) 16:22:10 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)) 16:22:10 INFO - Cleaning up... 16:22:10 INFO - Return code: 0 16:22:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:10 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 0xca1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf62180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, '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-1467931322.140484-755944837', '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 16:22:10 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 16:22:10 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 16:22:10 INFO - Using env: {'DISPLAY': ':0', 16:22:10 INFO - 'HOME': '/home/cltbld', 16:22:10 INFO - 'LANG': 'en_US.UTF-8', 16:22:10 INFO - 'LANGUAGE': 'en_US:en', 16:22:10 INFO - 'LOGNAME': 'cltbld', 16:22:10 INFO - 'MAIL': '/var/mail/cltbld', 16:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:10 INFO - 'MOZ_NO_REMOTE': '1', 16:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:10 INFO - 'NO_EM_RESTART': '1', 16:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:10 INFO - 'PWD': '/builds/slave/test', 16:22:10 INFO - 'SHELL': '/bin/bash', 16:22:10 INFO - 'SHLVL': '1', 16:22:10 INFO - 'TERM': 'linux', 16:22:10 INFO - 'TMOUT': '86400', 16:22:10 INFO - 'USER': 'cltbld', 16:22:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467931322.140484-755944837', 16:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:10 INFO - '_': '/tools/buildbot/bin/python'} 16:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:22:10 INFO - Cleaning up... 16:22:10 INFO - Return code: 0 16:22:10 INFO - Running post-action listener: _resource_record_post_action 16:22:10 INFO - Running post-action listener: _start_resource_monitoring 16:22:10 INFO - Starting resource monitoring. 16:22:10 INFO - ##### 16:22:10 INFO - ##### Finished create-virtualenv step (success) 16:22:10 INFO - ##### 16:22:10 INFO - ##### 16:22:10 INFO - ##### Running install step. 16:22:10 INFO - ##### 16:22:10 INFO - Running pre-action listener: _resource_record_pre_action 16:22:10 INFO - Running main action method: install 16:22:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:22:11 INFO - Reading from file tmpfile_stdout 16:22:11 INFO - Detecting whether we're running mozinstall >=1.0... 16:22:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:22:11 INFO - Reading from file tmpfile_stdout 16:22:11 INFO - Output received: 16:22:11 INFO - Usage: mozinstall [options] installer 16:22:11 INFO - Options: 16:22:11 INFO - -h, --help show this help message and exit 16:22:11 INFO - -d DEST, --destination=DEST 16:22:11 INFO - Directory to install application into. [default: 16:22:11 INFO - "/builds/slave/test"] 16:22:11 INFO - --app=APP Application being installed. [default: firefox] 16:22:11 INFO - mkdir: /builds/slave/test/build/application 16:22:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:22:28 INFO - Reading from file tmpfile_stdout 16:22:28 INFO - Output received: 16:22:28 INFO - /builds/slave/test/build/application/firefox/firefox 16:22:28 INFO - Running post-action listener: _resource_record_post_action 16:22:28 INFO - ##### 16:22:28 INFO - ##### Finished install step (success) 16:22:28 INFO - ##### 16:22:28 INFO - ##### 16:22:28 INFO - ##### Running run-tests step. 16:22:28 INFO - ##### 16:22:28 INFO - Running pre-action listener: _resource_record_pre_action 16:22:28 INFO - Running main action method: run_tests 16:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:22:28 INFO - Python 2.7.3 16:22:28 INFO - Return code: 0 16:22:28 INFO - grabbing minidump binary from tooltool 16:22:28 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')]} 16:22:28 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 0xf603b0>, '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 0xf612b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf61740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:22:28 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 16:22:28 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 16:22:28 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 16:22:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:22:28 INFO - Return code: 0 16:22:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:22:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:22:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:22:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:22:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:22:28 INFO - Using env: {'DISPLAY': ':0', 16:22:28 INFO - 'HOME': '/home/cltbld', 16:22:28 INFO - 'LANG': 'en_US.UTF-8', 16:22:28 INFO - 'LANGUAGE': 'en_US:en', 16:22:28 INFO - 'LOGNAME': 'cltbld', 16:22:28 INFO - 'MAIL': '/var/mail/cltbld', 16:22:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:22:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:28 INFO - 'MOZ_NO_REMOTE': '1', 16:22:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:28 INFO - 'NO_EM_RESTART': '1', 16:22:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:28 INFO - 'PWD': '/builds/slave/test', 16:22:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:22:28 INFO - 'SHELL': '/bin/bash', 16:22:28 INFO - 'SHLVL': '1', 16:22:28 INFO - 'TERM': 'linux', 16:22:28 INFO - 'TMOUT': '86400', 16:22:28 INFO - 'USER': 'cltbld', 16:22:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467931322.140484-755944837', 16:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:28 INFO - '_': '/tools/buildbot/bin/python'} 16:22:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:22:28 INFO - mozversion application_buildid: 20160707133059 16:22:28 INFO - mozversion application_changeset: 752282c3e152f3c56de2c66dd56cb05e79b05807 16:22:28 INFO - mozversion application_display_name: Nightly 16:22:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:22:28 INFO - mozversion application_name: Firefox 16:22:28 INFO - mozversion application_remotingname: firefox 16:22:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:22:28 INFO - mozversion application_vendor: Mozilla 16:22:28 INFO - mozversion application_version: 50.0a1 16:22:28 INFO - mozversion platform_buildid: 20160707133059 16:22:28 INFO - mozversion platform_changeset: 752282c3e152f3c56de2c66dd56cb05e79b05807 16:22:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:22:28 INFO - mozversion platform_version: 50.0a1 16:22:28 INFO - using testdate: 1467933748 16:22:28 INFO - actual date: 1467933748 16:22:28 INFO - starting webserver on 'localhost:59770' 16:22:28 INFO - SUITE-START | Running 2 tests 16:22:28 INFO - TEST-START | dromaeo_css 16:22:28 INFO - operating with platform_type : linux_ 16:22:28 INFO - Initialising browser for dromaeo_css test... 16:22:28 INFO - TEST-INFO | started process 29640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsCcNX6/profile http://localhost:59770/getInfo.html) 16:22:32 INFO - PROCESS | 29640 | __metrics Screen width/height:1600/1200 16:22:32 INFO - PROCESS | 29640 | colorDepth:24 16:22:32 INFO - PROCESS | 29640 | Browser inner width/height: 1024/697 16:22:32 INFO - PROCESS | 29640 | __metrics 16:22:33 INFO - PROCESS | 29640 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:22:34 INFO - TEST-INFO | 29640: exit 0 16:22:34 INFO - Browser initialized. 16:22:34 INFO - Running cycle 1/1 for dromaeo_css test... 16:22:34 INFO - TEST-INFO | started process 29725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsCcNX6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:22:46 INFO - PROCESS | 29725 | RSS: Main: 156360704 16:22:46 INFO - PROCESS | 29725 | 16:23:37 INFO - PROCESS | 29725 | 1467933817343 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] 16:25:46 INFO - PROCESS | 29725 | Cycle 1(1): loaded http://localhost:59770/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59770/tests/dromaeo/cssquery-ext.html) 16:25:47 INFO - PROCESS | 29725 | RSS: Main: 278712320 16:25:47 INFO - PROCESS | 29725 | 16:28:50 INFO - PROCESS | 29725 | Cycle 1(1): loaded http://localhost:59770/tests/dromaeo/cssquery-ext.html (next: http://localhost:59770/tests/dromaeo/cssquery-jquery.html) 16:28:50 INFO - PROCESS | 29725 | RSS: Main: 241627136 16:28:50 INFO - PROCESS | 29725 | 16:31:52 INFO - PROCESS | 29725 | Cycle 1(1): loaded http://localhost:59770/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59770/tests/dromaeo/cssquery-mootools.html) 16:31:53 INFO - PROCESS | 29725 | RSS: Main: 237522944 16:31:53 INFO - PROCESS | 29725 | 16:34:55 INFO - PROCESS | 29725 | Cycle 1(1): loaded http://localhost:59770/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59770/tests/dromaeo/cssquery-prototype.html) 16:34:56 INFO - PROCESS | 29725 | RSS: Main: 237096960 16:34:56 INFO - PROCESS | 29725 | 16:37:58 INFO - PROCESS | 29725 | Cycle 1(1): loaded http://localhost:59770/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59770/tests/dromaeo/cssquery-yui.html) 16:37:59 INFO - PROCESS | 29725 | RSS: Main: 224841728 16:37:59 INFO - PROCESS | 29725 | 16:41:02 INFO - PROCESS | 29725 | Cycle 1(1): loaded http://localhost:59770/tests/dromaeo/cssquery-yui.html (next: http://localhost:59770/tests/dromaeo/cssquery-dojo.html) 16:41:02 INFO - PROCESS | 29725 | RSS: Main: 280289280 16:41:02 INFO - PROCESS | 29725 | 16:41:02 INFO - PROCESS | 29725 | __start_tp_report 16:41:02 INFO - PROCESS | 29725 | _x_x_mozilla_page_load 16:41:02 INFO - PROCESS | 29725 | _x_x_mozilla_page_load_details 16:41:02 INFO - PROCESS | 29725 | |i|pagename|runs| 16:41:02 INFO - PROCESS | 29725 | |0;dojo.html;3055.3889222155567;3076.061801150648;3099.473089574772;3103.689631036895;3120.6879312068795;5258.92111618326;5352.411234764178;5370.301860758096;5423.078076726956;5487.149491828763;5338.973305133469;5374.355077390709;5404.378496472907;5417.160340147274;5429.429909859467;4806.519348065201;4811.037792441508;4819.445763737162;4880.902381952359;5081.1108056090225;4992.350994370745;5020.196768517038;5041.369828771403;5051.621128415365;5056.6713163644245;4766.594839438651;4811.254255590389;4845.733484658343;4862.805487780484;4948.851534453954;4876.561109500162;4881.243407271879;4881.755912204376;4945.727984960826;4964.05682920244;4876.390451193601;4912.828051018233;4928.063667903087;4947.777350019258;4952.108620448354;5235.1623740201385;5348.064088784447;5468.863278418032;5484.945150548483;5489.972550137264;5833.7083145842535;5836.095405212156;5879.617824841372;5889.411058894119;5890.204822348971;5866.178734977107;5894.410558944114;5940.702964851784;5941.376155503696;5949.643021418686;5279.6832190068335;5309.415964243892;5363.517283444508;5378.784848606012;5498.202760599731;5908.350081491032;5937.376575459601;5937.970310148508;5947.434993675594;5961.552883533665;5695.174199741097;5711.657300561979;5745.712714364265;5749.913751293734;5755.740991655385;5547.11246200606;5672.602917795714;5735.283089613798;5742.54059675225;5814.825555233349;5726.226959360433;5737.942620573741;5742.511886489611;5747.5689323300085;5750.1949727038245;5694.544436445074;5738.167965644958;5751.079827227707;5752.827415177551;5754.510866576305;4253.659707223414;4335.956640433618;4336.934945975813;4381.7151885128005;4421.248387774086;3930.901727456779;3936.488256526633;3938.5076865391825;3967.821448034845;3973.205358928226;5588.944110558842;5590.5527557796095;5591.077472217039;5593.272874526286;5644.32268127819;5673.631213971079;5775.451332123442;5830.883382332329;5873.823785286449;5926.199963005025;5585.888282234332;5592.944070559323;5594.272744543184;5596.440355964371;5634.549236061187;5061.645684802029;5067.189249720101;5072.442031376546;5075.467075957045;5121.692698438105;5770.5095066919785;5967.224260846149;6010.519158467225;6024.277086749618;6097.054956481752;5812.738426770721;5831.212786273968;5831.7375718093635;5845.649261044351;5846.444587764156;6054.39456054391;6071.605345652519;6076.817695469143;6078.270607527125;6078.969605151946;5473.616846820684;5691.345495267931;5696.088625819849;5747.339056008613;5804.65172089676;5897;5897.262842144732;5898.793542226002;5901.439363260483;5904.409559044061;5528.612997090326;5748.080307150836;5763.4812866842185;5767.221425107557;5767.971160144172;5618.971905140448;5651.095824668033;5684.175794509855;5711.400302968294;5717.056685646821;5635.211070450058;5655.321361436654;5661.264035675335;5661.971690141523;5664.801731939362;5534.916976245279;5568.359638641608;5727.7422515986045;5730.025895597675;5739.8852022960145;5407.864803379947;5409.323834520685;5474.863128421821;5508.697021663847;5547.306586676666 16:41:02 INFO - PROCESS | 29725 | |1;ext.html;593.525179856115;613.4233820209004;616.6731632234917;639.7281155508907;640.2860810196629;31114.53328200076;43707.12585748283;44482.11035779282;44773.328400074024;44866;46492.53507464924;46615.76692116535;46812;46907.29639055417;47021.29468057982;8907.109289071106;9127.908720912772;9139.177474027336;9140.223081038086;9141.314401419886;9021.233195178418;9092.954535227347;9098.135677110664;9116.58975346111;9118.908810911873;9157.679481218158;9170.724878253663;9184.989651138369;9196;9207.217386522154;9113.043130471304;9133.315001374856;9166.450012999174;9167.679131230376;9168.999999999933;9009.684661036898;9092.318076144249;9092.636294548276;9096.1813436791;9096.909030909672;43569;43924;43948.340774888406;43948.56051439477;43968.78015609901;3486.89539313821;3685.539307586552;4148.937765933513;4229.513605935326;4439.200943830109;32836.34327313464;33552.63815703967;33988.32023359519;34063.829680851435;34068;4485.506594274627;4595.103954728829;4737.218358970766;4752;4760.880977975544;358906;360254;360526.9999999974;360791;362270;60277.09584356238;61004.694976524836;61042.084368734504;61046.38953610407;61080;64239.67880160663;64329.678351607945;64462.033069503996;64483;64607.67696161489;17594.91202543979;17831.59273498087;17831.910840445715;17837.910810445865;17841;13581.660458488419;13622.591322260349;13677.179369237678;13677.658058548417;13678.384472698752;15829.14251346838;18855.151518181716;18987.71518427225;19110.808891910903;19285.4214373569;5505.889882202334;6303.630527781774;6677.833054173588;6734.326567343324;6838.965805170942;1006.2905651515664;1032.8347464405808;1036.6216331039116;1056.9154467642725;1131.2025022359217;33737.32525349479;34028;34523.482147767805;34706.652933470345;34975.475367869505;1080.222239987208;1100.5927806711568;1112.0214211493833;1155.96532104037;1176.9823452648218;17223.56941076458;17870.821291786917;17899.463016109537;18036.90981545084;18050.548736281697;516248;519518;520344;520530;521554;59813;60674;60723;60819.391806082254;60824;1195.2947760821157;1325.2975922760952;1354.2686949047404;1405.6907480354305;1471.3158381352723;31116.377672446877;35648.475907104636;35797.64202357943;35856.4621530672;36033.81983090068;54288;54880.451195487534;55339.44660553343;55475.72262138664;55494.44505554893;527008;527565;531716;533959;540684;37368.25263494769;39500.604993949695;41832.79083604563;46020.539794601624;50406.49593504165;50279;50411.49588504068;51223.231651526;51469.742651286506;52355.738221310174;42355.576444235165;42535.787321063195;43381;43436.78281608572;44553;41945.37081943712;43620.84815540149;43801.34297985597;45738;46000;42838.78580607202;43388.34917476303;43874;44196.55803441924;44367;36307.45538816867;38577.421338680506;38877;39276.607233927294;39435.60564394434;29121.85439072791;29248.89382182716;29489.262768430104;29670.774691898627;29755.851220743756 16:41:02 INFO - PROCESS | 29725 | |2;jquery.html;376.41843352021107;384.6000159833772;390.7753042000849;399.1458279282335;405.99188016239674;18085.457436276898;19653.606927861434;20915.163393464263;20918.581628367425;20954.790452095476;11973.940130299357;12527.060470464728;12562.30907300098;12745;19856.20575176991;5387.649802762818;5481.643693159952;5511.614187006911;5536.446355364472;5540.584456165783;3962.5046869141356;4701.670883038189;6753.324667533232;6762.966185169067;6880.277570855038;6317.747290108413;6807.387335139836;6819.693113809891;6845.623490708009;6867.313268673118;6187.443130118311;6216;6216.937830621681;6223.159873417076;6225.19072520574;3861.613838616144;5563.332400112013;5867.178594996704;5868.677222752747;5870;13687.657808554766;13773.173609583357;14020.789688154584;14524.273786310749;14578;2509.510645424143;2581.7031041430287;2610.451805120927;2792.274008757717;3065.2796592800896;9603.807923841485;9739.172170365528;10305.84541231882;11469.082473402108;14141.29293535319;1913.9234430622757;1967.4687834284664;1968.7932767059397;1974.5853370792152;1978.99010504948;81169.59415202886;82833.58583207105;83272.58363708142;84876;85132.99999999937;10673.146148308117;10850.728731781768;10880.836787448194;10885.564577416815;11295.49170287339;15120.773188402183;15184.544463666107;15198.240087995557;15236.771448428282;15267.083974961537;7885.29032387088;8174.182581741778;8175.100738918714;8249.958750206331;8342.207490288412;7819.139894611588;7860.135385107634;7972.641231144612;8036.557989310527;8100.149484304181;4626.930596041062;4644.558766917205;4695.741734204652;4756.643251756063;4781.2350023996;1935.5838494723703;1944.5041514413733;1987.9900600497194;1989.6717041688248;1998.8400927925732;945.2626950978248;981.6662334806057;998.3011891675856;1020.6682828080903;1074.7689246811974;20204.29284975019;20504.282350117675;20651.69022464664;20798.79201207999;20805.54181098466;989.7525618595351;1019.8062368150028;1024.8975102489692;1027.9486025698834;1033.0289527843802;10645.574177032986;11318.151138664633;11374.545018199346;11378.772424551627;11397.316161030365;352654;356547;356762.8647427037;447543;491184;101180.49409752904;102674.48662756638;104326.95673043324;108620;109978;888.4314039015036;912.6714382822179;936.6628013914985;941.2564074381299;942.7925856311738;15310;17125.743113853052;17207.483775486755;17699.469015929542;18164.545886352946;43588.34617480677;44263.55736442594;44841.77579112214;45028.77485612551;45158;62060;62662.373376265656;63157.68421157865;63732.68133659302;63755.362446374944;8184.672613095409;8466.534340611326;8506.532140732319;8531.274841638531;8554.57227138653;12711.237325760483;13284.933575332061;13430.529931452353;13688.589342319747;13913.930430347784;11777.764444711229;12045.156839021185;12133.69665758363;12182.852252314884;12191.695207619881;11648.068154547786;11723.41382930867;11773.529058837894;11854.881451185378;12008.279503229835;11624.767504650028;11708.765824683629;12121.333326667118;12224;12360.567380141652;7556.6977320908745;8068.314193293636;8166;8441.662333506836;8620.956895215484;8879;11542.942285288857;12360.690982725504;12431.254124752544;12710.618681439571 16:41:02 INFO - PROCESS | 29725 | |3;mootools.html;1339.343721576428;1421.6943357178209;1466.963325916852;1562.9609259768504;1749.8687598430113;8260;8672.566371681407;8684.348673849463;8878.067802880701;8912.955435222815;8616.569171541414;8802.427842190253;8826.382153249258;8828.60271287792;8829.867551986725;1893.8579606529497;2070.0891607692565;2145.0668959002883;2179.9891000545013;2205.7904499072642;2212.623853944833;2215.091812356934;2217.135317226283;2217.667349897512;2219.4451387153213;2177.2597316912247;2191.6931629571873;2198.2635817001324;2198.890055497219;2200.3179014505477;1861.571838477151;2029.8071683190074;2100.6218880601486;2108.673155660875;2109.177420805879;2101.464126647695;2112.8098471137673;2115.7355330583678;2134.0396821430263;2134.7438307403054;8752.21230089295;8817.911820881838;8862.512561809099;8866.645334186625;8871;5027.622928280393;5138;5166.147585648364;5179.792808287664;5214.270002199695;3249.252671885456;3269.346130773855;3316.1046517440395;3325.068980685388;3370.679785420381;1065.0999905080196;1067.6850329152842;1069.417167643636;1087.8259478483405;1090.6837017264984;12081.15431919766;12084.939575302067;12085.214461060003;12107.152499325051;12129.21160124589;4347.260965635849;4422.447194100738;4505.774711264424;4550.863474095782;4552.476465206478;9869.555869985868;9940.055694708992;9946.055124763281;9954.153896918699;10106.646267380607;5212.50481204285;5214.0875346814155;5243.475652434802;5247.02929957959;5248.448912864171;4106.3635136553885;4532.184206842734;4650.790714417859;4651.418572678415;4737.313089601988;3708.8887333380044;3819.083419979185;3823.2735780201674;3845.538535375717;3878.7090968176935;1070.4166229404993;1189.6490535291937;1224.9265044097383;1240.2186622427812;1245.582729785532;906.1559725957776;937.1752857485369;978.2907392140642;982.3025651787168;1021.7139201023725;6130.877382452415;6130.908036379458;6277.372262773777;6283.937160628427;6312.116303717483;980.6224603527551;981.9901800982042;988.6687959533637;1008.7629407089328;1077.8383242513685;4229.978850105791;4301.720388174758;4362.890927726832;4371.256886329332;4371.431713877176;10620.362778233331;10848.511816968256;10966;11007.339559626447;11021.944890275658;10819.83770243447;10823.567057317776;10843.945780271206;10851.457427128613;10851.620193293196;7801.102873169544;7887.566183859943;8056.718014869569;8082.595870206466;8276.83446331082;6178.135061091541;6364.5863018905475;6430.453411460078;6454.386833250834;6468.15913931186;10069.748256293651;10167.542460589439;10319.380837149794;10364.533595988049;10398.168146548107;10184.949075254577;10453.581856725647;10671.46642667848;10672.83990740124;10675.733106672395;7822.9608851957655;7931.920680793118;7945.8808117879435;7952.36381089523;7984.401169912164;8572.742817715478;8575.485470871768;8599.484030958163;8606.65573377058;8614.267787238156;7491.70033198666;7725.49784264021;7744.535327880345;7760.68957241704;7799.883001754864;7450.180480147071;7678.078630564368;7736.342410895137;7817.804554886174;7846.254605812439;6904.4131248844415;6912.758053468105;6968.965155174192;6978;6979.895301570582;5262.368515778131;5285.365756109138;5375.973120134374;5432.103702889137;5473.124300111963;5492.505674489315;5572.860678482908;5589.077802162597;5668.801591944262;5729.742161602821 16:41:02 INFO - PROCESS | 29725 | |4;prototype.html;316.817829747895;324.9317643294908;325.6515528384629;325.8875687887678;332.413290542193;5167.354080739908;5217.295665085212;5226.014114636438;5235.240890070937;5269.446708095652;5157.664751791131;5217.113090774568;5244.213367994803;5244.39689435715;5245.31810864588;3929.607039296062;3957.5844536323702;4102.0360215349365;4131.8967025824295;4146.481689788777;4087.979560102195;4106.38404239365;4123.546409894909;4124.443200167984;4128.3601041838565;3929.1945151243926;4062.045419326456;4069.3489041753323;4080.8571699990507;4119.732217405874;3968.9085501487034;4048.696347773914;4077.408775727503;4095.221907837531;4098.918021639581;3625.6374362563797;3633.582138054131;3641.1625326175126;3643.0528062703625;3646.690031347339;5150.407703114152;5170.095233334189;5176.171812509981;5180.300659410969;5197.66105252634;4447.466304043535;4655.301704744282;4655.4180727409075;4686.250199967989;4698.741569213692;5480.246321177225;5507.476789704971;5519.503244707996;5533.916991245134;5534.169874518854;3954.960450395488;3964.762114273124;3983.342748446503;3990.1620659661216;4003.5987404408515;5485.6982865942355;5594.636348637326;5617.747201375948;5622.297212848394;5640.802571910004;3965.3457179565626;3972.205558888234;4002.399640054015;4036.4550785643564;4038.7778672172726;4080.9795951020055;4084.5098588169017;4090.0592863640936;4095.85664501747;4097.959020409818;4581.5647513486165;4594.931076033862;4616.792244349012;4637.721736695809;4678.69588476748;5493.615446918758;5502.752376143083;5514.255575497336;5541.476094074082;5544.556435485151;1387.854275301099;1405.3465138710344;1407.908870625253;1409.3516982188307;1411.2238268952035;883.5405589093635;900.7793090692691;901.5395060002837;917.5320586500933;945.952702364879;5239.240310155006;5289.259503669489;5315.654482458628;5331.760070796823;5333.280007198979;5517.751701173457;5536.723163841792;5536.833894983157;5548.805791797267;5561.944380556223;5117.8464646060675;5249.895002099936;5273.419923808378;5288.576913846883;5436.184572314184;2987.775916806248;2988.4321978824387;2990.357073229266;2999.145243605562;3023.3953209358215;5851.590388672837;5856.677882716406;5866.73599688015;5894.498967587718;5896.705164741831;5507.7246137692955;5682.232898558725;5700.857478563069;5707.74315155819;5712.942870571241;5782.340123543133;5802.767889284466;5804.519847438876;5851.1515830205235;5918;5443.863903402446;5616.494515493625;5652.749668940293;5658.528782516493;5712.742926568231;5568.997580435561;5590.2670172246735;5596.572873917288;5605.439456054362;5612.298462692163;5840.853978650568;5849.853753656193;5855.648661080349;5859.882802343844;5881.853038657421;3866.188100498814;3962.5046869141356;3978.2043591282436;3992.2414741199077;3996.2806694795217;5433.864153396196;5619.578531610064;5667.914981275202;5676.091825308096;5690.719588092646;5424.783008679608;5502.504774570308;5527.640703354269;5529.751161197836;5535.861603459945;5413.566914646897;5477.561795056306;5481.945180548303;5485.533729633026;5498.350494851448;5205.92191117126;5378.731063446734;5408.405075441777;5437.67373957548;5438.945610543844;5503.3395992481155;5518.586106041983;5521.889562208814;5522;5535.260046277119;5396.811111611075;5408.404520666491;5425.077736784677;5453.291072160594;5475.890482190413 16:41:02 INFO - PROCESS | 29725 | |5;yui.html;738.7672883041845;762.416751185343;780.5160800303812;818.7502811642448;822.5887056471767;15982.600434989117;16091.114988675617;16635.50093497194;16647.83352166478;16697.49907502774;15284;15295.082295062304;15472;15524.767128493082;15539.37842486302;676.6549059979421;806.5684858600664;807.4509333653114;815.5066184958074;821.2321479416764;823.1768231768232;823.5347028928636;823.6293667849492;826.5164878546028;827.9006519217702;841.2975165736617;843.0684094076049;843.4096132707099;843.6920524008723;844.4764246167384;681.7988693335453;833.6832003838533;851.3359579527978;851.9446235994671;857.6697971281039;624.4598422364668;624.7688355308564;624.7813265357089;624.8781487609917;625.5058503782006;14315.498957536436;14386.496472623408;14397;14434.133951962916;14471.710565788731;14439.278036098152;14782.334794934253;14792.556223313319;14827.703445931129;15078.773818392732;13076.934615326958;13344.399502022432;13504.392302346418;13568.932155339258;13607;4514.119746649405;4541.72749635023;4564.680472366936;4618.122556714247;4763.190257656207;78088.8286675706;78144;78399.6080019602;78618.30604640911;79625.60187199085;10793.29843560166;11111;11159;11204.103671706243;11240.156988225915;18669.626607467773;18752.812471875106;18902.243910243436;19670.901645491966;19734.70397944032;8507.404481686222;8529.829403411897;8756.912430875609;8908.688195913111;8967.148120928501;4424.159409712144;4529.84145554904;4549.385832912514;4573.199690054227;4763.976180119077;3413.453847384407;3498.3003399320237;3522.577290725078;3526.8412921418085;3526.8765593204116;594.7556081574998;601.4616917858492;602.9969850150721;608.7047781825811;608.7291155435877;612.0604871522193;670.2158474584747;680.43863812355;712.1738783011785;721.8195451137216;9495.24038076966;9525.237980961507;9645.614175433044;9713.61145554184;9760.560774765152;681.7988693335478;692.6640579319027;699.1435491522844;702.1749444402807;709.8686742952467;4405.647548196137;4523.660725445605;4588.3805686231935;4597;4791.089692958327;108884;114711.42644286725;115431.42284288525;119049;119261;86390;86700;86756;102248;104613.47693261637;73842.26157738462;87633;87907;88332.5583372079;90643.54678226566;9707.514624268617;9989.750256243362;10007.54966026516;10029.247806414402;10185.236107291834;53371.466285336646;53420.46579534155;53676.46323536715;53775.19337209867;55206.44793552013;67672.6616366915;78375.60812196131;78594.60702696678;78677;80291.59854200692;13187.208767473981;13342.132761370867;13382.397792099573;13392.330383480592;13399.83755960706;14691.55925322242;14985;15005.32476038559;15104.244787760788;15325;13680;13877;14008.78986815219;14152.646183845487;14470.131792092508;14164.504242351468;14212.928935355258;14355.138691678532;14372.640683982983;15045.322960466587;11227.7754444909;11726.355050472306;12852.421641025989;13267.33663316811;13594.86405135936;11349.432528373383;11704.531818727155;11775.470103845519;11933.582324618597;12153.635390938285;11268.873112688665;11524.596639117926;11842.314417421741;11889.28664280146;11931.224470409396 16:41:02 INFO - PROCESS | 29725 | __end_tp_report 16:41:02 INFO - PROCESS | 29725 | __start_cc_report 16:41:02 INFO - PROCESS | 29725 | _x_x_mozilla_cycle_collect,1115 16:41:02 INFO - PROCESS | 29725 | __end_cc_report 16:41:02 INFO - PROCESS | 29725 | __startTimestamp1467934862526__endTimestamp 16:41:02 INFO - PROCESS | 29725 | 16:41:02 INFO - PROCESS | 29725 | ------- Summary: start ------- 16:41:02 INFO - PROCESS | 29725 | Number of tests: 6 16:41:02 INFO - PROCESS | 29725 | 16:41:02 INFO - PROCESS | 29725 | [#0] dojo.html Cycles:165 Average:5390.75 Median:5596.44 stddev:629.82 (11.3%) stddev-sans-first:604.52 16:41:02 INFO - PROCESS | 29725 | Values: 3055.4 3076.1 3099.5 3103.7 3120.7 5258.9 5352.4 5370.3 5423.1 5487.1 5339.0 5374.4 5404.4 5417.2 5429.4 4806.5 4811.0 4819.4 4880.9 5081.1 4992.4 5020.2 5041.4 5051.6 5056.7 4766.6 4811.3 4845.7 4862.8 4948.9 4876.6 4881.2 4881.8 4945.7 4964.1 4876.4 4912.8 4928.1 4947.8 4952.1 5235.2 5348.1 5468.9 5484.9 5490.0 5833.7 5836.1 5879.6 5889.4 5890.2 5866.2 5894.4 5940.7 5941.4 5949.6 5279.7 5309.4 5363.5 5378.8 5498.2 5908.4 5937.4 5938.0 5947.4 5961.6 5695.2 5711.7 5745.7 5749.9 5755.7 5547.1 5672.6 5735.3 5742.5 5814.8 5726.2 5737.9 5742.5 5747.6 5750.2 5694.5 5738.2 5751.1 5752.8 5754.5 4253.7 4336.0 4336.9 4381.7 4421.2 3930.9 3936.5 3938.5 3967.8 3973.2 5588.9 5590.6 5591.1 5593.3 5644.3 5673.6 5775.5 5830.9 5873.8 5926.2 5585.9 5592.9 5594.3 5596.4 5634.5 5061.6 5067.2 5072.4 5075.5 5121.7 5770.5 5967.2 6010.5 6024.3 6097.1 5812.7 5831.2 5831.7 5845.6 5846.4 6054.4 6071.6 6076.8 6078.3 6079.0 5473.6 5691.3 5696.1 5747.3 5804.7 5897.0 5897.3 5898.8 5901.4 5904.4 5528.6 5748.1 5763.5 5767.2 5768.0 5619.0 5651.1 5684.2 5711.4 5717.1 5635.2 5655.3 5661.3 5662.0 5664.8 5534.9 5568.4 5727.7 5730.0 5739.9 5407.9 5409.3 5474.9 5508.7 5547.3 16:41:02 INFO - PROCESS | 29725 | 16:41:02 INFO - PROCESS | 29725 | [#1] ext.html Cycles:180 Average:64294.06 Median:24403.10 stddev:126479.10 (518.3%) stddev-sans-first:126743.48 16:41:02 INFO - PROCESS | 29725 | Values: 593.5 613.4 616.7 639.7 640.3 31114.5 43707.1 44482.1 44773.3 44866.0 46492.5 46615.8 46812.0 46907.3 47021.3 8907.1 9127.9 9139.2 9140.2 9141.3 9021.2 9093.0 9098.1 9116.6 9118.9 9157.7 9170.7 9185.0 9196.0 9207.2 9113.0 9133.3 9166.5 9167.7 9169.0 9009.7 9092.3 9092.6 9096.2 9096.9 43569.0 43924.0 43948.3 43948.6 43968.8 3486.9 3685.5 4148.9 4229.5 4439.2 32836.3 33552.6 33988.3 34063.8 34068.0 4485.5 4595.1 4737.2 4752.0 4760.9 358906.0 360254.0 360527.0 360791.0 362270.0 60277.1 61004.7 61042.1 61046.4 61080.0 64239.7 64329.7 64462.0 64483.0 64607.7 17594.9 17831.6 17831.9 17837.9 17841.0 13581.7 13622.6 13677.2 13677.7 13678.4 15829.1 18855.2 18987.7 19110.8 19285.4 5505.9 6303.6 6677.8 6734.3 6839.0 1006.3 1032.8 1036.6 1056.9 1131.2 33737.3 34028.0 34523.5 34706.7 34975.5 1080.2 1100.6 1112.0 1156.0 1177.0 17223.6 17870.8 17899.5 18036.9 18050.5 516248.0 519518.0 520344.0 520530.0 521554.0 59813.0 60674.0 60723.0 60819.4 60824.0 1195.3 1325.3 1354.3 1405.7 1471.3 31116.4 35648.5 35797.6 35856.5 36033.8 54288.0 54880.5 55339.4 55475.7 55494.4 527008.0 527565.0 531716.0 533959.0 540684.0 37368.3 39500.6 41832.8 46020.5 50406.5 50279.0 50411.5 51223.2 51469.7 52355.7 42355.6 42535.8 43381.0 43436.8 44553.0 41945.4 43620.8 43801.3 45738.0 46000.0 42838.8 43388.3 43874.0 44196.6 44367.0 36307.5 38577.4 38877.0 39276.6 39435.6 29121.9 29248.9 29489.3 29670.8 29755.9 16:41:02 INFO - PROCESS | 29725 | 16:41:02 INFO - PROCESS | 29725 | [#2] jquery.html Cycles:180 Average:26933.11 Median:2701.36 stddev:67962.31 (2515.9%) stddev-sans-first:68123.71 16:41:02 INFO - PROCESS | 29725 | Values: 376.4 384.6 390.8 399.1 406.0 18085.5 19653.6 20915.2 20918.6 20954.8 11973.9 12527.1 12562.3 12745.0 19856.2 5387.6 5481.6 5511.6 5536.4 5540.6 3962.5 4701.7 6753.3 6763.0 6880.3 6317.7 6807.4 6819.7 6845.6 6867.3 6187.4 6216.0 6216.9 6223.2 6225.2 3861.6 5563.3 5867.2 5868.7 5870.0 13687.7 13773.2 14020.8 14524.3 14578.0 2509.5 2581.7 2610.5 2792.3 3065.3 9603.8 9739.2 10305.8 11469.1 14141.3 1913.9 1967.5 1968.8 1974.6 1979.0 81169.6 82833.6 83272.6 84876.0 85133.0 10673.1 10850.7 10880.8 10885.6 11295.5 15120.8 15184.5 15198.2 15236.8 15267.1 7885.3 8174.2 8175.1 8250.0 8342.2 7819.1 7860.1 7972.6 8036.6 8100.1 4626.9 4644.6 4695.7 4756.6 4781.2 1935.6 1944.5 1988.0 1989.7 1998.8 945.3 981.7 998.3 1020.7 1074.8 20204.3 20504.3 20651.7 20798.8 20805.5 989.8 1019.8 1024.9 1027.9 1033.0 10645.6 11318.2 11374.5 11378.8 11397.3 352654.0 356547.0 356762.9 447543.0 491184.0 101180.5 102674.5 104327.0 108620.0 109978.0 888.4 912.7 936.7 941.3 942.8 15310.0 17125.7 17207.5 17699.5 18164.5 43588.3 44263.6 44841.8 45028.8 45158.0 62060.0 62662.4 63157.7 63732.7 63755.4 8184.7 8466.5 8506.5 8531.3 8554.6 12711.2 13284.9 13430.5 13688.6 13913.9 11777.8 12045.2 12133.7 12182.9 12191.7 11648.1 11723.4 11773.5 11854.9 12008.3 11624.8 11708.8 12121.3 12224.0 12360.6 7556.7 8068.3 8166.0 8441.7 8621.0 8879.0 11542.9 12360.7 12431.3 12710.6 16:41:02 INFO - PROCESS | 29725 | 16:41:02 INFO - PROCESS | 29725 | [#3] mootools.html Cycles:180 Average:5795.20 Median:4601.63 stddev:3325.45 (72.3%) stddev-sans-first:3317.92 16:41:02 INFO - PROCESS | 29725 | Values: 1339.3 1421.7 1467.0 1563.0 1749.9 8260.0 8672.6 8684.3 8878.1 8913.0 8616.6 8802.4 8826.4 8828.6 8829.9 1893.9 2070.1 2145.1 2180.0 2205.8 2212.6 2215.1 2217.1 2217.7 2219.4 2177.3 2191.7 2198.3 2198.9 2200.3 1861.6 2029.8 2100.6 2108.7 2109.2 2101.5 2112.8 2115.7 2134.0 2134.7 8752.2 8817.9 8862.5 8866.6 8871.0 5027.6 5138.0 5166.1 5179.8 5214.3 3249.3 3269.3 3316.1 3325.1 3370.7 1065.1 1067.7 1069.4 1087.8 1090.7 12081.2 12084.9 12085.2 12107.2 12129.2 4347.3 4422.4 4505.8 4550.9 4552.5 9869.6 9940.1 9946.1 9954.2 10106.6 5212.5 5214.1 5243.5 5247.0 5248.4 4106.4 4532.2 4650.8 4651.4 4737.3 3708.9 3819.1 3823.3 3845.5 3878.7 1070.4 1189.6 1224.9 1240.2 1245.6 906.2 937.2 978.3 982.3 1021.7 6130.9 6130.9 6277.4 6283.9 6312.1 980.6 982.0 988.7 1008.8 1077.8 4230.0 4301.7 4362.9 4371.3 4371.4 10620.4 10848.5 10966.0 11007.3 11021.9 10819.8 10823.6 10843.9 10851.5 10851.6 7801.1 7887.6 8056.7 8082.6 8276.8 6178.1 6364.6 6430.5 6454.4 6468.2 10069.7 10167.5 10319.4 10364.5 10398.2 10184.9 10453.6 10671.5 10672.8 10675.7 7823.0 7931.9 7945.9 7952.4 7984.4 8572.7 8575.5 8599.5 8606.7 8614.3 7491.7 7725.5 7744.5 7760.7 7799.9 7450.2 7678.1 7736.3 7817.8 7846.3 6904.4 6912.8 6969.0 6978.0 6979.9 5262.4 5285.4 5376.0 5432.1 5473.1 5492.5 5572.9 5589.1 5668.8 5729.7 16:41:02 INFO - PROCESS | 29725 | 16:41:02 INFO - PROCESS | 29725 | [#4] prototype.html Cycles:180 Average:4626.45 Median:5288.92 stddev:1362.13 (25.8%) stddev-sans-first:1326.98 16:41:02 INFO - PROCESS | 29725 | Values: 316.8 324.9 325.7 325.9 332.4 5167.4 5217.3 5226.0 5235.2 5269.4 5157.7 5217.1 5244.2 5244.4 5245.3 3929.6 3957.6 4102.0 4131.9 4146.5 4088.0 4106.4 4123.5 4124.4 4128.4 3929.2 4062.0 4069.3 4080.9 4119.7 3968.9 4048.7 4077.4 4095.2 4098.9 3625.6 3633.6 3641.2 3643.1 3646.7 5150.4 5170.1 5176.2 5180.3 5197.7 4447.5 4655.3 4655.4 4686.3 4698.7 5480.2 5507.5 5519.5 5533.9 5534.2 3955.0 3964.8 3983.3 3990.2 4003.6 5485.7 5594.6 5617.7 5622.3 5640.8 3965.3 3972.2 4002.4 4036.5 4038.8 4081.0 4084.5 4090.1 4095.9 4098.0 4581.6 4594.9 4616.8 4637.7 4678.7 5493.6 5502.8 5514.3 5541.5 5544.6 1387.9 1405.3 1407.9 1409.4 1411.2 883.5 900.8 901.5 917.5 946.0 5239.2 5289.3 5315.7 5331.8 5333.3 5517.8 5536.7 5536.8 5548.8 5561.9 5117.8 5249.9 5273.4 5288.6 5436.2 2987.8 2988.4 2990.4 2999.1 3023.4 5851.6 5856.7 5866.7 5894.5 5896.7 5507.7 5682.2 5700.9 5707.7 5712.9 5782.3 5802.8 5804.5 5851.2 5918.0 5443.9 5616.5 5652.7 5658.5 5712.7 5569.0 5590.3 5596.6 5605.4 5612.3 5840.9 5849.9 5855.6 5859.9 5881.9 3866.2 3962.5 3978.2 3992.2 3996.3 5433.9 5619.6 5667.9 5676.1 5690.7 5424.8 5502.5 5527.6 5529.8 5535.9 5413.6 5477.6 5481.9 5485.5 5498.4 5205.9 5378.7 5408.4 5437.7 5438.9 5503.3 5518.6 5521.9 5522.0 5535.3 5396.8 5408.4 5425.1 5453.3 5475.9 16:41:02 INFO - PROCESS | 29725 | 16:41:02 INFO - PROCESS | 29725 | [#5] yui.html Cycles:180 Average:20929.04 Median:4545.56 stddev:29858.30 (656.9%) stddev-sans-first:29903.57 16:41:02 INFO - PROCESS | 29725 | Values: 738.8 762.4 780.5 818.8 822.6 15982.6 16091.1 16635.5 16647.8 16697.5 15284.0 15295.1 15472.0 15524.8 15539.4 676.7 806.6 807.5 815.5 821.2 823.2 823.5 823.6 826.5 827.9 841.3 843.1 843.4 843.7 844.5 681.8 833.7 851.3 851.9 857.7 624.5 624.8 624.8 624.9 625.5 14315.5 14386.5 14397.0 14434.1 14471.7 14439.3 14782.3 14792.6 14827.7 15078.8 13076.9 13344.4 13504.4 13568.9 13607.0 4514.1 4541.7 4564.7 4618.1 4763.2 78088.8 78144.0 78399.6 78618.3 79625.6 10793.3 11111.0 11159.0 11204.1 11240.2 18669.6 18752.8 18902.2 19670.9 19734.7 8507.4 8529.8 8756.9 8908.7 8967.1 4424.2 4529.8 4549.4 4573.2 4764.0 3413.5 3498.3 3522.6 3526.8 3526.9 594.8 601.5 603.0 608.7 608.7 612.1 670.2 680.4 712.2 721.8 9495.2 9525.2 9645.6 9713.6 9760.6 681.8 692.7 699.1 702.2 709.9 4405.6 4523.7 4588.4 4597.0 4791.1 108884.0 114711.4 115431.4 119049.0 119261.0 86390.0 86700.0 86756.0 102248.0 104613.5 73842.3 87633.0 87907.0 88332.6 90643.5 9707.5 9989.8 10007.5 10029.2 10185.2 53371.5 53420.5 53676.5 53775.2 55206.4 67672.7 78375.6 78594.6 78677.0 80291.6 13187.2 13342.1 13382.4 13392.3 13399.8 14691.6 14985.0 15005.3 15104.2 15325.0 13680.0 13877.0 14008.8 14152.6 14470.1 14164.5 14212.9 14355.1 14372.6 15045.3 11227.8 11726.4 12852.4 13267.3 13594.9 11349.4 11704.5 11775.5 11933.6 12153.6 11268.9 11524.6 11842.3 11889.3 11931.2 16:41:02 INFO - PROCESS | 29725 | -------- Summary: end -------- 16:41:02 INFO - PROCESS | 29725 | 16:41:03 INFO - TEST-INFO | 29725: exit 0 16:41:03 INFO - TEST-OK | dromaeo_css | took 1114536ms 16:41:03 INFO - TEST-START | kraken 16:41:03 INFO - operating with platform_type : linux_ 16:41:03 INFO - Initialising browser for kraken test... 16:41:03 INFO - TEST-INFO | started process 29925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpadu_kO/profile http://localhost:59770/getInfo.html) 16:41:07 INFO - PROCESS | 29925 | __metrics Screen width/height:1600/1200 16:41:07 INFO - PROCESS | 29925 | colorDepth:24 16:41:07 INFO - PROCESS | 29925 | Browser inner width/height: 1024/697 16:41:07 INFO - PROCESS | 29925 | __metrics 16:41:07 INFO - PROCESS | 29925 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:41:08 INFO - TEST-INFO | 29925: exit 0 16:41:08 INFO - Browser initialized. 16:41:08 INFO - Running cycle 1/1 for kraken test... 16:41:08 INFO - TEST-INFO | started process 30010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpadu_kO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:41:20 INFO - PROCESS | 30010 | RSS: Main: 157229056 16:41:20 INFO - PROCESS | 30010 | 16:41:23 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59770/tests/kraken/driver.html?testName=audio-beat-detection) 16:41:23 INFO - PROCESS | 30010 | RSS: Main: 215371776 16:41:23 INFO - PROCESS | 30010 | 16:41:26 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59770/tests/kraken/driver.html?testName=audio-dft) 16:41:27 INFO - PROCESS | 30010 | RSS: Main: 203403264 16:41:27 INFO - PROCESS | 30010 | 16:41:30 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59770/tests/kraken/driver.html?testName=audio-fft) 16:41:30 INFO - PROCESS | 30010 | RSS: Main: 268533760 16:41:30 INFO - PROCESS | 30010 | 16:41:32 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59770/tests/kraken/driver.html?testName=audio-oscillator) 16:41:33 INFO - PROCESS | 30010 | RSS: Main: 180752384 16:41:33 INFO - PROCESS | 30010 | 16:41:35 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59770/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:41:36 INFO - PROCESS | 30010 | RSS: Main: 184184832 16:41:36 INFO - PROCESS | 30010 | 16:41:39 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59770/tests/kraken/driver.html?testName=imaging-darkroom) 16:41:39 INFO - PROCESS | 30010 | RSS: Main: 218882048 16:41:39 INFO - PROCESS | 30010 | 16:41:43 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59770/tests/kraken/driver.html?testName=imaging-desaturate) 16:41:43 INFO - PROCESS | 30010 | RSS: Main: 220983296 16:41:43 INFO - PROCESS | 30010 | 16:41:46 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59770/tests/kraken/driver.html?testName=json-parse-financial) 16:41:47 INFO - PROCESS | 30010 | RSS: Main: 220753920 16:41:47 INFO - PROCESS | 30010 | 16:41:48 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59770/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:41:49 INFO - PROCESS | 30010 | RSS: Main: 206696448 16:41:49 INFO - PROCESS | 30010 | 16:41:51 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59770/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:41:51 INFO - PROCESS | 30010 | RSS: Main: 209797120 16:41:51 INFO - PROCESS | 30010 | 16:41:53 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59770/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:41:54 INFO - PROCESS | 30010 | RSS: Main: 210468864 16:41:54 INFO - PROCESS | 30010 | 16:41:56 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:41:57 INFO - PROCESS | 30010 | RSS: Main: 231714816 16:41:57 INFO - PROCESS | 30010 | 16:42:00 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:42:00 INFO - PROCESS | 30010 | RSS: Main: 224538624 16:42:00 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | Cycle 1(1): loaded http://localhost:59770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59770/tests/kraken/driver.html?testName=ai-astar) 16:42:02 INFO - PROCESS | 30010 | RSS: Main: 266563584 16:42:02 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | __start_tp_report 16:42:02 INFO - PROCESS | 30010 | _x_x_mozilla_page_load 16:42:02 INFO - PROCESS | 30010 | _x_x_mozilla_page_load_details 16:42:02 INFO - PROCESS | 30010 | |i|pagename|runs| 16:42:02 INFO - PROCESS | 30010 | |0;ai-astar;101;112;111;112;110;111;112;110;111;111 16:42:02 INFO - PROCESS | 30010 | |1;audio-beat-detection;144;120;136;177;120;119;142;115;158;116 16:42:02 INFO - PROCESS | 30010 | |2;audio-dft;161;161;161;159;162;161;161;161;162;160 16:42:02 INFO - PROCESS | 30010 | |3;audio-fft;74;75;76;124;76;74;74;75;97;73 16:42:02 INFO - PROCESS | 30010 | |4;audio-oscillator;83;84;116;85;84;84;128;83;84;128 16:42:02 INFO - PROCESS | 30010 | |5;imaging-gaussian-blur;117;117;117;116;118;117;116;117;117;116 16:42:02 INFO - PROCESS | 30010 | |6;imaging-darkroom;146;147;145;146;146;147;145;146;146;146 16:42:02 INFO - PROCESS | 30010 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 16:42:02 INFO - PROCESS | 30010 | |8;json-parse-financial;53;52;53;53;54;54;53;53;53;52 16:42:02 INFO - PROCESS | 30010 | |9;json-stringify-tinderbox;62;62;62;62;62;61;62;62;63;62 16:42:02 INFO - PROCESS | 30010 | |10;stanford-crypto-aes;84;77;80;74;76;76;76;78;75;79 16:42:02 INFO - PROCESS | 30010 | |11;stanford-crypto-ccm;126;125;116;118;118;118;122;121;165;121 16:42:02 INFO - PROCESS | 30010 | |12;stanford-crypto-pbkdf2;161;158;157;155;155;155;157;155;157;158 16:42:02 INFO - PROCESS | 30010 | |13;stanford-crypto-sha256-iterative;69;62;64;63;64;62;62;64;62;64 16:42:02 INFO - PROCESS | 30010 | __end_tp_report 16:42:02 INFO - PROCESS | 30010 | __start_cc_report 16:42:02 INFO - PROCESS | 30010 | _x_x_mozilla_cycle_collect,1663 16:42:02 INFO - PROCESS | 30010 | __end_cc_report 16:42:02 INFO - PROCESS | 30010 | __startTimestamp1467934922644__endTimestamp 16:42:02 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | ------- Summary: start ------- 16:42:02 INFO - PROCESS | 30010 | Number of tests: 14 16:42:02 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.28 (3.0%) stddev-sans-first:0.78 16:42:02 INFO - PROCESS | 30010 | Values: 101.0 112.0 111.0 112.0 110.0 111.0 112.0 110.0 111.0 111.0 16:42:02 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:139.00 stddev:20.79 (15.0%) stddev-sans-first:21.78 16:42:02 INFO - PROCESS | 30010 | Values: 144.0 120.0 136.0 177.0 120.0 119.0 142.0 115.0 158.0 116.0 16:42:02 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 16:42:02 INFO - PROCESS | 30010 | Values: 161.0 161.0 161.0 159.0 162.0 161.0 161.0 161.0 162.0 160.0 16:42:02 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:16.44 (21.9%) stddev-sans-first:17.19 16:42:02 INFO - PROCESS | 30010 | Values: 74.0 75.0 76.0 124.0 76.0 74.0 74.0 75.0 97.0 73.0 16:42:02 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:84.00 stddev:19.67 (23.4%) stddev-sans-first:20.30 16:42:02 INFO - PROCESS | 30010 | Values: 83.0 84.0 116.0 85.0 84.0 84.0 128.0 83.0 84.0 128.0 16:42:02 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 16:42:02 INFO - PROCESS | 30010 | Values: 117.0 117.0 117.0 116.0 118.0 117.0 116.0 117.0 117.0 116.0 16:42:02 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 16:42:02 INFO - PROCESS | 30010 | Values: 146.0 147.0 145.0 146.0 146.0 147.0 145.0 146.0 146.0 146.0 16:42:02 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:42:02 INFO - PROCESS | 30010 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:42:02 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 16:42:02 INFO - PROCESS | 30010 | Values: 53.0 52.0 53.0 53.0 54.0 54.0 53.0 53.0 53.0 52.0 16:42:02 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 16:42:02 INFO - PROCESS | 30010 | Values: 62.0 62.0 62.0 62.0 62.0 61.0 62.0 62.0 63.0 62.0 16:42:02 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.50 stddev:2.92 (3.8%) stddev-sans-first:1.92 16:42:02 INFO - PROCESS | 30010 | Values: 84.0 77.0 80.0 74.0 76.0 76.0 76.0 78.0 75.0 79.0 16:42:02 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:121.50 stddev:14.41 (11.9%) stddev-sans-first:15.28 16:42:02 INFO - PROCESS | 30010 | Values: 126.0 125.0 116.0 118.0 118.0 118.0 122.0 121.0 165.0 121.0 16:42:02 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:157.00 stddev:1.93 (1.2%) stddev-sans-first:1.32 16:42:02 INFO - PROCESS | 30010 | Values: 161.0 158.0 157.0 155.0 155.0 155.0 157.0 155.0 157.0 158.0 16:42:02 INFO - PROCESS | 30010 | 16:42:02 INFO - PROCESS | 30010 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:2.12 (3.3%) stddev-sans-first:1.00 16:42:02 INFO - PROCESS | 30010 | Values: 69.0 62.0 64.0 63.0 64.0 62.0 62.0 64.0 62.0 64.0 16:42:02 INFO - PROCESS | 30010 | -------- Summary: end -------- 16:42:02 INFO - PROCESS | 30010 | 16:42:03 INFO - TEST-INFO | 30010: exit 0 16:42:03 INFO - TEST-OK | kraken | took 60334ms 16:42:03 INFO - SUITE-END | took 1174s 16:42:03 INFO - Completed test suite (00:19:35) 16:42:03 INFO - javascript benchmark 16:42:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3055.3889222155567, 3076.061801150648, 3099.473089574772, 3103.689631036895, 3120.6879312068795, 5258.92111618326, 5352.411234764178, 5370.301860758096, 5423.078076726956, 5487.149491828763, 5338.973305133469, 5374.355077390709, 5404.378496472907, 5417.160340147274, 5429.429909859467, 4806.519348065201, 4811.037792441508, 4819.445763737162, 4880.902381952359, 5081.1108056090225, 4992.350994370745, 5020.196768517038, 5041.369828771403, 5051.621128415365, 5056.6713163644245, 4766.594839438651, 4811.254255590389, 4845.733484658343, 4862.805487780484, 4948.851534453954, 4876.561109500162, 4881.243407271879, 4881.755912204376, 4945.727984960826, 4964.05682920244, 4876.390451193601, 4912.828051018233, 4928.063667903087, 4947.777350019258, 4952.108620448354, 5235.1623740201385, 5348.064088784447, 5468.863278418032, 5484.945150548483, 5489.972550137264, 5833.7083145842535, 5836.095405212156, 5879.617824841372, 5889.411058894119, 5890.204822348971, 5866.178734977107, 5894.410558944114, 5940.702964851784, 5941.376155503696, 5949.643021418686, 5279.6832190068335, 5309.415964243892, 5363.517283444508, 5378.784848606012, 5498.202760599731, 5908.350081491032, 5937.376575459601, 5937.970310148508, 5947.434993675594, 5961.552883533665, 5695.174199741097, 5711.657300561979, 5745.712714364265, 5749.913751293734, 5755.740991655385, 5547.11246200606, 5672.602917795714, 5735.283089613798, 5742.54059675225, 5814.825555233349, 5726.226959360433, 5737.942620573741, 5742.511886489611, 5747.5689323300085, 5750.1949727038245, 5694.544436445074, 5738.167965644958, 5751.079827227707, 5752.827415177551, 5754.510866576305, 4253.659707223414, 4335.956640433618, 4336.934945975813, 4381.7151885128005, 4421.248387774086, 3930.901727456779, 3936.488256526633, 3938.5076865391825, 3967.821448034845, 3973.205358928226, 5588.944110558842, 5590.5527557796095, 5591.077472217039, 5593.272874526286, 5644.32268127819, 5673.631213971079, 5775.451332123442, 5830.883382332329, 5873.823785286449, 5926.199963005025, 5585.888282234332, 5592.944070559323, 5594.272744543184, 5596.440355964371, 5634.549236061187, 5061.645684802029, 5067.189249720101, 5072.442031376546, 5075.467075957045, 5121.692698438105, 5770.5095066919785, 5967.224260846149, 6010.519158467225, 6024.277086749618, 6097.054956481752, 5812.738426770721, 5831.212786273968, 5831.7375718093635, 5845.649261044351, 5846.444587764156, 6054.39456054391, 6071.605345652519, 6076.817695469143, 6078.270607527125, 6078.969605151946, 5473.616846820684, 5691.345495267931, 5696.088625819849, 5747.339056008613, 5804.65172089676, 5897.0, 5897.262842144732, 5898.793542226002, 5901.439363260483, 5904.409559044061, 5528.612997090326, 5748.080307150836, 5763.4812866842185, 5767.221425107557, 5767.971160144172, 5618.971905140448, 5651.095824668033, 5684.175794509855, 5711.400302968294, 5717.056685646821, 5635.211070450058, 5655.321361436654, 5661.264035675335, 5661.971690141523, 5664.801731939362, 5534.916976245279, 5568.359638641608, 5727.7422515986045, 5730.025895597675, 5739.8852022960145, 5407.864803379947, 5409.323834520685, 5474.863128421821, 5508.697021663847, 5547.306586676666], "value": 5346.879960434747, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.525179856115, 613.4233820209004, 616.6731632234917, 639.7281155508907, 640.2860810196629, 31114.53328200076, 43707.12585748283, 44482.11035779282, 44773.328400074024, 44866.0, 46492.53507464924, 46615.76692116535, 46812.0, 46907.29639055417, 47021.29468057982, 8907.109289071106, 9127.908720912772, 9139.177474027336, 9140.223081038086, 9141.314401419886, 9021.233195178418, 9092.954535227347, 9098.135677110664, 9116.58975346111, 9118.908810911873, 9157.679481218158, 9170.724878253663, 9184.989651138369, 9196.0, 9207.217386522154, 9113.043130471304, 9133.315001374856, 9166.450012999174, 9167.679131230376, 9168.999999999933, 9009.684661036898, 9092.318076144249, 9092.636294548276, 9096.1813436791, 9096.909030909672, 43569.0, 43924.0, 43948.340774888406, 43948.56051439477, 43968.78015609901, 3486.89539313821, 3685.539307586552, 4148.937765933513, 4229.513605935326, 4439.200943830109, 32836.34327313464, 33552.63815703967, 33988.32023359519, 34063.829680851435, 34068.0, 4485.506594274627, 4595.103954728829, 4737.218358970766, 4752.0, 4760.880977975544, 358906.0, 360254.0, 360526.9999999974, 360791.0, 362270.0, 60277.09584356238, 61004.694976524836, 61042.084368734504, 61046.38953610407, 61080.0, 64239.67880160663, 64329.678351607945, 64462.033069503996, 64483.0, 64607.67696161489, 17594.91202543979, 17831.59273498087, 17831.910840445715, 17837.910810445865, 17841.0, 13581.660458488419, 13622.591322260349, 13677.179369237678, 13677.658058548417, 13678.384472698752, 15829.14251346838, 18855.151518181716, 18987.71518427225, 19110.808891910903, 19285.4214373569, 5505.889882202334, 6303.630527781774, 6677.833054173588, 6734.326567343324, 6838.965805170942, 1006.2905651515664, 1032.8347464405808, 1036.6216331039116, 1056.9154467642725, 1131.2025022359217, 33737.32525349479, 34028.0, 34523.482147767805, 34706.652933470345, 34975.475367869505, 1080.222239987208, 1100.5927806711568, 1112.0214211493833, 1155.96532104037, 1176.9823452648218, 17223.56941076458, 17870.821291786917, 17899.463016109537, 18036.90981545084, 18050.548736281697, 516248.0, 519518.0, 520344.0, 520530.0, 521554.0, 59813.0, 60674.0, 60723.0, 60819.391806082254, 60824.0, 1195.2947760821157, 1325.2975922760952, 1354.2686949047404, 1405.6907480354305, 1471.3158381352723, 31116.377672446877, 35648.475907104636, 35797.64202357943, 35856.4621530672, 36033.81983090068, 54288.0, 54880.451195487534, 55339.44660553343, 55475.72262138664, 55494.44505554893, 527008.0, 527565.0, 531716.0, 533959.0, 540684.0, 37368.25263494769, 39500.604993949695, 41832.79083604563, 46020.539794601624, 50406.49593504165, 50279.0, 50411.49588504068, 51223.231651526, 51469.742651286506, 52355.738221310174, 42355.576444235165, 42535.787321063195, 43381.0, 43436.78281608572, 44553.0, 41945.37081943712, 43620.84815540149, 43801.34297985597, 45738.0, 46000.0, 42838.78580607202, 43388.34917476303, 43874.0, 44196.55803441924, 44367.0, 36307.45538816867, 38577.421338680506, 38877.0, 39276.607233927294, 39435.60564394434, 29121.85439072791, 29248.89382182716, 29489.262768430104, 29670.774691898627, 29755.851220743756], "value": 21206.12201116352, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.41843352021107, 384.6000159833772, 390.7753042000849, 399.1458279282335, 405.99188016239674, 18085.457436276898, 19653.606927861434, 20915.163393464263, 20918.581628367425, 20954.790452095476, 11973.940130299357, 12527.060470464728, 12562.30907300098, 12745.0, 19856.20575176991, 5387.649802762818, 5481.643693159952, 5511.614187006911, 5536.446355364472, 5540.584456165783, 3962.5046869141356, 4701.670883038189, 6753.324667533232, 6762.966185169067, 6880.277570855038, 6317.747290108413, 6807.387335139836, 6819.693113809891, 6845.623490708009, 6867.313268673118, 6187.443130118311, 6216.0, 6216.937830621681, 6223.159873417076, 6225.19072520574, 3861.613838616144, 5563.332400112013, 5867.178594996704, 5868.677222752747, 5870.0, 13687.657808554766, 13773.173609583357, 14020.789688154584, 14524.273786310749, 14578.0, 2509.510645424143, 2581.7031041430287, 2610.451805120927, 2792.274008757717, 3065.2796592800896, 9603.807923841485, 9739.172170365528, 10305.84541231882, 11469.082473402108, 14141.29293535319, 1913.9234430622757, 1967.4687834284664, 1968.7932767059397, 1974.5853370792152, 1978.99010504948, 81169.59415202886, 82833.58583207105, 83272.58363708142, 84876.0, 85132.99999999937, 10673.146148308117, 10850.728731781768, 10880.836787448194, 10885.564577416815, 11295.49170287339, 15120.773188402183, 15184.544463666107, 15198.240087995557, 15236.771448428282, 15267.083974961537, 7885.29032387088, 8174.182581741778, 8175.100738918714, 8249.958750206331, 8342.207490288412, 7819.139894611588, 7860.135385107634, 7972.641231144612, 8036.557989310527, 8100.149484304181, 4626.930596041062, 4644.558766917205, 4695.741734204652, 4756.643251756063, 4781.2350023996, 1935.5838494723703, 1944.5041514413733, 1987.9900600497194, 1989.6717041688248, 1998.8400927925732, 945.2626950978248, 981.6662334806057, 998.3011891675856, 1020.6682828080903, 1074.7689246811974, 20204.29284975019, 20504.282350117675, 20651.69022464664, 20798.79201207999, 20805.54181098466, 989.7525618595351, 1019.8062368150028, 1024.8975102489692, 1027.9486025698834, 1033.0289527843802, 10645.574177032986, 11318.151138664633, 11374.545018199346, 11378.772424551627, 11397.316161030365, 352654.0, 356547.0, 356762.8647427037, 447543.0, 491184.0, 101180.49409752904, 102674.48662756638, 104326.95673043324, 108620.0, 109978.0, 888.4314039015036, 912.6714382822179, 936.6628013914985, 941.2564074381299, 942.7925856311738, 15310.0, 17125.743113853052, 17207.483775486755, 17699.469015929542, 18164.545886352946, 43588.34617480677, 44263.55736442594, 44841.77579112214, 45028.77485612551, 45158.0, 62060.0, 62662.373376265656, 63157.68421157865, 63732.68133659302, 63755.362446374944, 8184.672613095409, 8466.534340611326, 8506.532140732319, 8531.274841638531, 8554.57227138653, 12711.237325760483, 13284.933575332061, 13430.529931452353, 13688.589342319747, 13913.930430347784, 11777.764444711229, 12045.156839021185, 12133.69665758363, 12182.852252314884, 12191.695207619881, 11648.068154547786, 11723.41382930867, 11773.529058837894, 11854.881451185378, 12008.279503229835, 11624.767504650028, 11708.765824683629, 12121.333326667118, 12224.0, 12360.567380141652, 7556.6977320908745, 8068.314193293636, 8166.0, 8441.662333506836, 8620.956895215484, 8879.0, 11542.942285288857, 12360.690982725504, 12431.254124752544, 12710.618681439571], "value": 9173.625775322434, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.343721576428, 1421.6943357178209, 1466.963325916852, 1562.9609259768504, 1749.8687598430113, 8260.0, 8672.566371681407, 8684.348673849463, 8878.067802880701, 8912.955435222815, 8616.569171541414, 8802.427842190253, 8826.382153249258, 8828.60271287792, 8829.867551986725, 1893.8579606529497, 2070.0891607692565, 2145.0668959002883, 2179.9891000545013, 2205.7904499072642, 2212.623853944833, 2215.091812356934, 2217.135317226283, 2217.667349897512, 2219.4451387153213, 2177.2597316912247, 2191.6931629571873, 2198.2635817001324, 2198.890055497219, 2200.3179014505477, 1861.571838477151, 2029.8071683190074, 2100.6218880601486, 2108.673155660875, 2109.177420805879, 2101.464126647695, 2112.8098471137673, 2115.7355330583678, 2134.0396821430263, 2134.7438307403054, 8752.21230089295, 8817.911820881838, 8862.512561809099, 8866.645334186625, 8871.0, 5027.622928280393, 5138.0, 5166.147585648364, 5179.792808287664, 5214.270002199695, 3249.252671885456, 3269.346130773855, 3316.1046517440395, 3325.068980685388, 3370.679785420381, 1065.0999905080196, 1067.6850329152842, 1069.417167643636, 1087.8259478483405, 1090.6837017264984, 12081.15431919766, 12084.939575302067, 12085.214461060003, 12107.152499325051, 12129.21160124589, 4347.260965635849, 4422.447194100738, 4505.774711264424, 4550.863474095782, 4552.476465206478, 9869.555869985868, 9940.055694708992, 9946.055124763281, 9954.153896918699, 10106.646267380607, 5212.50481204285, 5214.0875346814155, 5243.475652434802, 5247.02929957959, 5248.448912864171, 4106.3635136553885, 4532.184206842734, 4650.790714417859, 4651.418572678415, 4737.313089601988, 3708.8887333380044, 3819.083419979185, 3823.2735780201674, 3845.538535375717, 3878.7090968176935, 1070.4166229404993, 1189.6490535291937, 1224.9265044097383, 1240.2186622427812, 1245.582729785532, 906.1559725957776, 937.1752857485369, 978.2907392140642, 982.3025651787168, 1021.7139201023725, 6130.877382452415, 6130.908036379458, 6277.372262773777, 6283.937160628427, 6312.116303717483, 980.6224603527551, 981.9901800982042, 988.6687959533637, 1008.7629407089328, 1077.8383242513685, 4229.978850105791, 4301.720388174758, 4362.890927726832, 4371.256886329332, 4371.431713877176, 10620.362778233331, 10848.511816968256, 10966.0, 11007.339559626447, 11021.944890275658, 10819.83770243447, 10823.567057317776, 10843.945780271206, 10851.457427128613, 10851.620193293196, 7801.102873169544, 7887.566183859943, 8056.718014869569, 8082.595870206466, 8276.83446331082, 6178.135061091541, 6364.5863018905475, 6430.453411460078, 6454.386833250834, 6468.15913931186, 10069.748256293651, 10167.542460589439, 10319.380837149794, 10364.533595988049, 10398.168146548107, 10184.949075254577, 10453.581856725647, 10671.46642667848, 10672.83990740124, 10675.733106672395, 7822.9608851957655, 7931.920680793118, 7945.8808117879435, 7952.36381089523, 7984.401169912164, 8572.742817715478, 8575.485470871768, 8599.484030958163, 8606.65573377058, 8614.267787238156, 7491.70033198666, 7725.49784264021, 7744.535327880345, 7760.68957241704, 7799.883001754864, 7450.180480147071, 7678.078630564368, 7736.342410895137, 7817.804554886174, 7846.254605812439, 6904.4131248844415, 6912.758053468105, 6968.965155174192, 6978.0, 6979.895301570582, 5262.368515778131, 5285.365756109138, 5375.973120134374, 5432.103702889137, 5473.124300111963, 5492.505674489315, 5572.860678482908, 5589.077802162597, 5668.801591944262, 5729.742161602821], "value": 4595.010346906405, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.817829747895, 324.9317643294908, 325.6515528384629, 325.8875687887678, 332.413290542193, 5167.354080739908, 5217.295665085212, 5226.014114636438, 5235.240890070937, 5269.446708095652, 5157.664751791131, 5217.113090774568, 5244.213367994803, 5244.39689435715, 5245.31810864588, 3929.607039296062, 3957.5844536323702, 4102.0360215349365, 4131.8967025824295, 4146.481689788777, 4087.979560102195, 4106.38404239365, 4123.546409894909, 4124.443200167984, 4128.3601041838565, 3929.1945151243926, 4062.045419326456, 4069.3489041753323, 4080.8571699990507, 4119.732217405874, 3968.9085501487034, 4048.696347773914, 4077.408775727503, 4095.221907837531, 4098.918021639581, 3625.6374362563797, 3633.582138054131, 3641.1625326175126, 3643.0528062703625, 3646.690031347339, 5150.407703114152, 5170.095233334189, 5176.171812509981, 5180.300659410969, 5197.66105252634, 4447.466304043535, 4655.301704744282, 4655.4180727409075, 4686.250199967989, 4698.741569213692, 5480.246321177225, 5507.476789704971, 5519.503244707996, 5533.916991245134, 5534.169874518854, 3954.960450395488, 3964.762114273124, 3983.342748446503, 3990.1620659661216, 4003.5987404408515, 5485.6982865942355, 5594.636348637326, 5617.747201375948, 5622.297212848394, 5640.802571910004, 3965.3457179565626, 3972.205558888234, 4002.399640054015, 4036.4550785643564, 4038.7778672172726, 4080.9795951020055, 4084.5098588169017, 4090.0592863640936, 4095.85664501747, 4097.959020409818, 4581.5647513486165, 4594.931076033862, 4616.792244349012, 4637.721736695809, 4678.69588476748, 5493.615446918758, 5502.752376143083, 5514.255575497336, 5541.476094074082, 5544.556435485151, 1387.854275301099, 1405.3465138710344, 1407.908870625253, 1409.3516982188307, 1411.2238268952035, 883.5405589093635, 900.7793090692691, 901.5395060002837, 917.5320586500933, 945.952702364879, 5239.240310155006, 5289.259503669489, 5315.654482458628, 5331.760070796823, 5333.280007198979, 5517.751701173457, 5536.723163841792, 5536.833894983157, 5548.805791797267, 5561.944380556223, 5117.8464646060675, 5249.895002099936, 5273.419923808378, 5288.576913846883, 5436.184572314184, 2987.775916806248, 2988.4321978824387, 2990.357073229266, 2999.145243605562, 3023.3953209358215, 5851.590388672837, 5856.677882716406, 5866.73599688015, 5894.498967587718, 5896.705164741831, 5507.7246137692955, 5682.232898558725, 5700.857478563069, 5707.74315155819, 5712.942870571241, 5782.340123543133, 5802.767889284466, 5804.519847438876, 5851.1515830205235, 5918.0, 5443.863903402446, 5616.494515493625, 5652.749668940293, 5658.528782516493, 5712.742926568231, 5568.997580435561, 5590.2670172246735, 5596.572873917288, 5605.439456054362, 5612.298462692163, 5840.853978650568, 5849.853753656193, 5855.648661080349, 5859.882802343844, 5881.853038657421, 3866.188100498814, 3962.5046869141356, 3978.2043591282436, 3992.2414741199077, 3996.2806694795217, 5433.864153396196, 5619.578531610064, 5667.914981275202, 5676.091825308096, 5690.719588092646, 5424.783008679608, 5502.504774570308, 5527.640703354269, 5529.751161197836, 5535.861603459945, 5413.566914646897, 5477.561795056306, 5481.945180548303, 5485.533729633026, 5498.350494851448, 5205.92191117126, 5378.731063446734, 5408.405075441777, 5437.67373957548, 5438.945610543844, 5503.3395992481155, 5518.586106041983, 5521.889562208814, 5522.0, 5535.260046277119, 5396.811111611075, 5408.404520666491, 5425.077736784677, 5453.291072160594, 5475.890482190413], "value": 4189.100228369181, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.7672883041845, 762.416751185343, 780.5160800303812, 818.7502811642448, 822.5887056471767, 15982.600434989117, 16091.114988675617, 16635.50093497194, 16647.83352166478, 16697.49907502774, 15284.0, 15295.082295062304, 15472.0, 15524.767128493082, 15539.37842486302, 676.6549059979421, 806.5684858600664, 807.4509333653114, 815.5066184958074, 821.2321479416764, 823.1768231768232, 823.5347028928636, 823.6293667849492, 826.5164878546028, 827.9006519217702, 841.2975165736617, 843.0684094076049, 843.4096132707099, 843.6920524008723, 844.4764246167384, 681.7988693335453, 833.6832003838533, 851.3359579527978, 851.9446235994671, 857.6697971281039, 624.4598422364668, 624.7688355308564, 624.7813265357089, 624.8781487609917, 625.5058503782006, 14315.498957536436, 14386.496472623408, 14397.0, 14434.133951962916, 14471.710565788731, 14439.278036098152, 14782.334794934253, 14792.556223313319, 14827.703445931129, 15078.773818392732, 13076.934615326958, 13344.399502022432, 13504.392302346418, 13568.932155339258, 13607.0, 4514.119746649405, 4541.72749635023, 4564.680472366936, 4618.122556714247, 4763.190257656207, 78088.8286675706, 78144.0, 78399.6080019602, 78618.30604640911, 79625.60187199085, 10793.29843560166, 11111.0, 11159.0, 11204.103671706243, 11240.156988225915, 18669.626607467773, 18752.812471875106, 18902.243910243436, 19670.901645491966, 19734.70397944032, 8507.404481686222, 8529.829403411897, 8756.912430875609, 8908.688195913111, 8967.148120928501, 4424.159409712144, 4529.84145554904, 4549.385832912514, 4573.199690054227, 4763.976180119077, 3413.453847384407, 3498.3003399320237, 3522.577290725078, 3526.8412921418085, 3526.8765593204116, 594.7556081574998, 601.4616917858492, 602.9969850150721, 608.7047781825811, 608.7291155435877, 612.0604871522193, 670.2158474584747, 680.43863812355, 712.1738783011785, 721.8195451137216, 9495.24038076966, 9525.237980961507, 9645.614175433044, 9713.61145554184, 9760.560774765152, 681.7988693335478, 692.6640579319027, 699.1435491522844, 702.1749444402807, 709.8686742952467, 4405.647548196137, 4523.660725445605, 4588.3805686231935, 4597.0, 4791.089692958327, 108884.0, 114711.42644286725, 115431.42284288525, 119049.0, 119261.0, 86390.0, 86700.0, 86756.0, 102248.0, 104613.47693261637, 73842.26157738462, 87633.0, 87907.0, 88332.5583372079, 90643.54678226566, 9707.514624268617, 9989.750256243362, 10007.54966026516, 10029.247806414402, 10185.236107291834, 53371.466285336646, 53420.46579534155, 53676.46323536715, 53775.19337209867, 55206.44793552013, 67672.6616366915, 78375.60812196131, 78594.60702696678, 78677.0, 80291.59854200692, 13187.208767473981, 13342.132761370867, 13382.397792099573, 13392.330383480592, 13399.83755960706, 14691.55925322242, 14985.0, 15005.32476038559, 15104.244787760788, 15325.0, 13680.0, 13877.0, 14008.78986815219, 14152.646183845487, 14470.131792092508, 14164.504242351468, 14212.928935355258, 14355.138691678532, 14372.640683982983, 15045.322960466587, 11227.7754444909, 11726.355050472306, 12852.421641025989, 13267.33663316811, 13594.86405135936, 11349.432528373383, 11704.531818727155, 11775.470103845519, 11933.582324618597, 12153.635390938285, 11268.873112688665, 11524.596639117926, 11842.314417421741, 11889.28664280146, 11931.224470409396], "value": 7624.859964583607, "unit": "score"}], "name": "dromaeo_css", "value": 7310.800442875187, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 111.0, 112.0, 110.0, 111.0, 112.0, 110.0, 111.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 120.0, 136.0, 177.0, 120.0, 119.0, 142.0, 115.0, 158.0, 116.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 159.0, 162.0, 161.0, 161.0, 161.0, 162.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 124.0, 76.0, 74.0, 74.0, 75.0, 97.0, 73.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 116.0, 85.0, 84.0, 84.0, 128.0, 83.0, 84.0, 128.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 53.0, 54.0, 54.0, 53.0, 53.0, 53.0, 52.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 63.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 77.0, 80.0, 74.0, 76.0, 76.0, 76.0, 78.0, 75.0, 79.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 125.0, 116.0, 118.0, 118.0, 118.0, 122.0, 121.0, 165.0, 121.0], "value": 125.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 157.0, 155.0, 155.0, 155.0, 157.0, 155.0, 157.0, 158.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 62.0, 64.0, 63.0, 64.0, 62.0, 62.0, 64.0, 62.0, 64.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1479.0999999999997, "alertThreshold": 2.0}]} 16:42:03 INFO - Return code: 0 16:42:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:42:03 INFO - # TBPL SUCCESS # 16:42:03 INFO - Running post-action listener: _resource_record_post_action 16:42:03 INFO - ##### 16:42:03 INFO - ##### Finished run-tests step (success) 16:42:03 INFO - ##### 16:42:03 INFO - Running post-run listener: _resource_record_post_run 16:42:04 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551395328; Read time: 8; Write time: 448656 16:42:04 INFO - TinderboxPrint: CPU usage
13.0% 16:42:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:42:04 INFO - TinderboxPrint: I/O write bytes / time
551,395,328 / 448,656 16:42:04 INFO - TinderboxPrint: CPU idle
8,277.7 (87.0%) 16:42:04 INFO - TinderboxPrint: CPU user
1,195.0 (12.6%) 16:42:04 INFO - TinderboxPrint: Swap in / out
0 / 0 16:42:04 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256684032; Read time: 0; Write time: 244760 16:42:04 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 294711296; Read time: 0; Write time: 203896 16:42:04 INFO - Running post-run listener: _upload_blobber_files 16:42:04 INFO - Blob upload gear active. 16:42:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:42:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:42:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:42:04 INFO - (blobuploader) - INFO - Open directory for files ... 16:42:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:42:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:42:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:05 INFO - (blobuploader) - INFO - Done attempting. 16:42:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:42:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:42:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:06 INFO - (blobuploader) - INFO - Done attempting. 16:42:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:42:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:42:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:42:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:42:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:42:10 INFO - (blobuploader) - INFO - Done attempting. 16:42:10 INFO - (blobuploader) - INFO - Iteration through files over. 16:42:10 INFO - Return code: 0 16:42:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:42:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:42:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69a37be0dbc9e39e704a1a2a02fca9aab1d2c84b03ae6b4120afc1661a5636dea3de58e2bae5553f430b5ec2f42ca5a9fea5986bd20db6a01d18b7461fbd2442", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dff83d0e9019dc1b97bb0644ed3b55222c9bc8a0b62657ec03d021c7f6472b8ceb324fa90453b9eae35d628b22e8141d8ea3b4c7b6014d29aa58353095e75deb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/809a4f6bcfd26e38a778432469ff32fd11866ad5ae8aa9d003dbe9267b817e1a70ee9740b85e1364072556055330befcbda632ed7bdabbce9baebb97c53cb06e"} 16:42:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:42:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:42:10 INFO - Contents: 16:42:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69a37be0dbc9e39e704a1a2a02fca9aab1d2c84b03ae6b4120afc1661a5636dea3de58e2bae5553f430b5ec2f42ca5a9fea5986bd20db6a01d18b7461fbd2442", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dff83d0e9019dc1b97bb0644ed3b55222c9bc8a0b62657ec03d021c7f6472b8ceb324fa90453b9eae35d628b22e8141d8ea3b4c7b6014d29aa58353095e75deb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/809a4f6bcfd26e38a778432469ff32fd11866ad5ae8aa9d003dbe9267b817e1a70ee9740b85e1364072556055330befcbda632ed7bdabbce9baebb97c53cb06e"} 16:42:10 INFO - Running post-run listener: copy_logs_to_upload_dir 16:42:10 INFO - Copying logs to upload dir... 16:42:10 INFO - mkdir: /builds/slave/test/build/upload/logs 16:42:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.413967 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-07 16:42:09.807515) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 16:42:09.810798) ========= 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-1467931322.140484-755944837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69a37be0dbc9e39e704a1a2a02fca9aab1d2c84b03ae6b4120afc1661a5636dea3de58e2bae5553f430b5ec2f42ca5a9fea5986bd20db6a01d18b7461fbd2442", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dff83d0e9019dc1b97bb0644ed3b55222c9bc8a0b62657ec03d021c7f6472b8ceb324fa90453b9eae35d628b22e8141d8ea3b4c7b6014d29aa58353095e75deb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/809a4f6bcfd26e38a778432469ff32fd11866ad5ae8aa9d003dbe9267b817e1a70ee9740b85e1364072556055330befcbda632ed7bdabbce9baebb97c53cb06e"} build_url:https://queue.taskcluster.net/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/XpW9qlZcRDaWwSs8g--q9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/69a37be0dbc9e39e704a1a2a02fca9aab1d2c84b03ae6b4120afc1661a5636dea3de58e2bae5553f430b5ec2f42ca5a9fea5986bd20db6a01d18b7461fbd2442", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dff83d0e9019dc1b97bb0644ed3b55222c9bc8a0b62657ec03d021c7f6472b8ceb324fa90453b9eae35d628b22e8141d8ea3b4c7b6014d29aa58353095e75deb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/809a4f6bcfd26e38a778432469ff32fd11866ad5ae8aa9d003dbe9267b817e1a70ee9740b85e1364072556055330befcbda632ed7bdabbce9baebb97c53cb06e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 16:42:09.837267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 16:42:09.837697) ========= 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-1467931322.140484-755944837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004425 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 16:42:09.920563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 16:42:09.920918) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 16:42:09.921283) ========= ========= Total master_lag: 0.17 =========