builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0285 starttime: 1467979379.31 results: success (0) buildid: 20160708022626 builduid: 91e0a894a7dd41bfa26563067f62c440 revision: 806cd7a7b68de8777caf419239e2f4e671aaa80b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 05:02:59.307725) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 05:02:59.308272) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 05:02:59.308692) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 05:02:59.333529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:02:59.333924) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P1CD7GS4EK/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-08 05:02:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.3M=0.001s 2016-07-08 05:02:59 (20.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079517 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:02:59.436569) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:02:59.436975) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P1CD7GS4EK/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025595 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:02:59.486197) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 05:02:59.486649) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 806cd7a7b68de8777caf419239e2f4e671aaa80b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 806cd7a7b68de8777caf419239e2f4e671aaa80b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P1CD7GS4EK/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-08 05:02:59,569 truncating revision to first 12 chars 2016-07-08 05:02:59,569 Setting DEBUG logging. 2016-07-08 05:02:59,569 attempt 1/10 2016-07-08 05:02:59,569 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/806cd7a7b68d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 05:03:00,669 unpacking tar archive at: fx-team-806cd7a7b68d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.377405 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 05:03:00.887206) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 05:03:00.887575) ========= script_repo_revision: 806cd7a7b68de8777caf419239e2f4e671aaa80b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 05:03:00.888114) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 05:03:00.888424) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 05:03:00.907415) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-08 05:03:00.907724) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P1CD7GS4EK/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:03:01 INFO - MultiFileLogger online at 20160708 05:03:01 in /builds/slave/test 05:03:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:03:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:03:01 INFO - {'append_to_log': False, 05:03:01 INFO - 'base_work_dir': '/builds/slave/test', 05:03:01 INFO - 'blob_upload_branch': 'Fx-Team', 05:03:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:03:01 INFO - 'branch': 'Fx-Team', 05:03:01 INFO - 'buildbot_json_path': 'buildprops.json', 05:03:01 INFO - 'config_files': ('talos/mac_config.py',), 05:03:01 INFO - 'default_actions': ('clobber', 05:03:01 INFO - 'read-buildbot-config', 05:03:01 INFO - 'download-and-extract', 05:03:01 INFO - 'populate-webroot', 05:03:01 INFO - 'create-virtualenv', 05:03:01 INFO - 'install', 05:03:01 INFO - 'run-tests'), 05:03:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:03:01 INFO - 'download_minidump_stackwalk': True, 05:03:01 INFO - 'download_symbols': 'ondemand', 05:03:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:03:01 INFO - 'tooltool.py': '/tools/tooltool.py', 05:03:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:03:01 INFO - '/tools/misc-python/virtualenv.py')}, 05:03:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:03:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:03:01 INFO - 'installer_path': 'installer.exe', 05:03:01 INFO - 'log_level': 'info', 05:03:01 INFO - 'log_name': 'talos', 05:03:01 INFO - 'log_to_console': True, 05:03:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:03:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:03:01 INFO - 'opt_config_files': (), 05:03:01 INFO - 'pip_index': False, 05:03:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:03:01 INFO - 'cmd': ('bash', 05:03:01 INFO - '-c', 05:03:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:03:01 INFO - 'enabled': True, 05:03:01 INFO - 'halt_on_failure': False, 05:03:01 INFO - 'name': 'check_screen_resolution'},), 05:03:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:03:01 INFO - 'cmd': ('bash', 05:03:01 INFO - '-c', 05:03:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:03:01 INFO - 'enabled': True, 05:03:01 INFO - 'halt_on_failure': False, 05:03:01 INFO - 'name': 'check_screen_resolution'},), 05:03:01 INFO - 'run_cmd_checks_enabled': True, 05:03:01 INFO - 'sps_profile': False, 05:03:01 INFO - 'sps_profile_interval': 0, 05:03:01 INFO - 'suite': 'dromaeojs-e10s', 05:03:01 INFO - 'system_bits': '32', 05:03:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:03:01 INFO - 'title': 't-yosemite-r7-0285', 05:03:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:03:01 INFO - 'use_talos_json': True, 05:03:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:03:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:03:01 INFO - 'work_dir': 'build'} 05:03:01 INFO - ##### 05:03:01 INFO - ##### Running clobber step. 05:03:01 INFO - ##### 05:03:01 INFO - Running pre-action listener: _resource_record_pre_action 05:03:01 INFO - Running main action method: clobber 05:03:01 INFO - rmtree: /builds/slave/test/build 05:03:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:03:03 INFO - Running post-action listener: _resource_record_post_action 05:03:03 INFO - ##### 05:03:03 INFO - ##### Finished clobber step (success) 05:03:03 INFO - ##### 05:03:03 INFO - ##### 05:03:03 INFO - ##### Running read-buildbot-config step. 05:03:03 INFO - ##### 05:03:03 INFO - Running pre-action listener: _resource_record_pre_action 05:03:03 INFO - Running main action method: read_buildbot_config 05:03:03 INFO - Using buildbot properties: 05:03:03 INFO - { 05:03:03 INFO - "project": "", 05:03:03 INFO - "product": "firefox", 05:03:03 INFO - "script_repo_revision": "production", 05:03:03 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:03:03 INFO - "repository": "", 05:03:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:03:03 INFO - "buildid": "20160708022626", 05:03:03 INFO - "pgo_build": "False", 05:03:03 INFO - "basedir": "/builds/slave/test", 05:03:03 INFO - "buildnumber": 726, 05:03:03 INFO - "slavename": "t-yosemite-r7-0285", 05:03:03 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:03:03 INFO - "platform": "yosemite_r7", 05:03:03 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:03:03 INFO - "branch": "fx-team", 05:03:03 INFO - "repo_path": "integration/fx-team", 05:03:03 INFO - "revision": "806cd7a7b68de8777caf419239e2f4e671aaa80b", 05:03:03 INFO - "stage_platform": "macosx64", 05:03:03 INFO - "builduid": "91e0a894a7dd41bfa26563067f62c440", 05:03:03 INFO - "slavebuilddir": "test" 05:03:03 INFO - } 05:03:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 05:03:03 INFO - Running post-action listener: _resource_record_post_action 05:03:03 INFO - ##### 05:03:03 INFO - ##### Finished read-buildbot-config step (success) 05:03:03 INFO - ##### 05:03:03 INFO - ##### 05:03:03 INFO - ##### Running download-and-extract step. 05:03:03 INFO - ##### 05:03:03 INFO - Running pre-action listener: _resource_record_pre_action 05:03:03 INFO - Running main action method: download_and_extract 05:03:03 INFO - mkdir: /builds/slave/test/build/tests 05:03: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')]} 05:03:03 INFO - https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:03:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:03:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:03:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 05:03:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 05:03:04 INFO - Downloaded 1199 bytes. 05:03:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 05:03:04 INFO - Using the following test package requirements: 05:03:04 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:03:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:03:04 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 05:03:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:03:04 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 05:03:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:03:04 INFO - u'jsshell-mac.zip'], 05:03:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:03:04 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 05:03:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:03:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:03:04 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 05:03:04 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:03:04 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 05:03:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:03:04 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 05:03:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:03:04 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 05:03:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:04 INFO - https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:03:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:03:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:03:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:03:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:03:06 INFO - Downloaded 18806272 bytes. 05:03:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:03:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:03:09 INFO - Return code: 0 05:03:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:09 INFO - https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:03:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:03:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:03:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:03:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:03:10 INFO - Downloaded 18806272 bytes. 05:03:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:03:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:03:13 INFO - Return code: 0 05:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:13 INFO - https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:03:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:03:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:03:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:03:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:03:15 INFO - Downloaded 14403333 bytes. 05:03:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:03:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:03:15 INFO - Return code: 0 05:03:15 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')]} 05:03:15 INFO - https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:03:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:03:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:03:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 05:03:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 05:03:18 INFO - Downloaded 112425256 bytes. 05:03:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:03:18 INFO - mkdir: /builds/slave/test/properties 05:03:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:03:18 INFO - Writing to file /builds/slave/test/properties/build_url 05:03:18 INFO - Contents: 05:03:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:03:19 INFO - Running post-action listener: _resource_record_post_action 05:03:19 INFO - Running post-action listener: set_extra_try_arguments 05:03:19 INFO - ##### 05:03:19 INFO - ##### Finished download-and-extract step (success) 05:03:19 INFO - ##### 05:03:19 INFO - ##### 05:03:19 INFO - ##### Running populate-webroot step. 05:03:19 INFO - ##### 05:03:19 INFO - Running pre-action listener: _resource_record_pre_action 05:03:19 INFO - Running main action method: populate_webroot 05:03:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:03:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:03:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:03:19 INFO - '--tppagecycles', 05:03:19 INFO - '7'], 05:03:19 INFO - 'tests': ['tsvgm']}}, 05:03:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:03:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:03:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:03:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:03:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:03:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:03:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:19 INFO - 'talos_options': ['--disable-e10s'], 05:03:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:19 INFO - 'talos_options': ['--disable-e10s'], 05:03:19 INFO - 'tests': ['damp', 'tps']}, 05:03:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:19 INFO - 'tests': ['damp', 'tps']}, 05:03:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:03:19 INFO - 'tests': ['dromaeo_dom']}, 05:03:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:03:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:03:19 INFO - 'tests': ['basic_compositor_video']}, 05:03:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:03:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:03:19 INFO - 'tests': ['a11yr', 05:03:19 INFO - 'ts_paint', 05:03:19 INFO - 'tpaint', 05:03:19 INFO - 'sessionrestore', 05:03:19 INFO - 'sessionrestore_no_auto_restore', 05:03:19 INFO - 'tabpaint']}, 05:03:19 INFO - 'other-e10s': {'tests': ['a11yr', 05:03:19 INFO - 'ts_paint', 05:03:19 INFO - 'tpaint', 05:03:19 INFO - 'sessionrestore', 05:03:19 INFO - 'sessionrestore_no_auto_restore', 05:03:19 INFO - 'tabpaint']}, 05:03:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:03:19 INFO - 'ts_paint', 05:03:19 INFO - 'tpaint', 05:03:19 INFO - 'sessionrestore', 05:03:19 INFO - 'sessionrestore_no_auto_restore', 05:03:19 INFO - 'tabpaint']}, 05:03:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:03:19 INFO - 'ts_paint', 05:03:19 INFO - 'tpaint', 05:03:19 INFO - 'sessionrestore', 05:03:19 INFO - 'sessionrestore_no_auto_restore', 05:03:19 INFO - 'tabpaint']}, 05:03:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:03:19 INFO - 'tests': ['a11yr', 05:03:19 INFO - 'ts_paint', 05:03:19 INFO - 'tpaint', 05:03:19 INFO - 'sessionrestore', 05:03:19 INFO - 'sessionrestore_no_auto_restore', 05:03:19 INFO - 'tabpaint']}, 05:03:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:03:19 INFO - 'tests': ['a11yr', 05:03:19 INFO - 'ts_paint', 05:03:19 INFO - 'tpaint', 05:03:19 INFO - 'sessionrestore', 05:03:19 INFO - 'sessionrestore_no_auto_restore', 05:03:19 INFO - 'tabpaint']}, 05:03:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:03:19 INFO - 'tests': ['tsvgx', 05:03:19 INFO - 'tsvgr_opacity', 05:03:19 INFO - 'tart', 05:03:19 INFO - 'tscrollx', 05:03:19 INFO - 'cart']}, 05:03:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:03:19 INFO - 'tsvgr_opacity', 05:03:19 INFO - 'tart', 05:03:19 INFO - 'tscrollx', 05:03:19 INFO - 'cart']}, 05:03:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:19 INFO - 'talos_options': ['--disable-e10s'], 05:03:19 INFO - 'tests': ['tp5o']}, 05:03:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:19 INFO - 'tests': ['tp5o']}, 05:03:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:19 INFO - 'talos_options': ['--disable-e10s', 05:03:19 INFO - '--xperf_path', 05:03:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:19 INFO - 'tests': ['tp5n']}, 05:03:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:19 INFO - 'talos_options': ['--xperf_path', 05:03:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:19 INFO - 'tests': ['tp5n']}}, 05:03:19 INFO - 'talos.zip': {'path': '', 05:03:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:03:19 INFO - Running post-action listener: _resource_record_post_action 05:03:19 INFO - ##### 05:03:19 INFO - ##### Finished populate-webroot step (success) 05:03:19 INFO - ##### 05:03:19 INFO - ##### 05:03:19 INFO - ##### Running create-virtualenv step. 05:03:19 INFO - ##### 05:03:19 INFO - Running pre-action listener: _resource_record_pre_action 05:03:19 INFO - Running main action method: create_virtualenv 05:03:19 INFO - Creating virtualenv /builds/slave/test/build/venv 05:03:19 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 05:03:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:03:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:03:19 INFO - Using real prefix '/tools/python27' 05:03:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:03:20 INFO - Installing distribute.............................................................................................................................................................................................done. 05:03:23 INFO - Installing pip.................done. 05:03:23 INFO - Return code: 0 05:03:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:03:23 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')]} 05:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:23 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')]} 05:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:23 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 0x10717fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107214618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6484ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e3d30>, '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 0x106e48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070dbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:23 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 05:03:23 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 05:03:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 05:03:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:23 INFO - 'HOME': '/Users/cltbld', 05:03:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:23 INFO - 'LOGNAME': 'cltbld', 05:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:23 INFO - 'MOZ_NO_REMOTE': '1', 05:03:23 INFO - 'NO_EM_RESTART': '1', 05:03:23 INFO - 'PAGER': '/bin/cat', 05:03:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:23 INFO - 'PWD': '/builds/slave/test', 05:03:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:23 INFO - 'SHELL': '/bin/bash', 05:03:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 05:03:23 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 05:03:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:23 INFO - 'USER': 'cltbld', 05:03:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:23 INFO - 'XPC_FLAGS': '0x0', 05:03:23 INFO - 'XPC_SERVICE_NAME': '0', 05:03:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:23 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 05:03:23 INFO - Cleaning up... 05:03:23 INFO - Return code: 0 05:03:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:03:23 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')]} 05:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:23 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')]} 05:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:23 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 0x10717fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107214618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6484ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e3d30>, '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 0x106e48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070dbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:23 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 05:03:23 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 05:03:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 05:03:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:23 INFO - 'HOME': '/Users/cltbld', 05:03:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:23 INFO - 'LOGNAME': 'cltbld', 05:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:23 INFO - 'MOZ_NO_REMOTE': '1', 05:03:23 INFO - 'NO_EM_RESTART': '1', 05:03:23 INFO - 'PAGER': '/bin/cat', 05:03:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:23 INFO - 'PWD': '/builds/slave/test', 05:03:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:23 INFO - 'SHELL': '/bin/bash', 05:03:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 05:03:23 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 05:03:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:23 INFO - 'USER': 'cltbld', 05:03:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:23 INFO - 'XPC_FLAGS': '0x0', 05:03:23 INFO - 'XPC_SERVICE_NAME': '0', 05:03:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:23 INFO - Downloading/unpacking psutil>=3.1.1 05:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:03:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:26 INFO - Installing collected packages: psutil 05:03:26 INFO - Running setup.py install for psutil 05:03:26 INFO - building 'psutil._psutil_osx' extension 05:03:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:03:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:03:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:03:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:03:27 INFO - building 'psutil._psutil_posix' extension 05:03:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:03:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:03:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:03:27 INFO - ^ 05:03:27 INFO - 1 warning generated. 05:03:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:03:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:27 INFO - Successfully installed psutil 05:03:27 INFO - Cleaning up... 05:03:27 INFO - Return code: 0 05:03:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:03:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:27 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 0x10717fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107214618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6484ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e3d30>, '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 0x106e48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070dbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:27 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 05:03:27 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 05:03:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 05:03:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:27 INFO - 'HOME': '/Users/cltbld', 05:03:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:27 INFO - 'LOGNAME': 'cltbld', 05:03:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:27 INFO - 'MOZ_NO_REMOTE': '1', 05:03:27 INFO - 'NO_EM_RESTART': '1', 05:03:27 INFO - 'PAGER': '/bin/cat', 05:03:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:27 INFO - 'PWD': '/builds/slave/test', 05:03:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:27 INFO - 'SHELL': '/bin/bash', 05:03:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 05:03:27 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 05:03:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:27 INFO - 'USER': 'cltbld', 05:03:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:27 INFO - 'XPC_FLAGS': '0x0', 05:03:27 INFO - 'XPC_SERVICE_NAME': '0', 05:03:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:03:28 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 05:03:28 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 05:03:28 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 05:03:28 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 05:03:28 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 05:03:28 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 05:03:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:03:30 INFO - Installing collected packages: mozsystemmonitor 05:03:30 INFO - Running setup.py install for mozsystemmonitor 05:03:30 INFO - Successfully installed mozsystemmonitor 05:03:30 INFO - Cleaning up... 05:03:30 INFO - Return code: 0 05:03:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:03:30 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')]} 05:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:30 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')]} 05:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:30 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 0x10717fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107214618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6484ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e3d30>, '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 0x106e48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070dbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:30 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 05:03:30 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 05:03:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 05:03:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:30 INFO - 'HOME': '/Users/cltbld', 05:03:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:30 INFO - 'LOGNAME': 'cltbld', 05:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:30 INFO - 'MOZ_NO_REMOTE': '1', 05:03:30 INFO - 'NO_EM_RESTART': '1', 05:03:30 INFO - 'PAGER': '/bin/cat', 05:03:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:30 INFO - 'PWD': '/builds/slave/test', 05:03:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:30 INFO - 'SHELL': '/bin/bash', 05:03:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 05:03:30 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 05:03:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:30 INFO - 'USER': 'cltbld', 05:03:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:30 INFO - 'XPC_FLAGS': '0x0', 05:03:30 INFO - 'XPC_SERVICE_NAME': '0', 05:03:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:31 INFO - Downloading/unpacking jsonschema==2.5.1 05:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:03:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:03:33 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 05:03:33 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 05:03:33 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 05:03:33 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 05:03:33 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 05:03:33 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 05:03:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:03:33 INFO - warning: no files found matching '*.txt' 05:03:33 INFO - no previously-included directories found matching 'build' 05:03:33 INFO - no previously-included directories found matching 'dist' 05:03:33 INFO - no previously-included directories found matching '.git*' 05:03:33 INFO - Installing collected packages: jsonschema, functools32 05:03:34 INFO - Running setup.py install for functools32 05:03:34 INFO - warning: no files found matching '*.txt' 05:03:34 INFO - no previously-included directories found matching 'build' 05:03:34 INFO - no previously-included directories found matching 'dist' 05:03:34 INFO - no previously-included directories found matching '.git*' 05:03:34 INFO - Successfully installed jsonschema functools32 05:03:34 INFO - Cleaning up... 05:03:34 INFO - Return code: 0 05:03:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10717fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107214618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6484ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e3d30>, '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 0x106e48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070dbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:03:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:03:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 05:03:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:34 INFO - 'HOME': '/Users/cltbld', 05:03:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:34 INFO - 'LOGNAME': 'cltbld', 05:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:34 INFO - 'MOZ_NO_REMOTE': '1', 05:03:34 INFO - 'NO_EM_RESTART': '1', 05:03:34 INFO - 'PAGER': '/bin/cat', 05:03:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:34 INFO - 'PWD': '/builds/slave/test', 05:03:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:34 INFO - 'SHELL': '/bin/bash', 05:03:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 05:03:34 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 05:03:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:34 INFO - 'USER': 'cltbld', 05:03:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:34 INFO - 'XPC_FLAGS': '0x0', 05:03:34 INFO - 'XPC_SERVICE_NAME': '0', 05:03:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:34 INFO - Downloading/unpacking blobuploader==1.2.4 05:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:03:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:03:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:03:37 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 05:03:37 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 05:03:37 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 05:03:37 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 05:03:37 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 05:03:37 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 05:03:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:03:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:03:37 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 05:03:37 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 05:03:37 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 05:03:37 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 05:03:37 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 05:03:37 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 05:03:38 INFO - Downloading docopt-0.6.1.tar.gz 05:03:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:03:38 INFO - Installing collected packages: blobuploader, requests, docopt 05:03:38 INFO - Running setup.py install for blobuploader 05:03:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:03:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:03:38 INFO - Running setup.py install for requests 05:03:38 INFO - Running setup.py install for docopt 05:03:39 INFO - Successfully installed blobuploader requests docopt 05:03:39 INFO - Cleaning up... 05:03:39 INFO - Return code: 0 05:03:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:39 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 0x10717fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107214618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6484ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e3d30>, '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 0x106e48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070dbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:39 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 05:03:39 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 05:03:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 05:03:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:39 INFO - 'HOME': '/Users/cltbld', 05:03:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:39 INFO - 'LOGNAME': 'cltbld', 05:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:39 INFO - 'MOZ_NO_REMOTE': '1', 05:03:39 INFO - 'NO_EM_RESTART': '1', 05:03:39 INFO - 'PAGER': '/bin/cat', 05:03:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:39 INFO - 'PWD': '/builds/slave/test', 05:03:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:39 INFO - 'SHELL': '/bin/bash', 05:03:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 05:03:39 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 05:03:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:39 INFO - 'USER': 'cltbld', 05:03:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:39 INFO - 'XPC_FLAGS': '0x0', 05:03:39 INFO - 'XPC_SERVICE_NAME': '0', 05:03:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:39 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-bK7o30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:39 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-d2iBN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:39 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-A_0nW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:39 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-R1B6ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:39 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-0_AiSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:39 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-1axQlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:39 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-jePucd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:40 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-dYDfbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:40 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-d6oJ9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:40 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-NXX2v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:40 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-eGGel5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:40 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-CPvpOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:40 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-pCxTZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:40 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-FRIUdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:40 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-kxj_OQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:40 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-zkyL5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:41 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-Vijrh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:03:41 INFO - Running setup.py install for manifestparser 05:03:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:03:41 INFO - Running setup.py install for mozcrash 05:03:41 INFO - Running setup.py install for mozdebug 05:03:41 INFO - Running setup.py install for mozdevice 05:03:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:03:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:03:41 INFO - Running setup.py install for mozfile 05:03:41 INFO - Running setup.py install for mozhttpd 05:03:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:03:42 INFO - Running setup.py install for mozinfo 05:03:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:03:42 INFO - Running setup.py install for mozInstall 05:03:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:03:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:03:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:03:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:03:42 INFO - Running setup.py install for mozleak 05:03:42 INFO - Running setup.py install for mozlog 05:03:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:03:42 INFO - Running setup.py install for moznetwork 05:03:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:03:42 INFO - Running setup.py install for mozprocess 05:03:42 INFO - Running setup.py install for mozprofile 05:03:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:03:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:03:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:03:43 INFO - Running setup.py install for mozrunner 05:03:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:03:43 INFO - Running setup.py install for mozscreenshot 05:03:43 INFO - Running setup.py install for moztest 05:03:43 INFO - Running setup.py install for mozversion 05:03:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:03:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:03:43 INFO - Cleaning up... 05:03:43 INFO - Return code: 0 05:03:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:43 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')]} 05:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:43 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')]} 05:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:43 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 0x10717fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107214618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6484ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e3d30>, '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 0x106e48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070dbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:43 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 05:03:43 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 05:03:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 05:03:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:43 INFO - 'HOME': '/Users/cltbld', 05:03:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:43 INFO - 'LOGNAME': 'cltbld', 05:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:43 INFO - 'MOZ_NO_REMOTE': '1', 05:03:43 INFO - 'NO_EM_RESTART': '1', 05:03:43 INFO - 'PAGER': '/bin/cat', 05:03:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:43 INFO - 'PWD': '/builds/slave/test', 05:03:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:43 INFO - 'SHELL': '/bin/bash', 05:03:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 05:03:43 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 05:03:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:43 INFO - 'USER': 'cltbld', 05:03:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:43 INFO - 'XPC_FLAGS': '0x0', 05:03:43 INFO - 'XPC_SERVICE_NAME': '0', 05:03:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:43 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-ly7c0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:44 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)) 05:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:44 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-KRfyj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:44 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)) 05:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:44 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-xRbBII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:44 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)) 05:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:44 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-MJigsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:44 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)) 05:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:44 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-TV4LdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:44 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)) 05:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:44 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-IkTZmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:44 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)) 05:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:44 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-Dw8f9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:44 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)) 05:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:44 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-_RUu6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:44 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)) 05:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:44 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-5DUYp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:44 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)) 05:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:44 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-sph4q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:45 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)) 05:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:45 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-lAPBCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:45 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)) 05:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:45 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-V4J1HI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:45 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)) 05:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:45 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-AQT5Kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:45 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)) 05:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:45 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-sukF75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:45 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)) 05:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:45 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-Fw1Sxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:45 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)) 05:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:45 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-O5UO1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:45 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)) 05:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:45 INFO - Running setup.py (path:/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/pip-hNsXtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:45 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)) 05:03:45 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)) 05:03:45 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)) 05:03:45 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)) 05:03:45 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)) 05:03:45 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)) 05:03:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:03:45 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 05:03:45 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 05:03:45 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 05:03:45 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 05:03:45 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 05:03:45 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 05:03:48 INFO - Downloading blessings-1.6.tar.gz 05:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:03:48 INFO - Installing collected packages: blessings 05:03:48 INFO - Running setup.py install for blessings 05:03:48 INFO - Successfully installed blessings 05:03:48 INFO - Cleaning up... 05:03:48 INFO - Return code: 0 05:03:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:03:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:03:48 INFO - Reading from file tmpfile_stdout 05:03:48 INFO - Current package versions: 05:03:48 INFO - blessings == 1.6 05:03:48 INFO - blobuploader == 1.2.4 05:03:48 INFO - docopt == 0.6.1 05:03:48 INFO - functools32 == 3.2.3-2 05:03:48 INFO - jsonschema == 2.5.1 05:03:48 INFO - manifestparser == 1.1 05:03:48 INFO - mozInstall == 1.12 05:03:48 INFO - mozcrash == 0.17 05:03:48 INFO - mozdebug == 0.1 05:03:48 INFO - mozdevice == 0.48 05:03:48 INFO - mozfile == 1.2 05:03:48 INFO - mozhttpd == 0.7 05:03:48 INFO - mozinfo == 0.9 05:03:48 INFO - mozleak == 0.1 05:03:48 INFO - mozlog == 3.2 05:03:48 INFO - moznetwork == 0.27 05:03:48 INFO - mozprocess == 0.23 05:03:48 INFO - mozprofile == 0.28 05:03:48 INFO - mozrunner == 6.12 05:03:48 INFO - mozscreenshot == 0.1 05:03:48 INFO - mozsystemmonitor == 0.3 05:03:48 INFO - moztest == 0.7 05:03:48 INFO - mozversion == 1.4 05:03:48 INFO - psutil == 3.1.1 05:03:48 INFO - requests == 1.2.3 05:03:48 INFO - wsgiref == 0.1.2 05:03:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10717fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107214618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6484ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e3d30>, '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 0x106e48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070dbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 05:03:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:49 INFO - 'HOME': '/Users/cltbld', 05:03:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:49 INFO - 'LOGNAME': 'cltbld', 05:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:49 INFO - 'MOZ_NO_REMOTE': '1', 05:03:49 INFO - 'NO_EM_RESTART': '1', 05:03:49 INFO - 'PAGER': '/bin/cat', 05:03:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:49 INFO - 'PWD': '/builds/slave/test', 05:03:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:49 INFO - 'SHELL': '/bin/bash', 05:03:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 05:03:49 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 05:03:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:49 INFO - 'USER': 'cltbld', 05:03:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:49 INFO - 'XPC_FLAGS': '0x0', 05:03:49 INFO - 'XPC_SERVICE_NAME': '0', 05:03:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:49 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)) 05:03:49 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)) 05:03:49 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)) 05:03:49 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)) 05:03:49 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)) 05:03:49 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)) 05:03:49 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)) 05:03:49 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)) 05:03:49 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)) 05:03:49 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)) 05:03:49 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)) 05:03:49 INFO - Cleaning up... 05:03:49 INFO - Return code: 0 05:03:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:49 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 0x10717fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107214618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6484ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e3d30>, '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 0x106e48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070dbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:03:49 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 05:03:49 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 05:03:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 05:03:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:49 INFO - 'HOME': '/Users/cltbld', 05:03:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:49 INFO - 'LOGNAME': 'cltbld', 05:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:49 INFO - 'MOZ_NO_REMOTE': '1', 05:03:49 INFO - 'NO_EM_RESTART': '1', 05:03:49 INFO - 'PAGER': '/bin/cat', 05:03:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:49 INFO - 'PWD': '/builds/slave/test', 05:03:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:49 INFO - 'SHELL': '/bin/bash', 05:03:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 05:03:49 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 05:03:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:49 INFO - 'USER': 'cltbld', 05:03:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:49 INFO - 'XPC_FLAGS': '0x0', 05:03:49 INFO - 'XPC_SERVICE_NAME': '0', 05:03:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:03:49 INFO - Cleaning up... 05:03:49 INFO - Return code: 0 05:03:49 INFO - Running post-action listener: _resource_record_post_action 05:03:49 INFO - Running post-action listener: _start_resource_monitoring 05:03:49 INFO - Starting resource monitoring. 05:03:49 INFO - ##### 05:03:49 INFO - ##### Finished create-virtualenv step (success) 05:03:49 INFO - ##### 05:03:49 INFO - ##### 05:03:49 INFO - ##### Running install step. 05:03:49 INFO - ##### 05:03:49 INFO - Running pre-action listener: _resource_record_pre_action 05:03:49 INFO - Running main action method: install 05:03:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:03:50 INFO - Reading from file tmpfile_stdout 05:03:50 INFO - Detecting whether we're running mozinstall >=1.0... 05:03:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:03:50 INFO - Reading from file tmpfile_stdout 05:03:50 INFO - Output received: 05:03:50 INFO - Usage: mozinstall [options] installer 05:03:50 INFO - Options: 05:03:50 INFO - -h, --help show this help message and exit 05:03:50 INFO - -d DEST, --destination=DEST 05:03:50 INFO - Directory to install application into. [default: 05:03:50 INFO - "/builds/slave/test"] 05:03:50 INFO - --app=APP Application being installed. [default: firefox] 05:03:50 INFO - mkdir: /builds/slave/test/build/application 05:03:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:04:24 INFO - Reading from file tmpfile_stdout 05:04:24 INFO - Output received: 05:04:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:04:24 INFO - Running post-action listener: _resource_record_post_action 05:04:24 INFO - ##### 05:04:24 INFO - ##### Finished install step (success) 05:04:24 INFO - ##### 05:04:24 INFO - ##### 05:04:24 INFO - ##### Running run-tests step. 05:04:24 INFO - ##### 05:04:24 INFO - Running pre-action listener: _resource_record_pre_action 05:04:24 INFO - Running main action method: run_tests 05:04:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:04:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:04:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:04:24 INFO - 2016-07-08 05:04:24.244 screenresolution[1636:7509] starting screenresolution argv=screenresolution get 05:04:24 INFO - 2016-07-08 05:04:24.246 screenresolution[1636:7509] Display 0: 1600x1200x32@60 05:04:24 INFO - 2016-07-08 05:04:24.252 screenresolution[1637:7511] starting screenresolution argv=screenresolution list 05:04:24 INFO - Available Modes on Display 0 05:04:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:04:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:04:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:04:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:04:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:04:24 INFO - Intel Iris: 05:04:24 INFO - Chipset Model: Intel Iris 05:04:24 INFO - Type: GPU 05:04:24 INFO - Bus: Built-In 05:04:24 INFO - VRAM (Dynamic, Max): 1536 MB 05:04:24 INFO - Vendor: Intel (0x8086) 05:04:24 INFO - Device ID: 0x0a2e 05:04:24 INFO - Revision ID: 0x0009 05:04:24 INFO - Displays: 05:04:24 INFO - Display: 05:04:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:04:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:04:24 INFO - Display Serial Number: 1600x1200 60 05:04:24 INFO - Main Display: Yes 05:04:24 INFO - Mirror: Off 05:04:24 INFO - Online: Yes 05:04:24 INFO - Rotation: Supported 05:04:24 INFO - Return code: 0 05:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:04:24 INFO - Python 2.7.3 05:04:24 INFO - Return code: 0 05:04:24 INFO - grabbing minidump binary from tooltool 05:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:24 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/macosx64/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 0x1070e3d30>, '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 0x106e48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070dbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:04:24 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:04:24 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:04:24 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:04:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:04:24 INFO - Return code: 0 05:04:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:04:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:04:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:04:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:04:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0285', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0285 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:04:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P1CD7GS4EK/Render', 05:04:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:24 INFO - 'HOME': '/Users/cltbld', 05:04:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:24 INFO - 'LOGNAME': 'cltbld', 05:04:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:04:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:24 INFO - 'MOZ_NO_REMOTE': '1', 05:04:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:04:24 INFO - 'NO_EM_RESTART': '1', 05:04:24 INFO - 'PAGER': '/bin/cat', 05:04:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:24 INFO - 'PWD': '/builds/slave/test', 05:04:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:04:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:24 INFO - 'SHELL': '/bin/bash', 05:04:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners', 05:04:24 INFO - 'TMPDIR': '/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/', 05:04:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:24 INFO - 'USER': 'cltbld', 05:04:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:24 INFO - 'XPC_FLAGS': '0x0', 05:04:24 INFO - 'XPC_SERVICE_NAME': '0', 05:04:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0285', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:04:24 INFO - mozversion application_buildid: 20160708022626 05:04:24 INFO - mozversion application_changeset: 806cd7a7b68de8777caf419239e2f4e671aaa80b 05:04:24 INFO - mozversion application_display_name: Nightly 05:04:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:04:24 INFO - mozversion application_name: Firefox 05:04:24 INFO - mozversion application_remotingname: firefox 05:04:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:04:24 INFO - mozversion application_vendor: Mozilla 05:04:24 INFO - mozversion application_version: 50.0a1 05:04:24 INFO - mozversion platform_buildid: 20160708022626 05:04:24 INFO - mozversion platform_changeset: 806cd7a7b68de8777caf419239e2f4e671aaa80b 05:04:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:04:24 INFO - mozversion platform_version: 50.0a1 05:04:24 INFO - using testdate: 1467979464 05:04:24 INFO - actual date: 1467979464 05:04:24 INFO - starting webserver on 'localhost:49278' 05:04:24 INFO - SUITE-START | Running 2 tests 05:04:24 INFO - TEST-START | dromaeo_css 05:04:24 INFO - operating with platform_type : mac_ 05:04:24 INFO - Initialising browser for dromaeo_css test... 05:04:24 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmp54wVWu/profile http://localhost:49278/getInfo.html) 05:04:27 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 05:04:27 INFO - PROCESS | 1647 | colorDepth:24 05:04:27 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 05:04:27 INFO - PROCESS | 1647 | __metrics 05:04:27 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 05:04:28 INFO - TEST-INFO | 1647: exit 0 05:04:28 INFO - Browser initialized. 05:04:28 INFO - Running cycle 1/1 for dromaeo_css test... 05:04:28 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmp54wVWu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:40 INFO - PROCESS | 1653 | RSS: Main: 254398464 05:04:40 INFO - PROCESS | 1653 | 05:05:30 INFO - PROCESS | 1653 | 1467979530297 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] 05:07:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 05:07:42 INFO - PROCESS | 1653 | RSS: Main: 266829824 05:07:42 INFO - PROCESS | 1653 | 05:10:44 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 05:10:45 INFO - PROCESS | 1653 | RSS: Main: 275537920 05:10:45 INFO - PROCESS | 1653 | 05:13:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 05:13:47 INFO - PROCESS | 1653 | RSS: Main: 280010752 05:13:47 INFO - PROCESS | 1653 | 05:16:49 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 05:16:50 INFO - PROCESS | 1653 | RSS: Main: 279097344 05:16:50 INFO - PROCESS | 1653 | 05:19:52 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 05:19:53 INFO - PROCESS | 1653 | RSS: Main: 282669056 05:19:53 INFO - PROCESS | 1653 | 05:22:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 05:22:56 INFO - PROCESS | 1653 | RSS: Main: 282677248 05:22:56 INFO - PROCESS | 1653 | 05:22:56 INFO - PROCESS | 1653 | __start_tp_report 05:22:56 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 05:22:56 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 05:22:56 INFO - PROCESS | 1653 | |i|pagename|runs| 05:22:56 INFO - PROCESS | 1653 | |0;dojo.html;3399;3400.8809691660795;3425.606055303639;3437.0548099272696;3444.8277586120694;4750.667453278272;5814.447627475389;5929.703514824258;5940.67326297054;5953.315368732597;4386.495553011405;5113.590912726982;5578.44215578443;5681.914771278434;5881.705914704269;5192.532672059505;5237.711925844077;5290.391604965421;5356.009138309425;5380.892382152355;367.653971691529;4443.289073748201;5307.708076055816;5316.548093412064;5335.5198032177095;5259.789608415659;5267.578593712513;5311.362636483627;5322.627416080876;5329.440408757064;5218.9739051304505;5330.987112448623;5349.786008559653;5349.973250133763;5371.462853714636;4319.589638984291;5212.947870521284;5222.16445368743;5276.34045744282;5312.601554883399;4877.244027175793;5935.020721580934;5948.702564871739;5990.041593345044;5995.040793473024;6123.601965872204;6201.658908760016;6259.029850373199;6310.621362718206;6322.52581056418;6240.625562466221;6250.218722659668;6256.2492500899725;6267.62394256346;6273.780417685359;6022.735225602629;6026.758929642809;6027.7287522061615;6036.094585812163;6087.786927457518;6163.3528479509905;6238.438540531374;6278.529110316745;6368.203974503187;6405.3594640535575;6086.092056864447;6139.723712432951;6150.876982460415;6153.569250152446;6156.753729850756;6208.50331973441;6254.874902501924;6261.123442718023;6261.279952805395;6262.5616206866;5946.524278057745;6188.81433556994;6231.719572619152;6241.687915604201;6272.592281501779;6176.88816013122;6191.938080619227;6249.9062514062325;6271.310155882849;6278.811635650938;4921.729304888194;4962.578180854595;4976.552110310017;4987.650864439527;4989.077020751172;4442.133783912171;4445.466544014675;4453.487848897354;4469.21788686985;4523.457185137804;5865.706714664249;5871.794487192928;5911.76352945886;5974.133750606138;5976.073708575178;6285.842853928597;6294.590851594723;6296.496280297657;6304.65324407162;6323.494120470351;5745.798897038583;5941.1385349125;5963.821085367446;5986.640801551921;6007.098935159761;5489.670619762827;5517;5521.723913804293;5522.447755224445;5560.610757246954;6204.317525072329;6441.484681225491;6441.871162576722;6446.871062578723;6451.741930322734;6197.96901015492;6224.595401298901;6266.592671476522;6267.2165979252595;6302.338254483397;5422.539084177889;6329.683515824282;6363.395477429637;6389.105525226565;6395.5203359747275;5277.868053298698;6101.054336577838;6210.312610675629;6212.4408803207925;6342.460890824332;6189.1025801257665;6262.4990000800735;6265.906011409741;6269.216347956505;6298.874022519432;5183.481651834786;5300.231466437422;5806.82579522615;6125.509959203342;6220.626762394271;5350.598705097055;6036.7585296589405;6119.41115851624;6193.938060619516;6223.253209614875;4857.562819346276;4859.052484765437;5227.032998895216;5886.91092147954;6000.669963152069;5298.867528311823;6262.405071518198;6275.090111933653;6278.623282603058;6315.17902672668;5108.284840122312;5899.882002360015;6106.847328816815;6162.322144564184;6162.568620196544 05:22:56 INFO - PROCESS | 1653 | |1;ext.html;464.70259034218105;513.938327400712;533.8692020454988;548.8408361575143;582.0977484898407;39575.01062473436;42273.78863105688;42285.57714422855;42384.78807605958;42392;42440.57559424405;42521.78739106308;42993;43506;43515.782421087926;9620.663276785332;9775.657851975182;9785.412875227508;9838.36050656705;9838.655647052354;9693.709188724315;9740.853887191663;9753.024697530225;9782.706518804447;9791.216702663805;9767.267454940873;9803.31376803624;9830.459324737136;9839.754006149868;9842.507874606277;9756.560954757017;9787.021297870227;9795.657151999645;9799.755006124833;9812.116909478182;9729.513524323755;9762.023797620252;9765.072318129767;9818.754531136707;9826.656067037691;41097.383539246635;41384;41484.58515414837;41510;41535.7923210382;3190.441672707267;3448.655134486531;3485.2506711057245;3495.5980062292906;3574.821258937043;29361.265968350748;30843.537346939815;31952.360952781048;31977.840110799298;32409.027729168163;3149.4960806271115;3160.8419579020956;3166.3983843069973;3185.5540224368606;3287.227501537137;441573;443756;445332;447192;449207;33816.32367352639;34288;34359.141021474665;34365.48451773226;34374.31251374959;35444.468332975026;35695.28609427849;36275.81862090673;36702.8164859174;36749.44875826865;16998;17035.91482042582;17051.744223836653;17135.74296385555;17141.057241851817;12926.224426534438;13029.739405212033;13048.54330098442;13053.28206948627;13070.34648267602;20068.598628027357;20321.88229647354;20376.898115509328;20443.693344599844;20461.386158415273;7488.438367122488;7837.255460731221;8338.541380224146;8356.247937685515;8433.536155511505;909.8498747706554;981.9214462842956;1083.1767856429012;1091.476091476096;1139.0248034360025;25505.61741573878;27299.45401091967;28755.418451984922;30122;30671.38657226843;1004.4726518577805;1092.781443711245;1144.49070163778;1150.442035612727;1197.8622458417394;12338.753224935452;13737.793933091012;16222.918885405497;16373.672526549402;16555.006699598063;685984;687530;692222;693034;698129;61700.69149654223;61886;62191;62220.68889655613;62404.375956240765;1387.2300873015372;1434.6771976305456;1436.0450300550226;1448.3265281643876;1455.6433673749998;27890.442191156468;30502.237444063187;30628.08115756531;30928.845355773075;31045.844770776002;49012.26481602708;52126.69683257949;52879.94240115253;53189.20216196837;53230.40308790743;461008;486582;516220;522199;523515;25548.61677074808;27267;27826.44347113006;27990.58014129749;28009.43981120407;49648.255276170166;50655;51032.48967510278;51098;51680.74159629328;36446;41495;41550.584494154675;41759.7912010438;41951.160976780906;39244.23400946907;41365.172696546506;41559.46744526749;42006;42167.57832421637;38910.80544597259;38914;39085;39704.60295397009;39827;29758.85120574383;35310.29379412449;35573.93278201658;36039.27921441609;36097.917062488166;24693.259202223962;26173.607395888695;26475.735242647326;26657.333566660214;27628.723712763418 05:22:56 INFO - PROCESS | 1653 | |2;jquery.html;377.1645804542937;382.97510661806984;386.1369838411151;388.21580407576675;404.2864344432078;19576.11907464164;21417.250396236097;21634.89182554089;21689.783102168974;21851.78148218517;20406.489837754063;20618.587628247427;21192.57614847706;21489.355319340444;21597.67603485949;5735.311762588495;5863.120531920204;6049.788257410992;6064.484518815884;6103.298120716108;3913.1391093959282;5818.389069147721;6059.242594675666;6109.908351374733;6113.358097399776;6107.175531303262;6132.172156758847;6137.447629713325;6143.201383820097;6169.444749972502;5681.204631351614;6044.758209671608;6065;6099.664518451484;6104.877902441971;5829.7376618052285;5873.44202300785;5908.763649454017;5920.615160014629;5923;20797.480062998395;24109.758902410926;24209.273721788373;25373.746262537323;25390.238292851245;2180;2240.708707867983;2272.977270227293;2950.27718209038;3035.3322269100763;10405.167586593054;11365.829512557319;13387.062905596613;15462.304196311194;16014.199290035569;1884.5100273928877;1890.5273681579606;1896.4784684211813;1914.9425517234506;1929.5947850951177;110689;113421;113430;114839;123230.9999999991;11510.53957841677;11519.942400287944;11617.76764464706;11711.1802173847;11850.407479625985;14407.279636018156;14413.702766751043;14432.061915975639;14447.349869255908;14452.277386130652;7102.573845569283;8611;8661.523616201044;8734.912650873537;8834.469931804113;7087.468439867031;7234.493585448968;8709.608067636971;8781.165789250012;8855.690050848189;3474.652534746556;4253.787670513889;4351.303791393362;4516.593506584358;4645.651576131736;1799.442172926397;1840.6655174998286;1900.249401486405;1904.7143427886315;1995.630808300469;850.9702160424356;853.9188777066169;891.4889262699662;903.9322050846213;975.9756006099763;19472.415827525198;20712.067956941974;21115.577688446145;21254.06437371352;21260.78739212588;916.4821875640242;937.9015203403544;992.8659630949874;1001.7946321004176;1066.184368957748;10752.784944301227;11199.832002519968;11280;11302.265352752045;12254.632361029184;611541;613929;619780;620120;626790;119052;135527.261833432;135927.32036339756;139524.60475395116;142729;1019.413837043688;1036.264252380818;1056.3609016545033;1059.7933402986498;1067.3382502848283;16260.756088658443;19128.426147215607;19622;19708.704369434756;19753.604927901073;49707.75730606764;49764.253536196265;52311;53019.734901325246;54601.72699136479;65711.6714416444;77766.22233777816;86450.56774716087;90166;90248.743781406;6105.236845394325;6580.670966451754;6892.862142757217;7626.351760100453;7961.8407631848195;9033.593488293174;12307.75384492323;12552.811707824572;12615.93692031534;12758.936205319285;10603.204759643211;10746.979036991474;10802.67591972242;10888.45557722095;10976.23166378346;10691.625793097204;10734.409607471353;10743.623973160902;10744;10887.074598658886;11019.173561982723;11121.83317250258;11125.109991200847;11246.775064498828;11372.54509819598;6272.717727702356;7474.430369622441;7858;7963.243491868263;8052.597370131587;10515.106215971422;10986.890131098588;11007.944960275147;11115.166362523005;11150.888491115309 05:22:56 INFO - PROCESS | 1653 | |3;mootools.html;1380.7997840313155;1548.3496931288862;1703.4208369154485;1759.2699029902592;1903.1435853865755;8041.638126284317;8590.527520986343;8643.740687779376;9060.184583387494;9075.001749807525;7353.558786472815;8779.692710755126;8889.511076890769;8906.77733056674;8927.642894284221;2308.503671710582;2335.6146235871147;2337.824663150262;2343.7304709958316;2348.9765102349015;2294.6672732453785;2311.075569772088;2334.6264597664376;2345.7771511706446;2347.2371479269223;2317.617593097137;2323.6863023491865;2323.756005619411;2329.359426157812;2330.3707998840305;2301.148575027234;2304.2511183865226;2316.2124877541632;2318.8376813623054;2323.721153461587;2309.2841219222096;2310.1567927706433;2318.9912388111056;2320.1067588978367;2326;9003.954980225122;9006.324525660537;9031.954840225757;9065.909340906639;9096.408733432305;5250.9737451312885;5398.2982212312545;5401.972990135064;5403.756830942617;5412.512873841334;3497.5453191085;3555.839987200582;3658.0489072840987;3659;3666.3034023535442;1059.2003037706559;1073.313079629038;1099.2689861242263;1109.2457129152174;1112.8998390144925;11479.483423245974;11624.593139240085;11651.359175245443;11701.946824785726;11734.826517348281;4638.512956139624;4645.976770116195;4828.927566086511;4851.466338702739;4852.733099679552;9860.013998600227;9943.850842237372;9944.651937182163;9954.701358959242;9971.551280192409;5371.892562148735;5418.674879507243;5421.376541697677;5421.83734487966;5423.945760542423;4033.858814941522;4432.468103827497;4759.952400476021;4919.385076865392;4967.180415231519;3953.6244056814558;3995.9001024974027;4039.6364327210104;4069.8168582413864;4103.343465045578;1070.721612380771;1216.3614102596207;1251.8748125187408;1258.3771033338373;1259.1563652352945;954.3176628710366;963.0610155098863;964.744342749172;967.4195482710318;988.2933702402817;5956.195913551615;6089.391060893875;6199.783007594712;6242.938700420939;6243.0635404688755;451.9548045195454;455.39432554702165;459.7011942237572;469.3804178484436;471.1613328275606;4198.916021679611;4240.257954857949;4291.485021797342;4413.558644135561;4475.910481790346;9593.568289426992;10717.78564428707;10915.126789856793;10976.286541374786;11113.277636953571;10900.727481813017;10997;11006.504707288192;11009.2843965142;11040.889591104147;7906.209379062163;8234.176582341837;8365.038020627584;8376.204260595234;8388.832223355499;6182.412670796267;6244.2819075806865;6272.874542509216;6373.5857169283845;6466.418022378009;10064.597416103567;10310.175185985254;10455.372677639367;10487.370757754254;10522.263441559018;10218.948905255724;10456.47717614101;10481.004304591052;10629.20280978945;10685.465726713788;7093.929060709327;7513.661885215288;7639.732609358646;7772.067351917806;7782.338501227233;6665.13353264092;8613.569321534023;8677.696280630147;8711.47731136134;8843.646254149762;7546.735864244944;7698.576578288248;7748.728794492165;7798.142204357403;7823.765287041398;7461;7528.962355188189;7569.659365328684;7666.734988727021;7732.574708391093;6623.569467984566;6666.166729158856;6701.128853249046;6761.492888033516;6766.661666916733;4673.369095172108;5065.56942659878;5106.66806657566;5260.789568417374;5291.470852914677;4247.702660813837;5230;5249.107651699144;5303.973480132575;5392.245085687929 05:22:56 INFO - PROCESS | 1653 | |4;prototype.html;276.2582466078579;312.2287948766546;312.29577303181316;316.0912376916364;317.4793338924163;5688.459596338341;5729.484346408827;5751.683657398841;5769.451902069307;5769.596128271018;4561.863144105674;5604.579656525767;5638.887222255553;5650.943490565093;5701.546105743029;4053.2906741320226;4142.399352093945;4214.641755450791;4224.683148763839;4253.766042867641;4171.456561072408;4218.725782824122;4231.851885184019;4238.449001629784;4257.936130958038;4181.393697913801;4215.262329092412;4264;4267.338562522798;4285.378620100084;3950.644442000234;4181.644560212355;4195.181939521794;4251.638610718092;4381.058072514393;3584.5160903277983;3586.4261718124976;3631.654992775682;3641.599424063351;3689.262147570497;4875.731834749087;5165.690058596496;5517.282753242052;5541.093529062002;5615.578831587647;4540.6594505411895;4797.664163508556;4916.778744956486;4933.950660493385;4949.282354058677;5932.872754176693;5945.346011938684;5959.910601340984;5983.09819737427;6023.397660233942;4028.8776198446144;4042.454268673721;4046.2312160689376;4046.817893194813;4065.5527891931865;5476.972615136939;6253.843653908643;6301.275353334334;6327.114204011442;6361.2048493938255;3429.7084747796216;4036.475258216472;4062.984253936516;4074.8370065197655;4078.7960601969785;4131.814068366931;4143.730657507313;4153.833846646161;4161.9803148228875;4166.458360413127;4062.4515690382013;4700.153972285021;4845.3216549683075;4864.464908860023;4881.803958030306;5962.135490353874;6031.819045428644;6049.334573196945;6061.515078793686;6107.633541987495;1358.381936219018;1372.8627137286192;1401.4464286606733;1407.4869515271125;1410.3230449384353;782.5187509681505;801.3989507869098;848.8429640516524;865.0959747064333;870.4516154822421;5517.972410137923;5595.160725891067;5596.58025648078;5626.662400255997;5630.71846407678;5093.312402825572;5835.270591176103;6135.5398345124295;6217.409346112112;6225.011994242789;5177.585793136615;5184.429712731597;5527.5577953764405;5539.612227144142;5613.691246981455;3075.646300675406;3237.368713100923;3258.185453636591;3259.282957749291;3299.191698033997;5012.974935125301;5786.797462088806;6298.339228970529;6301.684915754286;6349.365063493706;4967.801287948441;5432.212329212242;6263;6264.968675156595;6266.780662676784;5148.665336753099;5968.313643930916;6326.9683651581445;6340.682965851781;6358.364163583605;4566.967699373747;5333.040052790379;5623;5676.574256930664;6059.575829692056;5317.787288508416;5826.970865145817;6084.269887613515;6141.539384546088;6157.661328626789;5924.4300260430155;5992.26224394938;6264.561480696308;6288.478452066857;6292.402221788922;3272.7381809455665;3674.5590529135607;3961.148353103981;4023.5372932113182;4030.979845100756;4747.003129342738;5725.971370143289;6068.969655151696;6076.513878889767;6147.44672979434;4532.682712210114;5265.078611243094;5404.945950540444;5913.58604897653;5958.880822383615;5796.9420305798085;5815.79644712433;5818.650880946987;5843.80857178558;5872.882542349214;4524.185646583646;4613;5020.071286811952;5086.3896332440345;5216.321878155815;5439.755211015593;5483.369412517612;6024.246969128859;6040.426159514839;6085.261632265409;4756.096341695067;4959.7272150032095;5619.943800562106;5879.147523608967;5965.761369545169 05:22:56 INFO - PROCESS | 1653 | |5;yui.html;640.6860638287237;675.8749631318206;706.3360441185282;790.9011373578303;863.2921004776084;15295.541133765977;15941.123238221893;15957.361705531779;15984.280707368167;16074.437394691187;11367.886321136786;14205.857941420583;14797.186154761484;14819.18494482803;14828.6292842679;710.0485349631492;902.2736696958946;918.8529835226365;922.2437601167046;923.3905622289291;896.090468174803;935.3405848876525;936.8126374725048;942.839717248066;944.7260294514617;901.085398320705;974.4202199691208;977.3598293117983;979.2802290316612;980.6224603527622;963.4845357733578;966.6036924860808;967.569431602937;968.9563969621383;980.3823591137538;587.2102022779355;617.2777849915609;699.7480906873521;720.7441358317826;725.9056322678018;15511.146886921215;15647.530574082795;15687.215639217993;15699.529014129594;15720.68558628821;14985.700285994328;15012.549623511311;15029.924850375679;15174.696506069928;15183.089014659156;10414;11896.345700986441;12109.939450302692;12363.196392234566;12457.93771031148;3567.518385018015;3861.4014827701753;3934.547527034399;4135.7518548886865;4141.151064031867;109308;109678;110375;110766;111689;11499.597514086967;11664.766704665859;11667.591634292929;11688.47401866918;12161.756764864653;23781.9298131581;24133;24171.75828241695;24194.790260487258;24198;7201.207867134611;8306.70926517581;8308.335333173332;8335.458195217292;8357.707480238163;4504.639628829751;4507.752073635916;4675.509071547439;4675.906481870344;4817.9518204818205;3567.8751243706347;3609.5848977367414;3672.8163591820303;3681.3189559931498;3710.220853620716;664.9534532582769;665.5241502325861;678.1082876018021;693.1924308181013;694.2952902803659;596.5593092681127;665.9600423974578;674.750342373325;683.4436035035231;687.9518433709692;8174.877376839352;8482.363822713321;8543.529306638675;9170.67902623405;9643.951780241194;533.6984603698897;613.3222788818381;664.1200409457488;674.5581644023173;679.4190966723479;4599.494055653875;4681.7190968542;4715.858524244278;4719.480857105716;4739.961816418973;133240;152407.71388429182;154699.22650386675;158034;158517;123564;138783.30608347096;139487;142920;143411;119252;120475.39762301132;120588;121020;121495.39252303682;7761.805954851174;8985.685501007434;9064;9125.634974600942;9239.491827949258;58860.70569647125;59535.70232148811;59843.40156598378;60219.79560408855;61442.69278653757;83907.16092839238;87602.56198718966;92790.53604731933;93058;93777;12107.697307567381;12171.452284647035;12184.390780461119;12203.633890983285;12837.29394883253;12811.487540498649;12868.22790632565;12957.546485872948;13406.128601640861;13407.32963351848;12419;12433;12476.937615311865;12638.115331926678;12899;9439.339246252697;9542.33203675736;9827.11555959967;9890.406575605486;9938.801223975624;12162.452689628812;12195.573154939535;12651.177673451197;12664.176828506486;12731.61805145847;9923.40459572428;10288.022637849392;10340.37957722539;10415.375077495375;10654.946725266323;10259.639653147233;10329.535170917477;10336.431496267778;10351.792964140826;10463.633772818219 05:22:56 INFO - PROCESS | 1653 | __end_tp_report 05:22:56 INFO - PROCESS | 1653 | __start_cc_report 05:22:56 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,435 05:22:56 INFO - PROCESS | 1653 | __end_cc_report 05:22:56 INFO - PROCESS | 1653 | __startTimestamp1467980576508__endTimestamp 05:22:56 INFO - PROCESS | 1653 | 05:22:56 INFO - PROCESS | 1653 | ------- Summary: start ------- 05:22:56 INFO - PROCESS | 1653 | Number of tests: 6 05:22:56 INFO - PROCESS | 1653 | 05:22:56 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5703.54 Median:5995.04 stddev:795.67 (13.3%) stddev-sans-first:777.30 05:22:56 INFO - PROCESS | 1653 | Values: 3399.0 3400.9 3425.6 3437.1 3444.8 4750.7 5814.4 5929.7 5940.7 5953.3 4386.5 5113.6 5578.4 5681.9 5881.7 5192.5 5237.7 5290.4 5356.0 5380.9 367.7 4443.3 5307.7 5316.5 5335.5 5259.8 5267.6 5311.4 5322.6 5329.4 5219.0 5331.0 5349.8 5350.0 5371.5 4319.6 5212.9 5222.2 5276.3 5312.6 4877.2 5935.0 5948.7 5990.0 5995.0 6123.6 6201.7 6259.0 6310.6 6322.5 6240.6 6250.2 6256.2 6267.6 6273.8 6022.7 6026.8 6027.7 6036.1 6087.8 6163.4 6238.4 6278.5 6368.2 6405.4 6086.1 6139.7 6150.9 6153.6 6156.8 6208.5 6254.9 6261.1 6261.3 6262.6 5946.5 6188.8 6231.7 6241.7 6272.6 6176.9 6191.9 6249.9 6271.3 6278.8 4921.7 4962.6 4976.6 4987.7 4989.1 4442.1 4445.5 4453.5 4469.2 4523.5 5865.7 5871.8 5911.8 5974.1 5976.1 6285.8 6294.6 6296.5 6304.7 6323.5 5745.8 5941.1 5963.8 5986.6 6007.1 5489.7 5517.0 5521.7 5522.4 5560.6 6204.3 6441.5 6441.9 6446.9 6451.7 6198.0 6224.6 6266.6 6267.2 6302.3 5422.5 6329.7 6363.4 6389.1 6395.5 5277.9 6101.1 6210.3 6212.4 6342.5 6189.1 6262.5 6265.9 6269.2 6298.9 5183.5 5300.2 5806.8 6125.5 6220.6 5350.6 6036.8 6119.4 6193.9 6223.3 4857.6 4859.1 5227.0 5886.9 6000.7 5298.9 6262.4 6275.1 6278.6 6315.2 5108.3 5899.9 6106.8 6162.3 6162.6 05:22:56 INFO - PROCESS | 1653 | 05:22:56 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:67580.49 Median:40462.19 stddev:148867.92 (367.9%) stddev-sans-first:149200.25 05:22:56 INFO - PROCESS | 1653 | Values: 464.7 513.9 533.9 548.8 582.1 39575.0 42273.8 42285.6 42384.8 42392.0 42440.6 42521.8 42993.0 43506.0 43515.8 9620.7 9775.7 9785.4 9838.4 9838.7 9693.7 9740.9 9753.0 9782.7 9791.2 9767.3 9803.3 9830.5 9839.8 9842.5 9756.6 9787.0 9795.7 9799.8 9812.1 9729.5 9762.0 9765.1 9818.8 9826.7 41097.4 41384.0 41484.6 41510.0 41535.8 3190.4 3448.7 3485.3 3495.6 3574.8 29361.3 30843.5 31952.4 31977.8 32409.0 3149.5 3160.8 3166.4 3185.6 3287.2 441573.0 443756.0 445332.0 447192.0 449207.0 33816.3 34288.0 34359.1 34365.5 34374.3 35444.5 35695.3 36275.8 36702.8 36749.4 16998.0 17035.9 17051.7 17135.7 17141.1 12926.2 13029.7 13048.5 13053.3 13070.3 20068.6 20321.9 20376.9 20443.7 20461.4 7488.4 7837.3 8338.5 8356.2 8433.5 909.8 981.9 1083.2 1091.5 1139.0 25505.6 27299.5 28755.4 30122.0 30671.4 1004.5 1092.8 1144.5 1150.4 1197.9 12338.8 13737.8 16222.9 16373.7 16555.0 685984.0 687530.0 692222.0 693034.0 698129.0 61700.7 61886.0 62191.0 62220.7 62404.4 1387.2 1434.7 1436.0 1448.3 1455.6 27890.4 30502.2 30628.1 30928.8 31045.8 49012.3 52126.7 52879.9 53189.2 53230.4 461008.0 486582.0 516220.0 522199.0 523515.0 25548.6 27267.0 27826.4 27990.6 28009.4 49648.3 50655.0 51032.5 51098.0 51680.7 36446.0 41495.0 41550.6 41759.8 41951.2 39244.2 41365.2 41559.5 42006.0 42167.6 38910.8 38914.0 39085.0 39704.6 39827.0 29758.9 35310.3 35573.9 36039.3 36097.9 24693.3 26173.6 26475.7 26657.3 27628.7 05:22:56 INFO - PROCESS | 1653 | 05:22:56 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:35801.53 Median:11934.89 stddev:103202.73 (864.7%) stddev-sans-first:103457.96 05:22:56 INFO - PROCESS | 1653 | Values: 377.2 383.0 386.1 388.2 404.3 19576.1 21417.3 21634.9 21689.8 21851.8 20406.5 20618.6 21192.6 21489.4 21597.7 5735.3 5863.1 6049.8 6064.5 6103.3 3913.1 5818.4 6059.2 6109.9 6113.4 6107.2 6132.2 6137.4 6143.2 6169.4 5681.2 6044.8 6065.0 6099.7 6104.9 5829.7 5873.4 5908.8 5920.6 5923.0 20797.5 24109.8 24209.3 25373.7 25390.2 2180.0 2240.7 2273.0 2950.3 3035.3 10405.2 11365.8 13387.1 15462.3 16014.2 1884.5 1890.5 1896.5 1914.9 1929.6 110689.0 113421.0 113430.0 114839.0 123231.0 11510.5 11519.9 11617.8 11711.2 11850.4 14407.3 14413.7 14432.1 14447.3 14452.3 7102.6 8611.0 8661.5 8734.9 8834.5 7087.5 7234.5 8709.6 8781.2 8855.7 3474.7 4253.8 4351.3 4516.6 4645.7 1799.4 1840.7 1900.2 1904.7 1995.6 851.0 853.9 891.5 903.9 976.0 19472.4 20712.1 21115.6 21254.1 21260.8 916.5 937.9 992.9 1001.8 1066.2 10752.8 11199.8 11280.0 11302.3 12254.6 611541.0 613929.0 619780.0 620120.0 626790.0 119052.0 135527.3 135927.3 139524.6 142729.0 1019.4 1036.3 1056.4 1059.8 1067.3 16260.8 19128.4 19622.0 19708.7 19753.6 49707.8 49764.3 52311.0 53019.7 54601.7 65711.7 77766.2 86450.6 90166.0 90248.7 6105.2 6580.7 6892.9 7626.4 7961.8 9033.6 12307.8 12552.8 12615.9 12758.9 10603.2 10747.0 10802.7 10888.5 10976.2 10691.6 10734.4 10743.6 10744.0 10887.1 11019.2 11121.8 11125.1 11246.8 11372.5 6272.7 7474.4 7858.0 7963.2 8052.6 10515.1 10986.9 11007.9 11115.2 11150.9 05:22:56 INFO - PROCESS | 1653 | 05:22:56 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5785.54 Median:4794.44 stddev:3272.47 (68.3%) stddev-sans-first:3264.91 05:22:56 INFO - PROCESS | 1653 | Values: 1380.8 1548.3 1703.4 1759.3 1903.1 8041.6 8590.5 8643.7 9060.2 9075.0 7353.6 8779.7 8889.5 8906.8 8927.6 2308.5 2335.6 2337.8 2343.7 2349.0 2294.7 2311.1 2334.6 2345.8 2347.2 2317.6 2323.7 2323.8 2329.4 2330.4 2301.1 2304.3 2316.2 2318.8 2323.7 2309.3 2310.2 2319.0 2320.1 2326.0 9004.0 9006.3 9032.0 9065.9 9096.4 5251.0 5398.3 5402.0 5403.8 5412.5 3497.5 3555.8 3658.0 3659.0 3666.3 1059.2 1073.3 1099.3 1109.2 1112.9 11479.5 11624.6 11651.4 11701.9 11734.8 4638.5 4646.0 4828.9 4851.5 4852.7 9860.0 9943.9 9944.7 9954.7 9971.6 5371.9 5418.7 5421.4 5421.8 5423.9 4033.9 4432.5 4760.0 4919.4 4967.2 3953.6 3995.9 4039.6 4069.8 4103.3 1070.7 1216.4 1251.9 1258.4 1259.2 954.3 963.1 964.7 967.4 988.3 5956.2 6089.4 6199.8 6242.9 6243.1 452.0 455.4 459.7 469.4 471.2 4198.9 4240.3 4291.5 4413.6 4475.9 9593.6 10717.8 10915.1 10976.3 11113.3 10900.7 10997.0 11006.5 11009.3 11040.9 7906.2 8234.2 8365.0 8376.2 8388.8 6182.4 6244.3 6272.9 6373.6 6466.4 10064.6 10310.2 10455.4 10487.4 10522.3 10218.9 10456.5 10481.0 10629.2 10685.5 7093.9 7513.7 7639.7 7772.1 7782.3 6665.1 8613.6 8677.7 8711.5 8843.6 7546.7 7698.6 7748.7 7798.1 7823.8 7461.0 7529.0 7569.7 7666.7 7732.6 6623.6 6666.2 6701.1 6761.5 6766.7 4673.4 5065.6 5106.7 5260.8 5291.5 4247.7 5230.0 5249.1 5304.0 5392.2 05:22:56 INFO - PROCESS | 1653 | 05:22:56 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4769.10 Median:5325.41 stddev:1478.16 (27.8%) stddev-sans-first:1443.32 05:22:56 INFO - PROCESS | 1653 | Values: 276.3 312.2 312.3 316.1 317.5 5688.5 5729.5 5751.7 5769.5 5769.6 4561.9 5604.6 5638.9 5650.9 5701.5 4053.3 4142.4 4214.6 4224.7 4253.8 4171.5 4218.7 4231.9 4238.4 4257.9 4181.4 4215.3 4264.0 4267.3 4285.4 3950.6 4181.6 4195.2 4251.6 4381.1 3584.5 3586.4 3631.7 3641.6 3689.3 4875.7 5165.7 5517.3 5541.1 5615.6 4540.7 4797.7 4916.8 4934.0 4949.3 5932.9 5945.3 5959.9 5983.1 6023.4 4028.9 4042.5 4046.2 4046.8 4065.6 5477.0 6253.8 6301.3 6327.1 6361.2 3429.7 4036.5 4063.0 4074.8 4078.8 4131.8 4143.7 4153.8 4162.0 4166.5 4062.5 4700.2 4845.3 4864.5 4881.8 5962.1 6031.8 6049.3 6061.5 6107.6 1358.4 1372.9 1401.4 1407.5 1410.3 782.5 801.4 848.8 865.1 870.5 5518.0 5595.2 5596.6 5626.7 5630.7 5093.3 5835.3 6135.5 6217.4 6225.0 5177.6 5184.4 5527.6 5539.6 5613.7 3075.6 3237.4 3258.2 3259.3 3299.2 5013.0 5786.8 6298.3 6301.7 6349.4 4967.8 5432.2 6263.0 6265.0 6266.8 5148.7 5968.3 6327.0 6340.7 6358.4 4567.0 5333.0 5623.0 5676.6 6059.6 5317.8 5827.0 6084.3 6141.5 6157.7 5924.4 5992.3 6264.6 6288.5 6292.4 3272.7 3674.6 3961.1 4023.5 4031.0 4747.0 5726.0 6069.0 6076.5 6147.4 4532.7 5265.1 5404.9 5913.6 5958.9 5796.9 5815.8 5818.7 5843.8 5872.9 4524.2 4613.0 5020.1 5086.4 5216.3 5439.8 5483.4 6024.2 6040.4 6085.3 4756.1 4959.7 5619.9 5879.1 5965.8 05:22:56 INFO - PROCESS | 1653 | 05:22:56 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:25250.63 Median:3897.97 stddev:41123.58 (1055.0%) stddev-sans-first:41197.43 05:22:56 INFO - PROCESS | 1653 | Values: 640.7 675.9 706.3 790.9 863.3 15295.5 15941.1 15957.4 15984.3 16074.4 11367.9 14205.9 14797.2 14819.2 14828.6 710.0 902.3 918.9 922.2 923.4 896.1 935.3 936.8 942.8 944.7 901.1 974.4 977.4 979.3 980.6 963.5 966.6 967.6 969.0 980.4 587.2 617.3 699.7 720.7 725.9 15511.1 15647.5 15687.2 15699.5 15720.7 14985.7 15012.5 15029.9 15174.7 15183.1 10414.0 11896.3 12109.9 12363.2 12457.9 3567.5 3861.4 3934.5 4135.8 4141.2 109308.0 109678.0 110375.0 110766.0 111689.0 11499.6 11664.8 11667.6 11688.5 12161.8 23781.9 24133.0 24171.8 24194.8 24198.0 7201.2 8306.7 8308.3 8335.5 8357.7 4504.6 4507.8 4675.5 4675.9 4818.0 3567.9 3609.6 3672.8 3681.3 3710.2 665.0 665.5 678.1 693.2 694.3 596.6 666.0 674.8 683.4 688.0 8174.9 8482.4 8543.5 9170.7 9644.0 533.7 613.3 664.1 674.6 679.4 4599.5 4681.7 4715.9 4719.5 4740.0 133240.0 152407.7 154699.2 158034.0 158517.0 123564.0 138783.3 139487.0 142920.0 143411.0 119252.0 120475.4 120588.0 121020.0 121495.4 7761.8 8985.7 9064.0 9125.6 9239.5 58860.7 59535.7 59843.4 60219.8 61442.7 83907.2 87602.6 92790.5 93058.0 93777.0 12107.7 12171.5 12184.4 12203.6 12837.3 12811.5 12868.2 12957.5 13406.1 13407.3 12419.0 12433.0 12476.9 12638.1 12899.0 9439.3 9542.3 9827.1 9890.4 9938.8 12162.5 12195.6 12651.2 12664.2 12731.6 9923.4 10288.0 10340.4 10415.4 10654.9 10259.6 10329.5 10336.4 10351.8 10463.6 05:22:56 INFO - PROCESS | 1653 | -------- Summary: end -------- 05:22:56 INFO - PROCESS | 1653 | 05:22:57 INFO - TEST-INFO | 1653: exit 0 05:22:57 INFO - TEST-OK | dromaeo_css | took 1112266ms 05:22:57 INFO - TEST-START | kraken 05:22:57 INFO - operating with platform_type : mac_ 05:22:57 INFO - Initialising browser for kraken test... 05:22:57 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmpuh9fxG/profile http://localhost:49278/getInfo.html) 05:23:00 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 05:23:00 INFO - PROCESS | 1662 | colorDepth:24 05:23:00 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 05:23:00 INFO - PROCESS | 1662 | __metrics 05:23:00 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 05:23:00 INFO - TEST-INFO | 1662: exit 0 05:23:00 INFO - Browser initialized. 05:23:00 INFO - Running cycle 1/1 for kraken test... 05:23:00 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/tmpuh9fxG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:13 INFO - PROCESS | 1664 | RSS: Main: 253751296 05:23:13 INFO - PROCESS | 1664 | 05:23:15 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 05:23:16 INFO - PROCESS | 1664 | RSS: Main: 266690560 05:23:16 INFO - PROCESS | 1664 | 05:23:19 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 05:23:19 INFO - PROCESS | 1664 | RSS: Main: 270819328 05:23:19 INFO - PROCESS | 1664 | 05:23:23 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 05:23:23 INFO - PROCESS | 1664 | RSS: Main: 271007744 05:23:23 INFO - PROCESS | 1664 | 05:23:25 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 05:23:26 INFO - PROCESS | 1664 | RSS: Main: 271929344 05:23:26 INFO - PROCESS | 1664 | 05:23:28 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:23:29 INFO - PROCESS | 1664 | RSS: Main: 272461824 05:23:29 INFO - PROCESS | 1664 | 05:23:31 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 05:23:32 INFO - PROCESS | 1664 | RSS: Main: 272199680 05:23:32 INFO - PROCESS | 1664 | 05:23:35 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 05:23:35 INFO - PROCESS | 1664 | RSS: Main: 273080320 05:23:35 INFO - PROCESS | 1664 | 05:23:39 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 05:23:39 INFO - PROCESS | 1664 | RSS: Main: 273666048 05:23:39 INFO - PROCESS | 1664 | 05:23:41 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:23:42 INFO - PROCESS | 1664 | RSS: Main: 272797696 05:23:42 INFO - PROCESS | 1664 | 05:23:43 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:23:44 INFO - PROCESS | 1664 | RSS: Main: 272744448 05:23:44 INFO - PROCESS | 1664 | 05:23:46 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:23:47 INFO - PROCESS | 1664 | RSS: Main: 272920576 05:23:47 INFO - PROCESS | 1664 | 05:23:50 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:23:50 INFO - PROCESS | 1664 | RSS: Main: 273125376 05:23:50 INFO - PROCESS | 1664 | 05:23:53 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:23:54 INFO - PROCESS | 1664 | RSS: Main: 273162240 05:23:54 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 05:23:56 INFO - PROCESS | 1664 | RSS: Main: 274120704 05:23:56 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | __start_tp_report 05:23:56 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 05:23:56 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 05:23:56 INFO - PROCESS | 1664 | |i|pagename|runs| 05:23:56 INFO - PROCESS | 1664 | |0;ai-astar;102;117;105;136;119;120;114;117;117;117 05:23:56 INFO - PROCESS | 1664 | |1;audio-beat-detection;149;111;130;152;119;165;156;108;156;114 05:23:56 INFO - PROCESS | 1664 | |2;audio-dft;200;198;194;202;247;193;259;287;247;211 05:23:56 INFO - PROCESS | 1664 | |3;audio-fft;76;82;75;142;58;59;59;66;132;52 05:23:56 INFO - PROCESS | 1664 | |4;audio-oscillator;70;73;122;69;71;90;112;69;73;112 05:23:56 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;89;87;89;86;89;85;88;86;88;86 05:23:56 INFO - PROCESS | 1664 | |6;imaging-darkroom;95;96;95;116;94;95;96;98;95;96 05:23:56 INFO - PROCESS | 1664 | |7;imaging-desaturate;97;102;140;151;94;129;148;102;141;144 05:23:56 INFO - PROCESS | 1664 | |8;json-parse-financial;46;47;59;70;79;58;58;56;57;58 05:23:56 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;67;69;67;74;81;81;69;67;70;70 05:23:56 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;86;90;88;88;85;87;86;84;88;85 05:23:56 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;142;141;140;139;140;140;141;144;183;143 05:23:56 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;189;184;184;203;186;187;182;183;181;187 05:23:56 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;73;68;70;71;69;68;71;69;68;70 05:23:56 INFO - PROCESS | 1664 | __end_tp_report 05:23:56 INFO - PROCESS | 1664 | __start_cc_report 05:23:56 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1112 05:23:56 INFO - PROCESS | 1664 | __end_cc_report 05:23:56 INFO - PROCESS | 1664 | __startTimestamp1467980636507__endTimestamp 05:23:56 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | ------- Summary: start ------- 05:23:56 INFO - PROCESS | 1664 | Number of tests: 14 05:23:56 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:116.40 Median:117.00 stddev:9.12 (7.8%) stddev-sans-first:8.05 05:23:56 INFO - PROCESS | 1664 | Values: 102.0 117.0 105.0 136.0 119.0 120.0 114.0 117.0 117.0 117.0 05:23:56 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:150.50 stddev:21.82 (14.5%) stddev-sans-first:22.63 05:23:56 INFO - PROCESS | 1664 | Values: 149.0 111.0 130.0 152.0 119.0 165.0 156.0 108.0 156.0 114.0 05:23:56 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:223.80 Median:229.00 stddev:33.36 (14.6%) stddev-sans-first:34.26 05:23:56 INFO - PROCESS | 1664 | Values: 200.0 198.0 194.0 202.0 247.0 193.0 259.0 287.0 247.0 211.0 05:23:56 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:80.10 Median:62.50 stddev:31.52 (50.4%) stddev-sans-first:33.39 05:23:56 INFO - PROCESS | 1664 | Values: 76.0 82.0 75.0 142.0 58.0 59.0 59.0 66.0 132.0 52.0 05:23:56 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:86.10 Median:70.50 stddev:21.24 (30.1%) stddev-sans-first:21.72 05:23:56 INFO - PROCESS | 1664 | Values: 70.0 73.0 122.0 69.0 71.0 90.0 112.0 69.0 73.0 112.0 05:23:56 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:88.00 stddev:1.49 (1.7%) stddev-sans-first:1.45 05:23:56 INFO - PROCESS | 1664 | Values: 89.0 87.0 89.0 86.0 89.0 85.0 88.0 86.0 88.0 86.0 05:23:56 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:97.60 Median:95.50 stddev:6.55 (6.9%) stddev-sans-first:6.88 05:23:56 INFO - PROCESS | 1664 | Values: 95.0 96.0 95.0 116.0 94.0 95.0 96.0 98.0 95.0 96.0 05:23:56 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:124.80 Median:146.00 stddev:23.25 (15.9%) stddev-sans-first:22.38 05:23:56 INFO - PROCESS | 1664 | Values: 97.0 102.0 140.0 151.0 94.0 129.0 148.0 102.0 141.0 144.0 05:23:56 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:58.00 stddev:9.72 (16.8%) stddev-sans-first:9.13 05:23:56 INFO - PROCESS | 1664 | Values: 46.0 47.0 59.0 70.0 79.0 58.0 58.0 56.0 57.0 58.0 05:23:56 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:70.00 stddev:5.42 (7.7%) stddev-sans-first:5.50 05:23:56 INFO - PROCESS | 1664 | Values: 67.0 69.0 67.0 74.0 81.0 81.0 69.0 67.0 70.0 70.0 05:23:56 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.50 stddev:1.83 (2.1%) stddev-sans-first:1.92 05:23:56 INFO - PROCESS | 1664 | Values: 86.0 90.0 88.0 88.0 85.0 87.0 86.0 84.0 88.0 85.0 05:23:56 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:141.50 stddev:13.33 (9.4%) stddev-sans-first:14.09 05:23:56 INFO - PROCESS | 1664 | Values: 142.0 141.0 140.0 139.0 140.0 140.0 141.0 144.0 183.0 143.0 05:23:56 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.60 Median:186.50 stddev:6.28 (3.4%) stddev-sans-first:6.60 05:23:56 INFO - PROCESS | 1664 | Values: 189.0 184.0 184.0 203.0 186.0 187.0 182.0 183.0 181.0 187.0 05:23:56 INFO - PROCESS | 1664 | 05:23:56 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.64 (2.3%) stddev-sans-first:1.22 05:23:56 INFO - PROCESS | 1664 | Values: 73.0 68.0 70.0 71.0 69.0 68.0 71.0 69.0 68.0 70.0 05:23:56 INFO - PROCESS | 1664 | -------- Summary: end -------- 05:23:56 INFO - PROCESS | 1664 | 05:23:57 INFO - TEST-INFO | 1664: exit 0 05:23:57 INFO - TEST-OK | kraken | took 60229ms 05:23:57 INFO - SUITE-END | took 1172s 05:23:57 INFO - Completed test suite (00:19:32) 05:23:57 INFO - javascript benchmark 05:23:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7409.18352156437, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3399.0, 3400.8809691660795, 3425.606055303639, 3437.0548099272696, 3444.8277586120694, 4750.667453278272, 5814.447627475389, 5929.703514824258, 5940.67326297054, 5953.315368732597, 4386.495553011405, 5113.590912726982, 5578.44215578443, 5681.914771278434, 5881.705914704269, 5192.532672059505, 5237.711925844077, 5290.391604965421, 5356.009138309425, 5380.892382152355, 367.653971691529, 4443.289073748201, 5307.708076055816, 5316.548093412064, 5335.5198032177095, 5259.789608415659, 5267.578593712513, 5311.362636483627, 5322.627416080876, 5329.440408757064, 5218.9739051304505, 5330.987112448623, 5349.786008559653, 5349.973250133763, 5371.462853714636, 4319.589638984291, 5212.947870521284, 5222.16445368743, 5276.34045744282, 5312.601554883399, 4877.244027175793, 5935.020721580934, 5948.702564871739, 5990.041593345044, 5995.040793473024, 6123.601965872204, 6201.658908760016, 6259.029850373199, 6310.621362718206, 6322.52581056418, 6240.625562466221, 6250.218722659668, 6256.2492500899725, 6267.62394256346, 6273.780417685359, 6022.735225602629, 6026.758929642809, 6027.7287522061615, 6036.094585812163, 6087.786927457518, 6163.3528479509905, 6238.438540531374, 6278.529110316745, 6368.203974503187, 6405.3594640535575, 6086.092056864447, 6139.723712432951, 6150.876982460415, 6153.569250152446, 6156.753729850756, 6208.50331973441, 6254.874902501924, 6261.123442718023, 6261.279952805395, 6262.5616206866, 5946.524278057745, 6188.81433556994, 6231.719572619152, 6241.687915604201, 6272.592281501779, 6176.88816013122, 6191.938080619227, 6249.9062514062325, 6271.310155882849, 6278.811635650938, 4921.729304888194, 4962.578180854595, 4976.552110310017, 4987.650864439527, 4989.077020751172, 4442.133783912171, 4445.466544014675, 4453.487848897354, 4469.21788686985, 4523.457185137804, 5865.706714664249, 5871.794487192928, 5911.76352945886, 5974.133750606138, 5976.073708575178, 6285.842853928597, 6294.590851594723, 6296.496280297657, 6304.65324407162, 6323.494120470351, 5745.798897038583, 5941.1385349125, 5963.821085367446, 5986.640801551921, 6007.098935159761, 5489.670619762827, 5517.0, 5521.723913804293, 5522.447755224445, 5560.610757246954, 6204.317525072329, 6441.484681225491, 6441.871162576722, 6446.871062578723, 6451.741930322734, 6197.96901015492, 6224.595401298901, 6266.592671476522, 6267.2165979252595, 6302.338254483397, 5422.539084177889, 6329.683515824282, 6363.395477429637, 6389.105525226565, 6395.5203359747275, 5277.868053298698, 6101.054336577838, 6210.312610675629, 6212.4408803207925, 6342.460890824332, 6189.1025801257665, 6262.4990000800735, 6265.906011409741, 6269.216347956505, 6298.874022519432, 5183.481651834786, 5300.231466437422, 5806.82579522615, 6125.509959203342, 6220.626762394271, 5350.598705097055, 6036.7585296589405, 6119.41115851624, 6193.938060619516, 6223.253209614875, 4857.562819346276, 4859.052484765437, 5227.032998895216, 5886.91092147954, 6000.669963152069, 5298.867528311823, 6262.405071518198, 6275.090111933653, 6278.623282603058, 6315.17902672668, 5108.284840122312, 5899.882002360015, 6106.847328816815, 6162.322144564184, 6162.568620196544], "value": 5656.627122588934, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.70259034218105, 513.938327400712, 533.8692020454988, 548.8408361575143, 582.0977484898407, 39575.01062473436, 42273.78863105688, 42285.57714422855, 42384.78807605958, 42392.0, 42440.57559424405, 42521.78739106308, 42993.0, 43506.0, 43515.782421087926, 9620.663276785332, 9775.657851975182, 9785.412875227508, 9838.36050656705, 9838.655647052354, 9693.709188724315, 9740.853887191663, 9753.024697530225, 9782.706518804447, 9791.216702663805, 9767.267454940873, 9803.31376803624, 9830.459324737136, 9839.754006149868, 9842.507874606277, 9756.560954757017, 9787.021297870227, 9795.657151999645, 9799.755006124833, 9812.116909478182, 9729.513524323755, 9762.023797620252, 9765.072318129767, 9818.754531136707, 9826.656067037691, 41097.383539246635, 41384.0, 41484.58515414837, 41510.0, 41535.7923210382, 3190.441672707267, 3448.655134486531, 3485.2506711057245, 3495.5980062292906, 3574.821258937043, 29361.265968350748, 30843.537346939815, 31952.360952781048, 31977.840110799298, 32409.027729168163, 3149.4960806271115, 3160.8419579020956, 3166.3983843069973, 3185.5540224368606, 3287.227501537137, 441573.0, 443756.0, 445332.0, 447192.0, 449207.0, 33816.32367352639, 34288.0, 34359.141021474665, 34365.48451773226, 34374.31251374959, 35444.468332975026, 35695.28609427849, 36275.81862090673, 36702.8164859174, 36749.44875826865, 16998.0, 17035.91482042582, 17051.744223836653, 17135.74296385555, 17141.057241851817, 12926.224426534438, 13029.739405212033, 13048.54330098442, 13053.28206948627, 13070.34648267602, 20068.598628027357, 20321.88229647354, 20376.898115509328, 20443.693344599844, 20461.386158415273, 7488.438367122488, 7837.255460731221, 8338.541380224146, 8356.247937685515, 8433.536155511505, 909.8498747706554, 981.9214462842956, 1083.1767856429012, 1091.476091476096, 1139.0248034360025, 25505.61741573878, 27299.45401091967, 28755.418451984922, 30122.0, 30671.38657226843, 1004.4726518577805, 1092.781443711245, 1144.49070163778, 1150.442035612727, 1197.8622458417394, 12338.753224935452, 13737.793933091012, 16222.918885405497, 16373.672526549402, 16555.006699598063, 685984.0, 687530.0, 692222.0, 693034.0, 698129.0, 61700.69149654223, 61886.0, 62191.0, 62220.68889655613, 62404.375956240765, 1387.2300873015372, 1434.6771976305456, 1436.0450300550226, 1448.3265281643876, 1455.6433673749998, 27890.442191156468, 30502.237444063187, 30628.08115756531, 30928.845355773075, 31045.844770776002, 49012.26481602708, 52126.69683257949, 52879.94240115253, 53189.20216196837, 53230.40308790743, 461008.0, 486582.0, 516220.0, 522199.0, 523515.0, 25548.61677074808, 27267.0, 27826.44347113006, 27990.58014129749, 28009.43981120407, 49648.255276170166, 50655.0, 51032.48967510278, 51098.0, 51680.74159629328, 36446.0, 41495.0, 41550.584494154675, 41759.7912010438, 41951.160976780906, 39244.23400946907, 41365.172696546506, 41559.46744526749, 42006.0, 42167.57832421637, 38910.80544597259, 38914.0, 39085.0, 39704.60295397009, 39827.0, 29758.85120574383, 35310.29379412449, 35573.93278201658, 36039.27921441609, 36097.917062488166, 24693.259202223962, 26173.607395888695, 26475.735242647326, 26657.333566660214, 27628.723712763418], "value": 19817.74622048008, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.1645804542937, 382.97510661806984, 386.1369838411151, 388.21580407576675, 404.2864344432078, 19576.11907464164, 21417.250396236097, 21634.89182554089, 21689.783102168974, 21851.78148218517, 20406.489837754063, 20618.587628247427, 21192.57614847706, 21489.355319340444, 21597.67603485949, 5735.311762588495, 5863.120531920204, 6049.788257410992, 6064.484518815884, 6103.298120716108, 3913.1391093959282, 5818.389069147721, 6059.242594675666, 6109.908351374733, 6113.358097399776, 6107.175531303262, 6132.172156758847, 6137.447629713325, 6143.201383820097, 6169.444749972502, 5681.204631351614, 6044.758209671608, 6065.0, 6099.664518451484, 6104.877902441971, 5829.7376618052285, 5873.44202300785, 5908.763649454017, 5920.615160014629, 5923.0, 20797.480062998395, 24109.758902410926, 24209.273721788373, 25373.746262537323, 25390.238292851245, 2180.0, 2240.708707867983, 2272.977270227293, 2950.27718209038, 3035.3322269100763, 10405.167586593054, 11365.829512557319, 13387.062905596613, 15462.304196311194, 16014.199290035569, 1884.5100273928877, 1890.5273681579606, 1896.4784684211813, 1914.9425517234506, 1929.5947850951177, 110689.0, 113421.0, 113430.0, 114839.0, 123230.9999999991, 11510.53957841677, 11519.942400287944, 11617.76764464706, 11711.1802173847, 11850.407479625985, 14407.279636018156, 14413.702766751043, 14432.061915975639, 14447.349869255908, 14452.277386130652, 7102.573845569283, 8611.0, 8661.523616201044, 8734.912650873537, 8834.469931804113, 7087.468439867031, 7234.493585448968, 8709.608067636971, 8781.165789250012, 8855.690050848189, 3474.652534746556, 4253.787670513889, 4351.303791393362, 4516.593506584358, 4645.651576131736, 1799.442172926397, 1840.6655174998286, 1900.249401486405, 1904.7143427886315, 1995.630808300469, 850.9702160424356, 853.9188777066169, 891.4889262699662, 903.9322050846213, 975.9756006099763, 19472.415827525198, 20712.067956941974, 21115.577688446145, 21254.06437371352, 21260.78739212588, 916.4821875640242, 937.9015203403544, 992.8659630949874, 1001.7946321004176, 1066.184368957748, 10752.784944301227, 11199.832002519968, 11280.0, 11302.265352752045, 12254.632361029184, 611541.0, 613929.0, 619780.0, 620120.0, 626790.0, 119052.0, 135527.261833432, 135927.32036339756, 139524.60475395116, 142729.0, 1019.413837043688, 1036.264252380818, 1056.3609016545033, 1059.7933402986498, 1067.3382502848283, 16260.756088658443, 19128.426147215607, 19622.0, 19708.704369434756, 19753.604927901073, 49707.75730606764, 49764.253536196265, 52311.0, 53019.734901325246, 54601.72699136479, 65711.6714416444, 77766.22233777816, 86450.56774716087, 90166.0, 90248.743781406, 6105.236845394325, 6580.670966451754, 6892.862142757217, 7626.351760100453, 7961.8407631848195, 9033.593488293174, 12307.75384492323, 12552.811707824572, 12615.93692031534, 12758.936205319285, 10603.204759643211, 10746.979036991474, 10802.67591972242, 10888.45557722095, 10976.23166378346, 10691.625793097204, 10734.409607471353, 10743.623973160902, 10744.0, 10887.074598658886, 11019.173561982723, 11121.83317250258, 11125.109991200847, 11246.775064498828, 11372.54509819598, 6272.717727702356, 7474.430369622441, 7858.0, 7963.243491868263, 8052.597370131587, 10515.106215971422, 10986.890131098588, 11007.944960275147, 11115.166362523005, 11150.888491115309], "value": 9641.148927173708, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.7997840313155, 1548.3496931288862, 1703.4208369154485, 1759.2699029902592, 1903.1435853865755, 8041.638126284317, 8590.527520986343, 8643.740687779376, 9060.184583387494, 9075.001749807525, 7353.558786472815, 8779.692710755126, 8889.511076890769, 8906.77733056674, 8927.642894284221, 2308.503671710582, 2335.6146235871147, 2337.824663150262, 2343.7304709958316, 2348.9765102349015, 2294.6672732453785, 2311.075569772088, 2334.6264597664376, 2345.7771511706446, 2347.2371479269223, 2317.617593097137, 2323.6863023491865, 2323.756005619411, 2329.359426157812, 2330.3707998840305, 2301.148575027234, 2304.2511183865226, 2316.2124877541632, 2318.8376813623054, 2323.721153461587, 2309.2841219222096, 2310.1567927706433, 2318.9912388111056, 2320.1067588978367, 2326.0, 9003.954980225122, 9006.324525660537, 9031.954840225757, 9065.909340906639, 9096.408733432305, 5250.9737451312885, 5398.2982212312545, 5401.972990135064, 5403.756830942617, 5412.512873841334, 3497.5453191085, 3555.839987200582, 3658.0489072840987, 3659.0, 3666.3034023535442, 1059.2003037706559, 1073.313079629038, 1099.2689861242263, 1109.2457129152174, 1112.8998390144925, 11479.483423245974, 11624.593139240085, 11651.359175245443, 11701.946824785726, 11734.826517348281, 4638.512956139624, 4645.976770116195, 4828.927566086511, 4851.466338702739, 4852.733099679552, 9860.013998600227, 9943.850842237372, 9944.651937182163, 9954.701358959242, 9971.551280192409, 5371.892562148735, 5418.674879507243, 5421.376541697677, 5421.83734487966, 5423.945760542423, 4033.858814941522, 4432.468103827497, 4759.952400476021, 4919.385076865392, 4967.180415231519, 3953.6244056814558, 3995.9001024974027, 4039.6364327210104, 4069.8168582413864, 4103.343465045578, 1070.721612380771, 1216.3614102596207, 1251.8748125187408, 1258.3771033338373, 1259.1563652352945, 954.3176628710366, 963.0610155098863, 964.744342749172, 967.4195482710318, 988.2933702402817, 5956.195913551615, 6089.391060893875, 6199.783007594712, 6242.938700420939, 6243.0635404688755, 451.9548045195454, 455.39432554702165, 459.7011942237572, 469.3804178484436, 471.1613328275606, 4198.916021679611, 4240.257954857949, 4291.485021797342, 4413.558644135561, 4475.910481790346, 9593.568289426992, 10717.78564428707, 10915.126789856793, 10976.286541374786, 11113.277636953571, 10900.727481813017, 10997.0, 11006.504707288192, 11009.2843965142, 11040.889591104147, 7906.209379062163, 8234.176582341837, 8365.038020627584, 8376.204260595234, 8388.832223355499, 6182.412670796267, 6244.2819075806865, 6272.874542509216, 6373.5857169283845, 6466.418022378009, 10064.597416103567, 10310.175185985254, 10455.372677639367, 10487.370757754254, 10522.263441559018, 10218.948905255724, 10456.47717614101, 10481.004304591052, 10629.20280978945, 10685.465726713788, 7093.929060709327, 7513.661885215288, 7639.732609358646, 7772.067351917806, 7782.338501227233, 6665.13353264092, 8613.569321534023, 8677.696280630147, 8711.47731136134, 8843.646254149762, 7546.735864244944, 7698.576578288248, 7748.728794492165, 7798.142204357403, 7823.765287041398, 7461.0, 7528.962355188189, 7569.659365328684, 7666.734988727021, 7732.574708391093, 6623.569467984566, 6666.166729158856, 6701.128853249046, 6761.492888033516, 6766.661666916733, 4673.369095172108, 5065.56942659878, 5106.66806657566, 5260.789568417374, 5291.470852914677, 4247.702660813837, 5230.0, 5249.107651699144, 5303.973480132575, 5392.245085687929], "value": 4563.237528209756, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.2582466078579, 312.2287948766546, 312.29577303181316, 316.0912376916364, 317.4793338924163, 5688.459596338341, 5729.484346408827, 5751.683657398841, 5769.451902069307, 5769.596128271018, 4561.863144105674, 5604.579656525767, 5638.887222255553, 5650.943490565093, 5701.546105743029, 4053.2906741320226, 4142.399352093945, 4214.641755450791, 4224.683148763839, 4253.766042867641, 4171.456561072408, 4218.725782824122, 4231.851885184019, 4238.449001629784, 4257.936130958038, 4181.393697913801, 4215.262329092412, 4264.0, 4267.338562522798, 4285.378620100084, 3950.644442000234, 4181.644560212355, 4195.181939521794, 4251.638610718092, 4381.058072514393, 3584.5160903277983, 3586.4261718124976, 3631.654992775682, 3641.599424063351, 3689.262147570497, 4875.731834749087, 5165.690058596496, 5517.282753242052, 5541.093529062002, 5615.578831587647, 4540.6594505411895, 4797.664163508556, 4916.778744956486, 4933.950660493385, 4949.282354058677, 5932.872754176693, 5945.346011938684, 5959.910601340984, 5983.09819737427, 6023.397660233942, 4028.8776198446144, 4042.454268673721, 4046.2312160689376, 4046.817893194813, 4065.5527891931865, 5476.972615136939, 6253.843653908643, 6301.275353334334, 6327.114204011442, 6361.2048493938255, 3429.7084747796216, 4036.475258216472, 4062.984253936516, 4074.8370065197655, 4078.7960601969785, 4131.814068366931, 4143.730657507313, 4153.833846646161, 4161.9803148228875, 4166.458360413127, 4062.4515690382013, 4700.153972285021, 4845.3216549683075, 4864.464908860023, 4881.803958030306, 5962.135490353874, 6031.819045428644, 6049.334573196945, 6061.515078793686, 6107.633541987495, 1358.381936219018, 1372.8627137286192, 1401.4464286606733, 1407.4869515271125, 1410.3230449384353, 782.5187509681505, 801.3989507869098, 848.8429640516524, 865.0959747064333, 870.4516154822421, 5517.972410137923, 5595.160725891067, 5596.58025648078, 5626.662400255997, 5630.71846407678, 5093.312402825572, 5835.270591176103, 6135.5398345124295, 6217.409346112112, 6225.011994242789, 5177.585793136615, 5184.429712731597, 5527.5577953764405, 5539.612227144142, 5613.691246981455, 3075.646300675406, 3237.368713100923, 3258.185453636591, 3259.282957749291, 3299.191698033997, 5012.974935125301, 5786.797462088806, 6298.339228970529, 6301.684915754286, 6349.365063493706, 4967.801287948441, 5432.212329212242, 6263.0, 6264.968675156595, 6266.780662676784, 5148.665336753099, 5968.313643930916, 6326.9683651581445, 6340.682965851781, 6358.364163583605, 4566.967699373747, 5333.040052790379, 5623.0, 5676.574256930664, 6059.575829692056, 5317.787288508416, 5826.970865145817, 6084.269887613515, 6141.539384546088, 6157.661328626789, 5924.4300260430155, 5992.26224394938, 6264.561480696308, 6288.478452066857, 6292.402221788922, 3272.7381809455665, 3674.5590529135607, 3961.148353103981, 4023.5372932113182, 4030.979845100756, 4747.003129342738, 5725.971370143289, 6068.969655151696, 6076.513878889767, 6147.44672979434, 4532.682712210114, 5265.078611243094, 5404.945950540444, 5913.58604897653, 5958.880822383615, 5796.9420305798085, 5815.79644712433, 5818.650880946987, 5843.80857178558, 5872.882542349214, 4524.185646583646, 4613.0, 5020.071286811952, 5086.3896332440345, 5216.321878155815, 5439.755211015593, 5483.369412517612, 6024.246969128859, 6040.426159514839, 6085.261632265409, 4756.096341695067, 4959.7272150032095, 5619.943800562106, 5879.147523608967, 5965.761369545169], "value": 4286.351205182513, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.6860638287237, 675.8749631318206, 706.3360441185282, 790.9011373578303, 863.2921004776084, 15295.541133765977, 15941.123238221893, 15957.361705531779, 15984.280707368167, 16074.437394691187, 11367.886321136786, 14205.857941420583, 14797.186154761484, 14819.18494482803, 14828.6292842679, 710.0485349631492, 902.2736696958946, 918.8529835226365, 922.2437601167046, 923.3905622289291, 896.090468174803, 935.3405848876525, 936.8126374725048, 942.839717248066, 944.7260294514617, 901.085398320705, 974.4202199691208, 977.3598293117983, 979.2802290316612, 980.6224603527622, 963.4845357733578, 966.6036924860808, 967.569431602937, 968.9563969621383, 980.3823591137538, 587.2102022779355, 617.2777849915609, 699.7480906873521, 720.7441358317826, 725.9056322678018, 15511.146886921215, 15647.530574082795, 15687.215639217993, 15699.529014129594, 15720.68558628821, 14985.700285994328, 15012.549623511311, 15029.924850375679, 15174.696506069928, 15183.089014659156, 10414.0, 11896.345700986441, 12109.939450302692, 12363.196392234566, 12457.93771031148, 3567.518385018015, 3861.4014827701753, 3934.547527034399, 4135.7518548886865, 4141.151064031867, 109308.0, 109678.0, 110375.0, 110766.0, 111689.0, 11499.597514086967, 11664.766704665859, 11667.591634292929, 11688.47401866918, 12161.756764864653, 23781.9298131581, 24133.0, 24171.75828241695, 24194.790260487258, 24198.0, 7201.207867134611, 8306.70926517581, 8308.335333173332, 8335.458195217292, 8357.707480238163, 4504.639628829751, 4507.752073635916, 4675.509071547439, 4675.906481870344, 4817.9518204818205, 3567.8751243706347, 3609.5848977367414, 3672.8163591820303, 3681.3189559931498, 3710.220853620716, 664.9534532582769, 665.5241502325861, 678.1082876018021, 693.1924308181013, 694.2952902803659, 596.5593092681127, 665.9600423974578, 674.750342373325, 683.4436035035231, 687.9518433709692, 8174.877376839352, 8482.363822713321, 8543.529306638675, 9170.67902623405, 9643.951780241194, 533.6984603698897, 613.3222788818381, 664.1200409457488, 674.5581644023173, 679.4190966723479, 4599.494055653875, 4681.7190968542, 4715.858524244278, 4719.480857105716, 4739.961816418973, 133240.0, 152407.71388429182, 154699.22650386675, 158034.0, 158517.0, 123564.0, 138783.30608347096, 139487.0, 142920.0, 143411.0, 119252.0, 120475.39762301132, 120588.0, 121020.0, 121495.39252303682, 7761.805954851174, 8985.685501007434, 9064.0, 9125.634974600942, 9239.491827949258, 58860.70569647125, 59535.70232148811, 59843.40156598378, 60219.79560408855, 61442.69278653757, 83907.16092839238, 87602.56198718966, 92790.53604731933, 93058.0, 93777.0, 12107.697307567381, 12171.452284647035, 12184.390780461119, 12203.633890983285, 12837.29394883253, 12811.487540498649, 12868.22790632565, 12957.546485872948, 13406.128601640861, 13407.32963351848, 12419.0, 12433.0, 12476.937615311865, 12638.115331926678, 12899.0, 9439.339246252697, 9542.33203675736, 9827.11555959967, 9890.406575605486, 9938.801223975624, 12162.452689628812, 12195.573154939535, 12651.177673451197, 12664.176828506486, 12731.61805145847, 9923.40459572428, 10288.022637849392, 10340.37957722539, 10415.375077495375, 10654.946725266323, 10259.639653147233, 10329.535170917477, 10336.431496267778, 10351.792964140826, 10463.633772818219], "value": 7824.861406276954, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1570.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 117.0, 105.0, 136.0, 119.0, 120.0, 114.0, 117.0, 117.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 111.0, 130.0, 152.0, 119.0, 165.0, 156.0, 108.0, 156.0, 114.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 198.0, 194.0, 202.0, 247.0, 193.0, 259.0, 287.0, 247.0, 211.0], "value": 223.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 75.0, 142.0, 58.0, 59.0, 59.0, 66.0, 132.0, 52.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 122.0, 69.0, 71.0, 90.0, 112.0, 69.0, 73.0, 112.0], "value": 86.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 86.0, 89.0, 85.0, 88.0, 86.0, 88.0, 86.0], "value": 87.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 116.0, 94.0, 95.0, 96.0, 98.0, 95.0, 96.0], "value": 97.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 102.0, 140.0, 151.0, 94.0, 129.0, 148.0, 102.0, 141.0, 144.0], "value": 124.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 47.0, 59.0, 70.0, 79.0, 58.0, 58.0, 56.0, 57.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 74.0, 81.0, 81.0, 69.0, 67.0, 70.0, 70.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 88.0, 88.0, 85.0, 87.0, 86.0, 84.0, 88.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 141.0, 140.0, 139.0, 140.0, 140.0, 141.0, 144.0, 183.0, 143.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 184.0, 184.0, 203.0, 186.0, 187.0, 182.0, 183.0, 181.0, 187.0], "value": 186.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 68.0, 70.0, 71.0, 69.0, 68.0, 71.0, 69.0, 68.0, 70.0], "value": 69.7, "unit": "score"}]}]} 05:23:57 INFO - Return code: 0 05:23:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:23:57 ERROR - # TBPL SUCCESS # 05:23:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:23:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:23:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:23:57 INFO - 2016-07-08 05:23:57.805 screenresolution[1669:10356] starting screenresolution argv=screenresolution get 05:23:57 INFO - 2016-07-08 05:23:57.808 screenresolution[1669:10356] Display 0: 1600x1200x32@60 05:23:57 INFO - 2016-07-08 05:23:57.814 screenresolution[1670:10359] starting screenresolution argv=screenresolution list 05:23:57 INFO - Available Modes on Display 0 05:23:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:23:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:23:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:23:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:23:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:23:58 INFO - Intel Iris: 05:23:58 INFO - Chipset Model: Intel Iris 05:23:58 INFO - Type: GPU 05:23:58 INFO - Bus: Built-In 05:23:58 INFO - VRAM (Dynamic, Max): 1536 MB 05:23:58 INFO - Vendor: Intel (0x8086) 05:23:58 INFO - Device ID: 0x0a2e 05:23:58 INFO - Revision ID: 0x0009 05:23:58 INFO - Displays: 05:23:58 INFO - Display: 05:23:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:23:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:23:58 INFO - Display Serial Number: 1600x1200 60 05:23:58 INFO - Main Display: Yes 05:23:58 INFO - Mirror: Off 05:23:58 INFO - Online: Yes 05:23:58 INFO - Rotation: Supported 05:23:58 INFO - Return code: 0 05:23:58 INFO - Running post-action listener: _resource_record_post_action 05:23:58 INFO - ##### 05:23:58 INFO - ##### Finished run-tests step (success) 05:23:58 INFO - ##### 05:23:58 INFO - Running post-run listener: _resource_record_post_run 05:23:58 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 37037568; Write bytes: 707753472; Read time: 240; Write time: 2027 05:23:58 INFO - TinderboxPrint: CPU usage
54.5% 05:23:58 INFO - TinderboxPrint: I/O read bytes / time
37,037,568 / 240 05:23:58 INFO - TinderboxPrint: I/O write bytes / time
707,753,472 / 2,027 05:23:58 INFO - TinderboxPrint: CPU idle
2,197.5 (45.5%) 05:23:58 INFO - TinderboxPrint: CPU system
979.0 (20.3%) 05:23:58 INFO - TinderboxPrint: CPU user
1,653.1 (34.2%) 05:23:58 INFO - TinderboxPrint: Swap in / out
444,047,360 / 0 05:23:58 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 400912896; Write bytes: 395859968; Read time: 29386; Write time: 868 05:23:58 INFO - run-tests - Wall time: 1174s; CPU: 55.0%; Read bytes: 34973184; Write bytes: 296226304; Read time: 221; Write time: 1117 05:23:58 INFO - Running post-run listener: _upload_blobber_files 05:23:58 INFO - Blob upload gear active. 05:23:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:23:58 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 05:23:58 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:23:58 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:23:58 INFO - (blobuploader) - INFO - Open directory for files ... 05:23:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:23:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:23:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:59 INFO - (blobuploader) - INFO - Done attempting. 05:23:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:23:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:24:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:00 INFO - (blobuploader) - INFO - Done attempting. 05:24:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:24:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:24:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:02 INFO - (blobuploader) - INFO - Done attempting. 05:24:02 INFO - (blobuploader) - INFO - Iteration through files over. 05:24:02 INFO - Return code: 0 05:24:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:24:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:24:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f993f632725b47427f3900cae2bd9ef8d22aebd7ebc0cd5cc25f40474030036f328e335969da63b07bc5fa8831bebf7ac2ece606ef9483e86339769df83c04d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/123ce50e616436d52832216a99b07ba84065e00ddbacecb39aa4396da5a2b00b6757662e563fbbc2dab13a6d290ed63ecd3a0de3d2a2e90a2f32615aaefc25e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/077300516c3f9e4a1ee0ecdb46635773c02bc0b5d5bf3cdb8dad66c7e46d764314290c1381e9e919c2d4bc5ef73129854be7e7a056c22aba20e9cd70443c8905"} 05:24:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:24:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:24:02 INFO - Contents: 05:24:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f993f632725b47427f3900cae2bd9ef8d22aebd7ebc0cd5cc25f40474030036f328e335969da63b07bc5fa8831bebf7ac2ece606ef9483e86339769df83c04d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/123ce50e616436d52832216a99b07ba84065e00ddbacecb39aa4396da5a2b00b6757662e563fbbc2dab13a6d290ed63ecd3a0de3d2a2e90a2f32615aaefc25e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/077300516c3f9e4a1ee0ecdb46635773c02bc0b5d5bf3cdb8dad66c7e46d764314290c1381e9e919c2d4bc5ef73129854be7e7a056c22aba20e9cd70443c8905"} 05:24:02 INFO - Running post-run listener: copy_logs_to_upload_dir 05:24:02 INFO - Copying logs to upload dir... 05:24:02 INFO - mkdir: /builds/slave/test/build/upload/logs 05:24:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.059770 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-08 05:24:03.005970) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 05:24:03.009458) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P1CD7GS4EK/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f993f632725b47427f3900cae2bd9ef8d22aebd7ebc0cd5cc25f40474030036f328e335969da63b07bc5fa8831bebf7ac2ece606ef9483e86339769df83c04d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/123ce50e616436d52832216a99b07ba84065e00ddbacecb39aa4396da5a2b00b6757662e563fbbc2dab13a6d290ed63ecd3a0de3d2a2e90a2f32615aaefc25e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/077300516c3f9e4a1ee0ecdb46635773c02bc0b5d5bf3cdb8dad66c7e46d764314290c1381e9e919c2d4bc5ef73129854be7e7a056c22aba20e9cd70443c8905"} build_url:https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010928 build_url: 'https://queue.taskcluster.net/v1/task/Fbkl6XbOR62yrOVgwEKctA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f993f632725b47427f3900cae2bd9ef8d22aebd7ebc0cd5cc25f40474030036f328e335969da63b07bc5fa8831bebf7ac2ece606ef9483e86339769df83c04d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/123ce50e616436d52832216a99b07ba84065e00ddbacecb39aa4396da5a2b00b6757662e563fbbc2dab13a6d290ed63ecd3a0de3d2a2e90a2f32615aaefc25e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/077300516c3f9e4a1ee0ecdb46635773c02bc0b5d5bf3cdb8dad66c7e46d764314290c1381e9e919c2d4bc5ef73129854be7e7a056c22aba20e9cd70443c8905"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 05:24:03.045077) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:24:03.045406) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P1CD7GS4EK/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.hDhBQA8bCU/Listeners TMPDIR=/var/folders/s0/f6nsqk417rl96stczq35c_fw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005056 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 05:24:03.095123) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 05:24:03.095469) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 05:24:03.095847) ========= ========= Total master_lag: 0.18 =========