builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0330 starttime: 1474979917.58 results: success (0) buildid: 20160927030200 builduid: abdc06c068014bcf9b0eeacc00b847aa revision: 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 05:38:37.583892) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 05:38:37.584742) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 05:38:37.585041) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 05:38:37.629170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 05:38:37.629631) ========= 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.9HJSdLGYOq/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.JdSh0GTEnl/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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-09-27 05:38:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 41.2M=0s 2016-09-27 05:38:38 (41.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.461647 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 05:38:38.118497) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 05:38:38.118870) ========= 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.9HJSdLGYOq/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.JdSh0GTEnl/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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.026890 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 05:38:38.171820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 05:38:38.172298) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9HJSdLGYOq/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.JdSh0GTEnl/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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-09-27 05:38:38,263 truncating revision to first 12 chars 2016-09-27 05:38:38,263 Setting DEBUG logging. 2016-09-27 05:38:38,263 attempt 1/10 2016-09-27 05:38:38,264 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/66a77b9bfe5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 05:38:38,893 unpacking tar archive at: mozilla-central-66a77b9bfe5d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.898712 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 05:38:39.093892) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 05:38:39.094233) ========= script_repo_revision: 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 05:38:39.094645) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 05:38:39.095021) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 05:38:39.119282) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-27 05:38:39.119588) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9HJSdLGYOq/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.JdSh0GTEnl/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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:38:39 INFO - MultiFileLogger online at 20160927 05:38:39 in /builds/slave/test 05:38:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:38:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:38:39 INFO - {'append_to_log': False, 05:38:39 INFO - 'base_work_dir': '/builds/slave/test', 05:38:39 INFO - 'blob_upload_branch': 'Firefox', 05:38:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:38:39 INFO - 'branch': 'Firefox', 05:38:39 INFO - 'buildbot_json_path': 'buildprops.json', 05:38:39 INFO - 'config_files': ('talos/mac_config.py',), 05:38:39 INFO - 'default_actions': ('clobber', 05:38:39 INFO - 'read-buildbot-config', 05:38:39 INFO - 'download-and-extract', 05:38:39 INFO - 'populate-webroot', 05:38:39 INFO - 'create-virtualenv', 05:38:39 INFO - 'install', 05:38:39 INFO - 'run-tests'), 05:38:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:38:39 INFO - 'download_minidump_stackwalk': True, 05:38:39 INFO - 'download_symbols': 'ondemand', 05:38:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:38:39 INFO - 'tooltool.py': '/tools/tooltool.py', 05:38:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:38:39 INFO - '/tools/misc-python/virtualenv.py')}, 05:38:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:38:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:38:39 INFO - 'installer_path': 'installer.exe', 05:38:39 INFO - 'log_level': 'info', 05:38:39 INFO - 'log_name': 'talos', 05:38:39 INFO - 'log_to_console': True, 05:38:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:38:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:38:39 INFO - 'opt_config_files': (), 05:38:39 INFO - 'pip_index': False, 05:38:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:38:39 INFO - 'cmd': ('bash', 05:38:39 INFO - '-c', 05:38:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:38:39 INFO - 'enabled': True, 05:38:39 INFO - 'halt_on_failure': False, 05:38:39 INFO - 'name': 'check_screen_resolution'},), 05:38:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:38:39 INFO - 'cmd': ('bash', 05:38:39 INFO - '-c', 05:38:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:38:39 INFO - 'enabled': True, 05:38:39 INFO - 'halt_on_failure': False, 05:38:39 INFO - 'name': 'check_screen_resolution'},), 05:38:39 INFO - 'run_cmd_checks_enabled': True, 05:38:39 INFO - 'sps_profile': False, 05:38:39 INFO - 'sps_profile_interval': 0, 05:38:39 INFO - 'suite': 'dromaeojs', 05:38:39 INFO - 'system_bits': '32', 05:38:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:38:39 INFO - 'title': 't-yosemite-r7-0330', 05:38:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:38:39 INFO - 'use_talos_json': True, 05:38:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:38:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:38:39 INFO - 'work_dir': 'build'} 05:38:39 INFO - [mozharness: 2016-09-27 12:38:39.343315Z] Running clobber step. 05:38:39 INFO - Running pre-action listener: _resource_record_pre_action 05:38:39 INFO - Running main action method: clobber 05:38:39 INFO - rmtree: /builds/slave/test/build 05:38:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:38:41 INFO - Running post-action listener: _resource_record_post_action 05:38:41 INFO - [mozharness: 2016-09-27 12:38:41.618996Z] Finished clobber step (success) 05:38:41 INFO - [mozharness: 2016-09-27 12:38:41.619233Z] Running read-buildbot-config step. 05:38:41 INFO - Running pre-action listener: _resource_record_pre_action 05:38:41 INFO - Running main action method: read_buildbot_config 05:38:41 INFO - Using buildbot properties: 05:38:41 INFO - { 05:38:41 INFO - "project": "", 05:38:41 INFO - "product": "firefox", 05:38:41 INFO - "script_repo_revision": "production", 05:38:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:38:41 INFO - "repository": "", 05:38:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:38:41 INFO - "buildid": "20160927030200", 05:38:41 INFO - "stage_platform": "macosx64", 05:38:41 INFO - "basedir": "/builds/slave/test", 05:38:41 INFO - "nightly_build": "True", 05:38:41 INFO - "buildnumber": 0, 05:38:41 INFO - "slavename": "t-yosemite-r7-0330", 05:38:41 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:38:41 INFO - "platform": "yosemite_r7", 05:38:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:38:41 INFO - "branch": "mozilla-central", 05:38:41 INFO - "repo_path": "mozilla-central", 05:38:41 INFO - "revision": "66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd", 05:38:41 INFO - "pgo_build": "False", 05:38:41 INFO - "builduid": "abdc06c068014bcf9b0eeacc00b847aa", 05:38:41 INFO - "slavebuilddir": "test" 05:38:41 INFO - } 05:38:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:38:41 INFO - Running post-action listener: _resource_record_post_action 05:38:41 INFO - [mozharness: 2016-09-27 12:38:41.625162Z] Finished read-buildbot-config step (success) 05:38:41 INFO - [mozharness: 2016-09-27 12:38:41.625362Z] Running download-and-extract step. 05:38:41 INFO - Running pre-action listener: _resource_record_pre_action 05:38:41 INFO - Running main action method: download_and_extract 05:38:41 INFO - mkdir: /builds/slave/test/build/tests 05:38:41 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:41 INFO - trying https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:38:41 INFO - Downloading https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:38:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:38:43 INFO - Downloaded 1199 bytes. 05:38:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:38:43 INFO - Using the following test package requirements: 05:38:43 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:38:43 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:38:43 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:38:43 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:38:43 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:38:43 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:38:43 INFO - u'jsshell-mac.zip'], 05:38:43 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:38:43 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:38:43 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:38:43 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:38:43 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:38:43 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:38:43 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:38:43 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:38:43 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:38:43 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:38:43 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:38:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:38:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:38:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:38:43 INFO - Fetch https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:38:43 INFO - Expected file size: 16470555 05:38:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:38:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:38:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:38:50 INFO - Fetch https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:38:51 INFO - Expected file size: 16470555 05:38:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:38:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:38:57 INFO - Fetch https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:38:58 INFO - Expected file size: 14414057 05:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:59 INFO - trying https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:38:59 INFO - Downloading https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:38:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:39:01 INFO - Downloaded 111690554 bytes. 05:39:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:39:01 INFO - mkdir: /builds/slave/test/properties 05:39:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:39:01 INFO - Writing to file /builds/slave/test/properties/build_url 05:39:01 INFO - Contents: 05:39:01 INFO - build_url:https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:39:02 INFO - Running post-action listener: _resource_record_post_action 05:39:02 INFO - Running post-action listener: set_extra_try_arguments 05:39:02 INFO - [mozharness: 2016-09-27 12:39:02.486207Z] Finished download-and-extract step (success) 05:39:02 INFO - [mozharness: 2016-09-27 12:39:02.486313Z] Running populate-webroot step. 05:39:02 INFO - Running pre-action listener: _resource_record_pre_action 05:39:02 INFO - Running main action method: populate_webroot 05:39:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:39:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:39:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:39:02 INFO - '--tppagecycles', 05:39:02 INFO - '7'], 05:39:02 INFO - 'tests': ['tsvgm']}}, 05:39:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:39:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:39:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:39:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:39:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:39:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:39:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:02 INFO - 'talos_options': ['--disable-e10s'], 05:39:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:02 INFO - 'talos_options': ['--disable-e10s'], 05:39:02 INFO - 'tests': ['damp', 'tps']}, 05:39:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:02 INFO - 'tests': ['damp', 'tps']}, 05:39:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:39:02 INFO - 'tests': ['dromaeo_dom']}, 05:39:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:39:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:39:02 INFO - 'tests': ['basic_compositor_video']}, 05:39:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:39:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:39:02 INFO - 'tests': ['a11yr', 05:39:02 INFO - 'ts_paint', 05:39:02 INFO - 'tpaint', 05:39:02 INFO - 'sessionrestore', 05:39:02 INFO - 'sessionrestore_no_auto_restore', 05:39:02 INFO - 'tabpaint']}, 05:39:02 INFO - 'other-e10s': {'tests': ['a11yr', 05:39:02 INFO - 'ts_paint', 05:39:02 INFO - 'tpaint', 05:39:02 INFO - 'sessionrestore', 05:39:02 INFO - 'sessionrestore_no_auto_restore', 05:39:02 INFO - 'tabpaint']}, 05:39:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:39:02 INFO - 'ts_paint', 05:39:02 INFO - 'tpaint', 05:39:02 INFO - 'sessionrestore', 05:39:02 INFO - 'sessionrestore_no_auto_restore', 05:39:02 INFO - 'tabpaint']}, 05:39:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:39:02 INFO - 'ts_paint', 05:39:02 INFO - 'tpaint', 05:39:02 INFO - 'sessionrestore', 05:39:02 INFO - 'sessionrestore_no_auto_restore', 05:39:02 INFO - 'tabpaint']}, 05:39:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:39:02 INFO - 'tests': ['a11yr', 05:39:02 INFO - 'ts_paint', 05:39:02 INFO - 'tpaint', 05:39:02 INFO - 'sessionrestore', 05:39:02 INFO - 'sessionrestore_no_auto_restore', 05:39:02 INFO - 'tabpaint']}, 05:39:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:39:02 INFO - 'tests': ['a11yr', 05:39:02 INFO - 'ts_paint', 05:39:02 INFO - 'tpaint', 05:39:02 INFO - 'sessionrestore', 05:39:02 INFO - 'sessionrestore_no_auto_restore', 05:39:02 INFO - 'tabpaint']}, 05:39:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:39:02 INFO - 'tests': ['tsvgx', 05:39:02 INFO - 'tsvgr_opacity', 05:39:02 INFO - 'tart', 05:39:02 INFO - 'tscrollx', 05:39:02 INFO - 'cart']}, 05:39:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:39:02 INFO - 'tsvgr_opacity', 05:39:02 INFO - 'tart', 05:39:02 INFO - 'tscrollx', 05:39:02 INFO - 'cart']}, 05:39:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:02 INFO - 'talos_options': ['--disable-e10s'], 05:39:02 INFO - 'tests': ['tp5o']}, 05:39:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:02 INFO - 'tests': ['tp5o']}, 05:39:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:02 INFO - 'talos_options': ['--disable-e10s', 05:39:02 INFO - '--xperf_path', 05:39:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:02 INFO - 'tests': ['tp5n']}, 05:39:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:02 INFO - 'talos_options': ['--xperf_path', 05:39:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:02 INFO - 'tests': ['tp5n']}}, 05:39:02 INFO - 'talos.zip': {'path': '', 05:39:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:39:02 INFO - Running post-action listener: _resource_record_post_action 05:39:02 INFO - [mozharness: 2016-09-27 12:39:02.504729Z] Finished populate-webroot step (success) 05:39:02 INFO - [mozharness: 2016-09-27 12:39:02.504863Z] Running create-virtualenv step. 05:39:02 INFO - Running pre-action listener: _resource_record_pre_action 05:39:02 INFO - Running main action method: create_virtualenv 05:39:02 INFO - Creating virtualenv /builds/slave/test/build/venv 05:39:02 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:39:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:39:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:39:02 INFO - Using real prefix '/tools/python27' 05:39:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:39:03 INFO - Installing distribute.............................................................................................................................................................................................done. 05:39:06 INFO - Installing pip.................done. 05:39:06 INFO - Return code: 0 05:39:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:39:06 INFO - Reading from file tmpfile_stdout 05:39:06 INFO - Output received: 05:39:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:39:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8013ea3c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e29ad30>, '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 0x10e0c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e292b20>, '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.9HJSdLGYOq/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.JdSh0GTEnl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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:39:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:39:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9HJSdLGYOq/Render', 05:39:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:06 INFO - 'HOME': '/Users/cltbld', 05:39:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:06 INFO - 'LOGNAME': 'cltbld', 05:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:06 INFO - 'MOZ_NO_REMOTE': '1', 05:39:06 INFO - 'NO_EM_RESTART': '1', 05:39:06 INFO - 'PAGER': '/bin/cat', 05:39:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:06 INFO - 'PWD': '/builds/slave/test', 05:39:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:06 INFO - 'SHELL': '/bin/bash', 05:39:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdSh0GTEnl/Listeners', 05:39:06 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 05:39:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:06 INFO - 'USER': 'cltbld', 05:39:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:06 INFO - 'XPC_FLAGS': '0x0', 05:39:06 INFO - 'XPC_SERVICE_NAME': '0', 05:39:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:06 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:39:06 INFO - Cleaning up... 05:39:06 INFO - Return code: 0 05:39:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8013ea3c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e29ad30>, '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 0x10e0c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e292b20>, '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.9HJSdLGYOq/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.JdSh0GTEnl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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:39:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:39:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9HJSdLGYOq/Render', 05:39:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:06 INFO - 'HOME': '/Users/cltbld', 05:39:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:06 INFO - 'LOGNAME': 'cltbld', 05:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:06 INFO - 'MOZ_NO_REMOTE': '1', 05:39:06 INFO - 'NO_EM_RESTART': '1', 05:39:06 INFO - 'PAGER': '/bin/cat', 05:39:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:06 INFO - 'PWD': '/builds/slave/test', 05:39:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:06 INFO - 'SHELL': '/bin/bash', 05:39:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdSh0GTEnl/Listeners', 05:39:06 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 05:39:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:06 INFO - 'USER': 'cltbld', 05:39:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:06 INFO - 'XPC_FLAGS': '0x0', 05:39:06 INFO - 'XPC_SERVICE_NAME': '0', 05:39:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:06 INFO - Downloading/unpacking psutil>=3.1.1 05:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:39:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:10 INFO - Installing collected packages: psutil 05:39:10 INFO - Running setup.py install for psutil 05:39:10 INFO - building 'psutil._psutil_osx' extension 05:39:10 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:39:10 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:39:10 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:39:11 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:39:11 INFO - building 'psutil._psutil_posix' extension 05:39:11 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:39:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:39:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:39:11 INFO - ^ 05:39:11 INFO - 1 warning generated. 05:39:11 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:39:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:11 INFO - Successfully installed psutil 05:39:11 INFO - Cleaning up... 05:39:11 INFO - Return code: 0 05:39:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:39:11 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:11 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:11 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 0x10e486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8013ea3c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e29ad30>, '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 0x10e0c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e292b20>, '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.9HJSdLGYOq/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.JdSh0GTEnl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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:39:11 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:39:11 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:39:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9HJSdLGYOq/Render', 05:39:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:11 INFO - 'HOME': '/Users/cltbld', 05:39:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:11 INFO - 'LOGNAME': 'cltbld', 05:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:11 INFO - 'MOZ_NO_REMOTE': '1', 05:39:11 INFO - 'NO_EM_RESTART': '1', 05:39:11 INFO - 'PAGER': '/bin/cat', 05:39:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:11 INFO - 'PWD': '/builds/slave/test', 05:39:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:11 INFO - 'SHELL': '/bin/bash', 05:39:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdSh0GTEnl/Listeners', 05:39:11 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 05:39:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:11 INFO - 'USER': 'cltbld', 05:39:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:11 INFO - 'XPC_FLAGS': '0x0', 05:39:11 INFO - 'XPC_SERVICE_NAME': '0', 05:39:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:39:11 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:39:11 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:39:11 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:39:11 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:39:11 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:39:11 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:39:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:39:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:39:14 INFO - Installing collected packages: mozsystemmonitor 05:39:14 INFO - Running setup.py install for mozsystemmonitor 05:39:14 INFO - Successfully installed mozsystemmonitor 05:39:14 INFO - Cleaning up... 05:39:14 INFO - Return code: 0 05:39:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8013ea3c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e29ad30>, '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 0x10e0c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e292b20>, '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.9HJSdLGYOq/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.JdSh0GTEnl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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:39:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:39:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:39:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9HJSdLGYOq/Render', 05:39:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:14 INFO - 'HOME': '/Users/cltbld', 05:39:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:14 INFO - 'LOGNAME': 'cltbld', 05:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:14 INFO - 'MOZ_NO_REMOTE': '1', 05:39:14 INFO - 'NO_EM_RESTART': '1', 05:39:14 INFO - 'PAGER': '/bin/cat', 05:39:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:14 INFO - 'PWD': '/builds/slave/test', 05:39:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:14 INFO - 'SHELL': '/bin/bash', 05:39:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdSh0GTEnl/Listeners', 05:39:14 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 05:39:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:14 INFO - 'USER': 'cltbld', 05:39:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:14 INFO - 'XPC_FLAGS': '0x0', 05:39:14 INFO - 'XPC_SERVICE_NAME': '0', 05:39:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:14 INFO - Downloading/unpacking jsonschema==2.5.1 05:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:39:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:39:17 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:39:17 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:39:17 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:39:17 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:39:17 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:39:17 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:39:17 INFO - Downloading functools32-3.2.3-2.tar.gz 05:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:39:17 INFO - warning: no files found matching '*.txt' 05:39:17 INFO - no previously-included directories found matching 'build' 05:39:17 INFO - no previously-included directories found matching 'dist' 05:39:17 INFO - no previously-included directories found matching '.git*' 05:39:17 INFO - Installing collected packages: jsonschema, functools32 05:39:17 INFO - Running setup.py install for functools32 05:39:17 INFO - warning: no files found matching '*.txt' 05:39:17 INFO - no previously-included directories found matching 'build' 05:39:17 INFO - no previously-included directories found matching 'dist' 05:39:17 INFO - no previously-included directories found matching '.git*' 05:39:17 INFO - Successfully installed jsonschema functools32 05:39:17 INFO - Cleaning up... 05:39:17 INFO - Return code: 0 05:39:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8013ea3c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e29ad30>, '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 0x10e0c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e292b20>, '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.9HJSdLGYOq/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.JdSh0GTEnl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:39:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9HJSdLGYOq/Render', 05:39:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:17 INFO - 'HOME': '/Users/cltbld', 05:39:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:17 INFO - 'LOGNAME': 'cltbld', 05:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:17 INFO - 'MOZ_NO_REMOTE': '1', 05:39:17 INFO - 'NO_EM_RESTART': '1', 05:39:17 INFO - 'PAGER': '/bin/cat', 05:39:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:17 INFO - 'PWD': '/builds/slave/test', 05:39:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:17 INFO - 'SHELL': '/bin/bash', 05:39:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdSh0GTEnl/Listeners', 05:39:17 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 05:39:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:17 INFO - 'USER': 'cltbld', 05:39:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:17 INFO - 'XPC_FLAGS': '0x0', 05:39:17 INFO - 'XPC_SERVICE_NAME': '0', 05:39:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:39:18 INFO - Cleaning up... 05:39:18 INFO - Return code: 0 05:39:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:39:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:18 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 0x10e486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8013ea3c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e29ad30>, '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 0x10e0c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e292b20>, '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.9HJSdLGYOq/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.JdSh0GTEnl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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:39:18 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:39:18 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:39:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9HJSdLGYOq/Render', 05:39:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:18 INFO - 'HOME': '/Users/cltbld', 05:39:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:18 INFO - 'LOGNAME': 'cltbld', 05:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:18 INFO - 'MOZ_NO_REMOTE': '1', 05:39:18 INFO - 'NO_EM_RESTART': '1', 05:39:18 INFO - 'PAGER': '/bin/cat', 05:39:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:18 INFO - 'PWD': '/builds/slave/test', 05:39:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:18 INFO - 'SHELL': '/bin/bash', 05:39:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdSh0GTEnl/Listeners', 05:39:18 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 05:39:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:18 INFO - 'USER': 'cltbld', 05:39:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:18 INFO - 'XPC_FLAGS': '0x0', 05:39:18 INFO - 'XPC_SERVICE_NAME': '0', 05:39:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:18 INFO - Downloading/unpacking blobuploader==1.2.4 05:39:18 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:39:18 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:39:18 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:39:18 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:39:18 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:39:18 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:39:20 INFO - Downloading blobuploader-1.2.4.tar.gz 05:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:39:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:39:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:22 INFO - Downloading docopt-0.6.1.tar.gz 05:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:39:22 INFO - Installing collected packages: blobuploader, requests, docopt 05:39:22 INFO - Running setup.py install for blobuploader 05:39:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:39:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:39:22 INFO - Running setup.py install for requests 05:39:22 INFO - Running setup.py install for docopt 05:39:22 INFO - Successfully installed blobuploader requests docopt 05:39:22 INFO - Cleaning up... 05:39:23 INFO - Return code: 0 05:39:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:23 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 0x10e486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8013ea3c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e29ad30>, '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 0x10e0c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e292b20>, '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.9HJSdLGYOq/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.JdSh0GTEnl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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:39:23 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:39:23 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:39:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9HJSdLGYOq/Render', 05:39:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:23 INFO - 'HOME': '/Users/cltbld', 05:39:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:23 INFO - 'LOGNAME': 'cltbld', 05:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:23 INFO - 'MOZ_NO_REMOTE': '1', 05:39:23 INFO - 'NO_EM_RESTART': '1', 05:39:23 INFO - 'PAGER': '/bin/cat', 05:39:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:23 INFO - 'PWD': '/builds/slave/test', 05:39:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:23 INFO - 'SHELL': '/bin/bash', 05:39:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdSh0GTEnl/Listeners', 05:39:23 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 05:39:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:23 INFO - 'USER': 'cltbld', 05:39:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:23 INFO - 'XPC_FLAGS': '0x0', 05:39:23 INFO - 'XPC_SERVICE_NAME': '0', 05:39:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-LIzeKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-z_AGfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-ZrsSlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-Ki0yiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-dY2x_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-26Uf3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-5p39Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:24 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-d0gSDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:24 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-Lc41j1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:24 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-T5I4Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:24 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-eZDNMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:24 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-phjHu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:24 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-AERa3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:24 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-9qgzHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:24 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-1xIfU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:24 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-dqYIwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:25 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-pdtRFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:39:25 INFO - Running setup.py install for manifestparser 05:39:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:39:25 INFO - Running setup.py install for mozcrash 05:39:25 INFO - Running setup.py install for mozdebug 05:39:25 INFO - Running setup.py install for mozdevice 05:39:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:39:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:39:25 INFO - Running setup.py install for mozfile 05:39:25 INFO - Running setup.py install for mozhttpd 05:39:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:39:26 INFO - Running setup.py install for mozinfo 05:39:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:39:26 INFO - Running setup.py install for mozInstall 05:39:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:39:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:39:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:39:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:39:26 INFO - Running setup.py install for mozleak 05:39:26 INFO - Running setup.py install for mozlog 05:39:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:39:26 INFO - Running setup.py install for moznetwork 05:39:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:39:26 INFO - Running setup.py install for mozprocess 05:39:26 INFO - Running setup.py install for mozprofile 05:39:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:39:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:39:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:39:27 INFO - Running setup.py install for mozrunner 05:39:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:39:27 INFO - Running setup.py install for mozscreenshot 05:39:27 INFO - Running setup.py install for moztest 05:39:27 INFO - Running setup.py install for mozversion 05:39:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:39:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:39:27 INFO - Cleaning up... 05:39:27 INFO - Return code: 0 05:39:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:27 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 0x10e486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8013ea3c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e29ad30>, '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 0x10e0c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e292b20>, '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.9HJSdLGYOq/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.JdSh0GTEnl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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:39:27 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:39:27 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:39:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9HJSdLGYOq/Render', 05:39:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:27 INFO - 'HOME': '/Users/cltbld', 05:39:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:27 INFO - 'LOGNAME': 'cltbld', 05:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:27 INFO - 'MOZ_NO_REMOTE': '1', 05:39:27 INFO - 'NO_EM_RESTART': '1', 05:39:27 INFO - 'PAGER': '/bin/cat', 05:39:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:27 INFO - 'PWD': '/builds/slave/test', 05:39:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:27 INFO - 'SHELL': '/bin/bash', 05:39:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdSh0GTEnl/Listeners', 05:39:27 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 05:39:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:27 INFO - 'USER': 'cltbld', 05:39:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:27 INFO - 'XPC_FLAGS': '0x0', 05:39:27 INFO - 'XPC_SERVICE_NAME': '0', 05:39:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-5Cxu3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:28 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:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-PT927n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:28 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:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-keQ82S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:28 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:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-0zBA5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:28 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:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-ipzTgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:28 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:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-TNSAru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:28 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:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-NSZEy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:28 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:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-QqrSRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:28 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:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-6t_7qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:28 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:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-u8Cegh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:29 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-oh9rWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:29 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:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:29 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-sXJw6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:29 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:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:29 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-fnLmHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:29 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:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:29 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-Y0mzkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:29 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:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:29 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-vYFGan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:29 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:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:29 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-XMcdIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:29 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:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:29 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-TL2Pt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:29 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:39:29 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:39:29 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:39:29 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:39:29 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:39:29 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:39:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:39:29 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:39:29 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:39:29 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:39:29 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:39:29 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:39:29 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:39:32 INFO - Downloading blessings-1.6.tar.gz 05:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:39:32 INFO - Installing collected packages: blessings 05:39:32 INFO - Running setup.py install for blessings 05:39:32 INFO - Successfully installed blessings 05:39:32 INFO - Cleaning up... 05:39:32 INFO - Return code: 0 05:39:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:39:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:32 INFO - Reading from file tmpfile_stdout 05:39:32 INFO - Current package versions: 05:39:32 INFO - blessings == 1.6 05:39:32 INFO - blobuploader == 1.2.4 05:39:32 INFO - docopt == 0.6.1 05:39:32 INFO - functools32 == 3.2.3-2 05:39:32 INFO - jsonschema == 2.5.1 05:39:32 INFO - manifestparser == 1.1 05:39:32 INFO - mozInstall == 1.12 05:39:32 INFO - mozcrash == 0.17 05:39:32 INFO - mozdebug == 0.1 05:39:32 INFO - mozdevice == 0.48 05:39:32 INFO - mozfile == 1.2 05:39:32 INFO - mozhttpd == 0.7 05:39:32 INFO - mozinfo == 0.9 05:39:32 INFO - mozleak == 0.1 05:39:32 INFO - mozlog == 3.4 05:39:32 INFO - moznetwork == 0.27 05:39:32 INFO - mozprocess == 0.23 05:39:32 INFO - mozprofile == 0.28 05:39:32 INFO - mozrunner == 6.12 05:39:32 INFO - mozscreenshot == 0.1 05:39:32 INFO - mozsystemmonitor == 0.3 05:39:32 INFO - moztest == 0.7 05:39:32 INFO - mozversion == 1.4 05:39:32 INFO - psutil == 3.1.1 05:39:32 INFO - requests == 1.2.3 05:39:32 INFO - wsgiref == 0.1.2 05:39:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:32 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:32 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:32 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 0x10e486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8013ea3c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e29ad30>, '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 0x10e0c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e292b20>, '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.9HJSdLGYOq/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.JdSh0GTEnl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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:39:32 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:39:32 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:39:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9HJSdLGYOq/Render', 05:39:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:32 INFO - 'HOME': '/Users/cltbld', 05:39:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:32 INFO - 'LOGNAME': 'cltbld', 05:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:32 INFO - 'MOZ_NO_REMOTE': '1', 05:39:32 INFO - 'NO_EM_RESTART': '1', 05:39:32 INFO - 'PAGER': '/bin/cat', 05:39:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:32 INFO - 'PWD': '/builds/slave/test', 05:39:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:32 INFO - 'SHELL': '/bin/bash', 05:39:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdSh0GTEnl/Listeners', 05:39:32 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 05:39:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:32 INFO - 'USER': 'cltbld', 05:39:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:32 INFO - 'XPC_FLAGS': '0x0', 05:39:32 INFO - 'XPC_SERVICE_NAME': '0', 05:39:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:33 INFO - Cleaning up... 05:39:33 INFO - Return code: 0 05:39:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:33 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 0x10e486490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3fc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8013ea3c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e29ad30>, '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 0x10e0c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e292b20>, '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.9HJSdLGYOq/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.JdSh0GTEnl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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:39:33 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:39:33 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:39:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9HJSdLGYOq/Render', 05:39:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:33 INFO - 'HOME': '/Users/cltbld', 05:39:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:33 INFO - 'LOGNAME': 'cltbld', 05:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:33 INFO - 'MOZ_NO_REMOTE': '1', 05:39:33 INFO - 'NO_EM_RESTART': '1', 05:39:33 INFO - 'PAGER': '/bin/cat', 05:39:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:33 INFO - 'PWD': '/builds/slave/test', 05:39:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:33 INFO - 'SHELL': '/bin/bash', 05:39:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdSh0GTEnl/Listeners', 05:39:33 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 05:39:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:33 INFO - 'USER': 'cltbld', 05:39:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:33 INFO - 'XPC_FLAGS': '0x0', 05:39:33 INFO - 'XPC_SERVICE_NAME': '0', 05:39:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:39:33 INFO - Cleaning up... 05:39:33 INFO - Return code: 0 05:39:33 INFO - Running post-action listener: _resource_record_post_action 05:39:33 INFO - Running post-action listener: _start_resource_monitoring 05:39:33 INFO - Starting resource monitoring. 05:39:33 INFO - [mozharness: 2016-09-27 12:39:33.537855Z] Finished create-virtualenv step (success) 05:39:33 INFO - [mozharness: 2016-09-27 12:39:33.538922Z] Running install step. 05:39:33 INFO - Running pre-action listener: _resource_record_pre_action 05:39:33 INFO - Running main action method: install 05:39:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:33 INFO - Reading from file tmpfile_stdout 05:39:33 INFO - Detecting whether we're running mozinstall >=1.0... 05:39:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:39:33 INFO - Reading from file tmpfile_stdout 05:39:33 INFO - Output received: 05:39:33 INFO - Usage: mozinstall [options] installer 05:39:33 INFO - Options: 05:39:33 INFO - -h, --help show this help message and exit 05:39:33 INFO - -d DEST, --destination=DEST 05:39:33 INFO - Directory to install application into. [default: 05:39:33 INFO - "/builds/slave/test"] 05:39:33 INFO - --app=APP Application being installed. [default: firefox] 05:39:33 INFO - mkdir: /builds/slave/test/build/application 05:39:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:40:08 INFO - Reading from file tmpfile_stdout 05:40:08 INFO - Output received: 05:40:08 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:40:08 INFO - Running post-action listener: _resource_record_post_action 05:40:08 INFO - [mozharness: 2016-09-27 12:40:08.415913Z] Finished install step (success) 05:40:08 INFO - [mozharness: 2016-09-27 12:40:08.416090Z] Running run-tests step. 05:40:08 INFO - Running pre-action listener: _resource_record_pre_action 05:40:08 INFO - Running main action method: run_tests 05:40:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:40:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:40:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:40:08 INFO - 2016-09-27 05:40:08.429 screenresolution[1656:8799] starting screenresolution argv=screenresolution get 05:40:08 INFO - 2016-09-27 05:40:08.431 screenresolution[1656:8799] Display 0: 1600x1200x32@60 05:40:08 INFO - 2016-09-27 05:40:08.437 screenresolution[1657:8801] starting screenresolution argv=screenresolution list 05:40:08 INFO - Available Modes on Display 0 05:40:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:40:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:40:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:40:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:40:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:40:08 INFO - Intel Iris: 05:40:08 INFO - Chipset Model: Intel Iris 05:40:08 INFO - Type: GPU 05:40:08 INFO - Bus: Built-In 05:40:08 INFO - VRAM (Dynamic, Max): 1536 MB 05:40:08 INFO - Vendor: Intel (0x8086) 05:40:08 INFO - Device ID: 0x0a2e 05:40:08 INFO - Revision ID: 0x0009 05:40:08 INFO - Displays: 05:40:08 INFO - Display: 05:40:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:40:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:40:08 INFO - Display Serial Number: 1600x1200 60 05:40:08 INFO - Main Display: Yes 05:40:08 INFO - Mirror: Off 05:40:08 INFO - Online: Yes 05:40:08 INFO - Rotation: Supported 05:40:08 INFO - Return code: 0 05:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:40:08 INFO - Python 2.7.3 05:40:08 INFO - Return code: 0 05:40:08 INFO - grabbing minidump binary from tooltool 05:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:08 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 0x10e29ad30>, '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 0x10e0c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e292b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:40:08 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:40:08 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:40:08 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:40:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:40:08 INFO - Return code: 0 05:40:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:40:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:40:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:40:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:40:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0330', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0330 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:40:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9HJSdLGYOq/Render', 05:40:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:08 INFO - 'HOME': '/Users/cltbld', 05:40:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:08 INFO - 'LOGNAME': 'cltbld', 05:40:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:40:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:08 INFO - 'MOZ_NO_REMOTE': '1', 05:40:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:40:08 INFO - 'NO_EM_RESTART': '1', 05:40:08 INFO - 'PAGER': '/bin/cat', 05:40:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:08 INFO - 'PWD': '/builds/slave/test', 05:40:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:40:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:08 INFO - 'SHELL': '/bin/bash', 05:40:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdSh0GTEnl/Listeners', 05:40:08 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 05:40:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:08 INFO - 'USER': 'cltbld', 05:40:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:08 INFO - 'XPC_FLAGS': '0x0', 05:40:08 INFO - 'XPC_SERVICE_NAME': '0', 05:40:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0330', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:40:09 INFO - mozversion application_buildid: 20160927030200 05:40:09 INFO - mozversion application_changeset: 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd 05:40:09 INFO - mozversion application_display_name: Nightly 05:40:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:40:09 INFO - mozversion application_name: Firefox 05:40:09 INFO - mozversion application_remotingname: firefox 05:40:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:40:09 INFO - mozversion application_vendor: Mozilla 05:40:09 INFO - mozversion application_version: 52.0a1 05:40:09 INFO - mozversion platform_buildid: 20160927030200 05:40:09 INFO - mozversion platform_changeset: 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd 05:40:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:40:09 INFO - mozversion platform_version: 52.0a1 05:40:09 INFO - using testdate: 1474980009 05:40:09 INFO - actual date: 1474980009 05:40:09 INFO - starting webserver on 'localhost:49280' 05:40:09 INFO - SUITE-START | Running 2 tests 05:40:09 INFO - TEST-START | dromaeo_css 05:40:09 INFO - operating with platform_type : mac_ 05:40:09 INFO - Initialising browser for dromaeo_css test... 05:40:09 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpwYlQV3/profile http://localhost:49280/getInfo.html) 05:40:11 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 05:40:11 INFO - PROCESS | 1667 | colorDepth:24 05:40:11 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 05:40:11 INFO - PROCESS | 1667 | __metrics 05:40:11 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:40:11 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:40:12 INFO - TEST-INFO | 1667: exit 0 05:40:12 INFO - Browser initialized. 05:40:12 INFO - Running cycle 1/1 for dromaeo_css test... 05:40:12 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpwYlQV3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:24 INFO - PROCESS | 1670 | RSS: Main: 235896832 05:40:24 INFO - PROCESS | 1670 | 05:41:15 INFO - PROCESS | 1670 | 1474980075567 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:43:26 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 05:43:28 INFO - PROCESS | 1670 | RSS: Main: 409317376 05:43:28 INFO - PROCESS | 1670 | 05:46:31 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 05:46:32 INFO - PROCESS | 1670 | RSS: Main: 374239232 05:46:32 INFO - PROCESS | 1670 | 05:49:34 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 05:49:35 INFO - PROCESS | 1670 | RSS: Main: 340762624 05:49:35 INFO - PROCESS | 1670 | 05:52:37 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 05:52:38 INFO - PROCESS | 1670 | RSS: Main: 339841024 05:52:38 INFO - PROCESS | 1670 | 05:55:41 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 05:55:42 INFO - PROCESS | 1670 | RSS: Main: 326868992 05:55:42 INFO - PROCESS | 1670 | 05:58:45 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 05:58:45 INFO - PROCESS | 1670 | RSS: Main: 421527552 05:58:45 INFO - PROCESS | 1670 | 05:58:45 INFO - PROCESS | 1670 | __start_tp_report 05:58:45 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 05:58:45 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 05:58:45 INFO - PROCESS | 1670 | |i|pagename|runs| 05:58:45 INFO - PROCESS | 1670 | |0;dojo.html;3268.7221586165174;3281.245313577877;3304.7521435892313;3311.4701647736338;3354.899353019409;5497.780088796443;5572.442755724425;5592.4407559244055;5628.493435590796;5663;5601.523870471015;5629.437056294369;5629.6340737852015;5632.915506267399;5637.3235211774545;5086.974565127179;5114.7698353574;5122.282880396748;5126.641135120543;5170.53465188133;5132.178851383779;5194.454582268864;5202.583793296546;5229.137192363255;5245.344331958505;5164.586833053347;5167.767450464719;5179.378474583036;5201.0898092833795;5209.479052094798;5217.191335343028;5236.450172731885;5236.554892834114;5241.816536421207;5276.9736151319385;5041.395032596112;5045;5106.770195341219;5161.4322424533275;5179.896402071938;5538.418466061086;5621.128725047624;5639.746211420496;5656.547476201935;5665.178549110397;6123.357047509992;6138.570300078996;6143.201383820075;6147.600405973642;6183.690815459209;6110.175126357974;6139.017757158833;6178.320384757673;6233.407826256498;6251.187345645082;5684.4315568443235;5702.4582664647205;5722.399148089474;5725.685087320154;5782.335031471434;5662.6036177468;6254.186955695731;6290.24517057956;6295.716692748837;6300.086487459293;5890.617109887844;5900.675462849585;5978.790742323998;6047.15339852421;6055.788047418319;6093.360197179321;6101.03536932808;6102.398363691488;6159.6612186329285;6193;6123;6130.877382452326;6134.8159555213415;6139.754409823647;6142.170806941095;6148.569600128038;6149.5080393568405;6155.1075094112;6162.352952939967;6171.228596425447;4746.59653929413;4818.060478206786;4822.493638168012;4834.806607735722;4873.025394920959;4363.563643635611;4364;4400.977995110004;4404.6035856772405;4428;5672.262605861211;5708.857278567986;5726.513246374022;5743.741531631003;5748.913766293509;6086.756529738849;6097.573169878155;6130.3369889931655;6214.25428948529;6221.06683997395;5683.54531637468;5714.114312281603;5723.942760572341;5755.798547050833;5810.651360918274;5306.416294207634;5306.708131052829;5307.283516725192;5312.893742125136;5325.0148722486465;6103.610425594382;6237.4698150656795;6245.250569931637;6256.74973001084;6259.561830671809;5930.34766175729;6100.157317757147;6119.441623354662;6142.805741014558;6158.815235542941;6319.842003949938;6330.746770129327;6336.873262534631;6341.302456729663;6365.586236894772;5979.192808970907;6020.4280593343565;6026.638401695912;6030.638161710312;6040.969795150996;5850.23946886902;6035.6076855004285;6086.239220097488;6095.207623009158;6114.175715401237;5662.433756624305;5716.114002329646;5733.02538568436;5786.132080188006;5786.363500014911;5704.80033198836;5706.201131841629;5713.314402271754;5719.7426115824055;5731.455511726379;5526.723663816712;5561.110222364564;5595.860103497445;5707.5433965281845;5769.9711501442225;5922.082077278029;5951.583389162717;6006.549508786771;6019.097135429721;6079.544034197364;5689.288838895138;5832.970835145967;5833.0667093266575;5842.269716285465;5861.560382971379 05:58:45 INFO - PROCESS | 1670 | |1;ext.html;513.9665921715089;522.5975998481168;526.6339893773826;530.8725905782613;533.6851257757925;21541.4614634634;32209;32219.03342899714;32226.83886580564;32406;32594.348113037784;33233.018056749774;33270.50094248588;33320.50019249713;33395.83302083492;9382.999999999984;9756.268279879003;9789.412635241908;9906.801863962717;9923.702288931343;9682.806343873119;9760.707178784647;9770;9784.315097943147;9803;8676.8698469523;8836.42563233391;9597.424154550748;9755.41467511948;9785.412875227474;8836.33727470439;11123.72077211119;11291.040261577777;12230.571929982409;12434.689132771662;11938.28370297785;12001.87998120025;12023.939880300542;12025.57910473138;12026.39868006605;40070;40229.39655905164;40233;40299;40337;2686.5835795451735;3321.7342612590933;3338.0820274424727;3387.5088112223834;3768.302863970147;25104.995800168155;30294.84852575723;30340.69659303401;30645;31008.8449557753;3195.472746996743;3211.7270032047304;3221.0497903118635;3235.142687187897;3328.1845947742718;508676.45661771455;511861;513592;514093;520032;61114;61393.69303153545;61398.79018147314;61421.38578614157;61491.6925415379;54423.91152176934;63965;64101.038484422774;64182;64218.67890660517;13992.510262140777;15654.217289135499;15894.284757185955;15971;16252.268647910872;12298.139130260975;12410.503579856886;12421.19262247951;12423.378831058591;12425.565105221274;13851.584452466443;14017.299135043411;17310.134493275287;17448.912755436395;17456.825431745772;5214.374275087014;6176.382361763877;6217.129601855744;6226.104861239545;6266.937330626726;856.5374697663317;909.2453263791037;918.3020904112923;957.8706874571983;1019.6991887393089;29554.852225738734;29692.663830127694;29710.405791884474;30225.244368890515;30424.087277381714;886.2334081019872;1023.9436830974367;1033.503918119307;1046.2937517176028;1091.9508622111864;14982.775258371134;15421;15480.5355839325;15541.42033974398;15784.447544335893;627146.8642656758;633947;635400;635998;636784;56700;56977.430225698045;57022;57087.714561426925;57227.56931076756;1164.0047759165961;1191.92252503587;1224.1430998301225;1353.61421994733;1378.9793153102712;26616;30757.384852303276;31544;32091.19772005625;33303.33393332071;55409.44590554043;56071.439285608256;56199.87600248054;56207.43792562022;56261;600328;607617;608355;608518;608801;38432.2313553733;38864.80567597144;39647.80176099101;39732.801335993136;39854.40218396668;45563.54436455593;45789.31316030329;46987.76506117584;47088.52911470841;47361.763191183825;29204.853975729984;30187.245318866324;37587;39272.01819954524;41581.1683766329;32787.18032049122;37926.810365948;38065.4290185653;38603;39545.60454395534;37348.813255934634;38441.61558384492;38470;38696.032599185244;38704;25498;28280.717192827808;28699.71300287054;32528;34229.973100807016;25160.622590661522;25202.36184647992;25215.495690086464;25555.84998675027;25900.740992590585 05:58:45 INFO - PROCESS | 1670 | |2;jquery.html;320.2633941933553;376.42031271841347;378.8371000469798;390.6796426929915;404.9878503644892;18804.24783008678;19481.318153864617;20330.89834550829;20395.694064589043;20547.280845170386;19568.70646940297;19606.50983725404;20092.598148037032;20215.393538193843;20333.59332813343;5302.681839089648;5527;5530.778768849241;5615.971920140393;6068.878622427549;6000.639961602296;6099.634021958675;6100.725467353957;6100.81697549072;6119.326874043873;5844.795432159875;6070.696465176746;6073.362296958822;6116.0520119381345;6196.318404975449;5966.343702192756;6152.661603611799;6194.256689197326;6197.101420294032;6205.9069113963105;5940.257467816523;6004.399560044004;6012.699365031731;6016.368281330485;6019.187409699678;12969;13016.869831301661;13023.28371939543;13164.86835131646;13206.820874555688;1880.3982725527837;2127.106615221611;2259.762724913877;2512.8366656167473;2529.0389651932333;9916.107550320434;9942.304038717293;10447.582096716122;13439.395227214798;14037.578872633838;1882.3694062489083;1907.83783378413;1919.865609407342;1923.855710821694;1956.1392987085637;111970;119418;119633;121702.39148804288;123259;11172.385518796544;11215.66353009411;11250.606228781953;11339.546418143182;11624.070074394198;14468.638284042983;14478.276086195649;14479.276036198358;14486.203258820655;14487.855121448862;6930.5148639594745;8050.758477245692;8321.708740194184;8358.832823343499;8475;8217.424780265444;8217.83564328722;8241.752747417588;8378.916210837813;8400.83198336042;4398.780060996937;4538.614217791524;4551.112533056023;4611.7232966021475;4630.83792067276;1501.6996600679909;1579.8025246844145;1910.2931915191468;1912.2733361322607;1914.5787926656114;847.1443841719907;896.8968568614563;903.2728653434049;916.4318122763929;963.1524258652481;18245;20105;20749.89625051865;20786.27248046311;20807.375778726662;739.7336958694866;898.1662853696598;914.9862752058724;918.7611221082567;990.1484723138095;7950.165232650604;9854.655087071918;10665.786684266272;10764.946175269073;10800.837987430195;555863;557448.2127589417;565162;568519;568721;128474.07288890674;128774;129941;132342;133896.88165485163;951.8143961927497;967;1025.5231317437429;1032.0195813976752;1037.2998226197287;18136.818631813512;18867.716984244973;18976.240950362382;19023.619527609095;19106;54047.91904161816;54786.63033424196;55111.72444137753;55139.724301378235;55773.16340254818;71122.64438677774;72047;72792.54414911778;74311.62844185745;75247.62376188303;5419.214213938878;5967.254093238345;7682.462227644011;7992.16082311349;8241.95879020601;10171.898281017095;12731.363431828186;12893;13480.6629834251;13498.392572334073;10877.347359158475;11018.283811552223;11186.944065279622;11685.532578696757;11854.051675866083;10997.285176463503;11342.20604557673;11405.973462388425;11771.941140294244;11833.82249266279;11310.377929213972;11323.16792901538;11748.765024699287;11911.344876031555;12042.879571204527;8060.476069055727;8068.12729889668;8147.714829980922;8241.423100382915;8375.20435558621;9921.305508614329;10110.342827716175;10920.344779313267;11153.665390038312;11319.886801131883 05:58:45 INFO - PROCESS | 1670 | |3;mootools.html;1329.2024785128922;1380.468519619946;1561.8125824901012;1746.8427841494263;1923.3556758485906;7876.488028278165;8368.079511253758;8377.497350158994;8390.286825619822;8406.579671016456;8181.181881811815;8512.787180320494;8733.475991440502;8784.341174411913;8866.980297265816;1997.9600407991868;2353.870537120458;2359.917402890899;2361.2207971369407;2385.737568867432;2331.463763334434;2368.100121953655;2382.0233704181287;2386.1767690146958;2391.820613453989;2357;2374.2165085521824;2390.8206884483734;2392.449736560592;2402.159244264511;2329.4758679297192;2357.8467399619058;2360.527894421114;2364.1252736487436;2381.904723811063;2338.649202619604;2341.9648705269433;2349.036894873094;2349.835511514195;2358.0803486640225;7512.436567257478;8892.555372231363;8970.50662213578;8980.281577473786;9005.14451127142;4786.0667169901535;5006.4743201964;5312.335958005249;5390.434004429557;5393.73031348435;3309.3381323735107;3396.575428071491;3499.4925735768425;3669.192777588926;3685.244524872395;894.485670739321;1093.578972095741;1097.868255809308;1651.1414064686296;1765.938192163268;10059.144972677332;11733;11792.823107653392;11920.344381059038;11935.820962685566;4722;4737.5397150264225;4774.2599897015325;4856.95143048572;4896.436909755353;10252.026057524523;10259.384436933808;10271.589136434459;10283.125934295518;10293.794124117476;5399;5410.91883621746;5414.40441551429;5414.783408663609;5420;4723.881902952454;4883.755812209375;4916.901661966812;4938.703677779345;4942.357493525818;3355.731541476676;3745.419459983707;3767.547894252707;3805.238952209569;3876.6898648108086;996.8704068471052;1153.901918336934;1162.593092417647;1173.7535117625393;1178.2871362825367;846.4794151596724;866.7183165471121;887.7070566712969;914.3416739947228;943.2312665177858;5592.692401917933;5670.149477578396;5967.283925928829;5977.6114552553945;6007.3992600739575;409.47266695226375;429.98065087071154;436.52636888975184;448.5268042215494;458.19586625472084;3545.0782796472586;3741.794201318899;3887.609120390996;3914.080191155076;4047.6964227683043;9891.35706179096;10332.793344133075;10570.788584228427;10997.395143267197;11017.338959662446;10166.644167454104;10402.843957340647;10444.63443779464;10593.311434756715;10782.4069676167;6783.491238157059;8028.237317454832;8044.879326810103;8055.4763940344865;8136.471129376571;5753.453421924911;5894.70526473666;6043.335233124265;6071.908921366095;6103.169049285108;10034.046765557261;10084.991500849856;10094.747631309276;10095.394276343442;10101.595936162765;8671.783205419915;9970.700878973643;10255.435951022766;10287.331323463952;10441.895581044093;7575.431842611716;7733.110692270461;7739.574323412041;7740.26467485588;7764.961175194087;8115.229053239933;8246.54643994586;8321.417500774887;8334.416590838826;8339.624716887633;7333.963330183315;7467;7470.962645186739;7477.92522074794;7548.320651141424;7340.816479588053;7384.96307518459;7385.9630701846145;7467.962660186664;7483.925160748323;5970.432808883149;6994.895076573957;7048.436125110082;7063.399611032914;7078.929210708033;4932.926006109839;5000.899982000413;5073.036123136592;5082.745862706776;5255.921161182662;5082.949170508396;5092.9745351273;5127.512886275797;5169.4830516948;5249.107651699297 05:58:45 INFO - PROCESS | 1670 | |4;prototype.html;301.7133722963185;302.5220152159588;310.87098853975596;315.43222200039924;318.5778843032979;4316.892077698059;4821.734804585755;4930.506949305068;5332.733363331832;5336.745864721787;4416.71291366061;4937.5556199942;5078.79684812608;5099.2606072119615;5264.6051546134;3566.8573257069816;3851.7688938663628;3890.1636148228126;3899.0447340401643;3921.509811273591;3448.4480984585916;3939.3303138466385;3991.241664083829;4031.8588849390276;4064.634182923536;3307.487339462375;3747.4191500317356;3769.8303576338994;3973.7482692951626;4038.8586399476026;3549.432090865462;3986.7873330301672;3988.364770444133;4002.9799851000557;4019.9799001004953;3452.5166476693284;3464.8094354810473;3471.548698669182;3476.217850983534;3479.373712731707;4220.6412454941055;5094.694318340874;5125.641205115643;5125.974370128163;5160.303359046518;4372.431583894106;4506.391637128979;4536.387587675687;4574;4588.0365123324145;4961.652684312099;5528.75120619573;5544.805931792368;5545.3086808523385;5559.581582011838;3696.667299942991;3789.6357311367888;3802.4866643003115;3831.3103641344546;3842.2507611015862;4716.787744551503;5578.30271216098;5821.7380217890295;5853.209816674737;5875.559333050039;3075.984620076885;3860.6911447084167;3863.2466668999837;3868.187680587052;3875.670568001695;3267.725587021064;3928.175083232496;3935.685145188378;3942.4677668514382;3945.467361906106;4177.665786737114;4314.590113939171;4449.221386257392;4548.295014272793;4561.657875659339;5486.423925487846;5605.635633683797;5615.410381909841;5618.719064046863;5628.802991895264;1183.5325046606542;1303.1985329022773;1330.966725831862;1332.946682132704;1340.9741547716005;792.7542461836849;834.5660256666499;859.7576501954741;863.4301361101643;863.4673454618103;4420.602145806893;4780.32301910931;5264.263003179558;5303.522682958475;5359.892802143935;4507.504174540798;5225.137852254412;5712.942870571241;5725.912076705413;5726.3700992890745;4242.851500197478;5114.667546609458;5247.717242999308;5286.810467644749;5325.520703136736;2371.4782747795457;2959.564611163584;2962.4595210490425;2996.2471953906775;3012.156596153037;4909.5090490950615;5617.634853734494;5879.588428810028;5902.734376953047;5958.523318134538;4845.63657725672;5081.390233171969;5247.842564722988;5309;5430.67415955044;4851.738547977551;5805.883882322414;5817.592768506249;5817.94182058174;5831.241938548046;4326.836581709145;4772.761361931959;5525.254090697705;5606.88817706177;5638.815848671825;5569.610127291213;5606.355269144101;5615.634983726045;5628.746706398304;5655.4910058094965;5100.719460429564;5343.4389389113585;5819.534437244925;5830.5627077968475;5899.056151015989;3655.8720444784303;3732.6406234388182;3754.586995430555;3795.0891785970616;3834.213986132892;5168.9483105169975;5494.478024587658;5643.71781410936;5673.574481913791;5679.886402271849;4646.933024204009;4725;5051.494850514919;5470.468268884719;5571.08077167279;4161.708680392465;4593.494715581351;5441.238226648352;5476.09644408684;5533.7390209537625;4945.950540494549;5186.792528298825;5392.838214853561;5402.783888644411;5431.37539182999;4931.3835770528685;5427.232111623021;5478.945210547843;5530.944690553043;5542.7551841504255;4109.630133288018;4579.381783459324;5144.279800827812;5439.5920305976415;5483.341998959991 05:58:45 INFO - PROCESS | 1670 | |5;yui.html;656.7766959233861;698.7833771530823;699.3041923286331;775.5114278004856;801.1587832775584;14844.480443184477;15134.772978405319;15732.764008539882;15742.842571574281;15772.132532710712;14095.01334906557;14410.135391876494;14431.350589223484;14438.133711977289;14450.49423270183;836.347648833909;855.110684887716;855.8074433252531;856.0497847389424;858.8196478739472;671.2113266911384;694.7394726977384;695.7703957693974;823.2261674026425;843.9915600843974;915.5971372596069;919.2691810011024;919.6643225222779;921.8156368726249;922.9676961306355;912.2610685344891;912.8904531456235;916.0335845682802;916.0335845682802;918.2699753695828;519.6154845414366;535.341529918199;539.0539602996755;540.664787831547;674.8279188806823;12268.509259629604;14179.858201417957;14704.411823527045;14771.704565908729;15123.092614443169;14132.576022719335;14401.423943042266;14409.855901440957;14459.855401445957;14858.257087145708;10805.5677772889;10815.83776243357;10841.891581084246;10857.67426977192;11130.05394541457;3805.9809700951596;3810.0284427471097;3845.4231865220163;3880.825362858678;3993.5806740292433;90738.63892041559;96031.51984240035;99499;114461.427692861;124136.65577178712;10863.293885897392;10906.5092070857;11009.724756880982;11050.944745276222;11391.544338226378;21611.67582486264;21742.45643858916;21824.781752182593;21833;22085.779142208692;7916.208379162038;7927.246911543394;7961.920380796118;7982.361411087099;8036.879446808302;4308.870733877989;4393.362962370438;4408.58118478744;4538.750368729751;4583.9083218335445;3544.6455354464347;3705.7035437164964;3707.5550933888107;3708.1841994761107;3711.257748450321;665.6738198282807;673.1249375811426;689.7034275261685;691.2638040486866;696.8710788504143;535.72945662441;583.6381443504969;610.8778244351058;646.1503123392723;655.3904868472271;8722.781930451789;8755.255803256667;9241.168294853496;9350.205232555309;9516.571754271074;617.9124740456739;642.5437939063224;645.8901986662279;656.7176114270814;664.6344510519195;4348.565143485626;4628.143793398232;4652.651051171108;4655.285100314943;4778.1399348117675;93796;118468;124573.37713311557;125026.37486812507;128697;117549.41225293819;118931.40534297274;119970;120011.39994299972;120310;53448.19827702588;90796;91850.08149918549;97648.51175744076;111605.44197278962;8507.489550626982;9245.815083698153;9874.308798384043;9886.406815591088;9926;42250.94372640709;60499.79000420055;61002;61904.69047654913;62473.062904057384;29910.102696919126;75727.48545028959;91773.08226917645;92143.53928230316;93250.60124098009;13056.673583160496;13173.27546984925;13250.337483125997;13301.46794128224;13619.25094119833;14475.420983160555;14717.852821472077;14778;14902.627434314229;15225;13335.933320333335;13507;13595.660108497366;13773.03588748778;14085;13539.796903046265;13542.59372218835;13605.455781768618;13641.522546710818;13685;11597.594084207012;11863.525458981545;11891.28652280866;11922.642320730392;12373.690657733629;10174;10616.734581635521;11443.542258309575;11502.252353596989;11884.46519906589;11395.544178232778;11446.542138314708;11495.76613506506;11545.595904143314;11699.590514331958 05:58:45 INFO - PROCESS | 1670 | __end_tp_report 05:58:45 INFO - PROCESS | 1670 | __start_cc_report 05:58:45 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1760 05:58:45 INFO - PROCESS | 1670 | __end_cc_report 05:58:45 INFO - PROCESS | 1670 | __startTimestamp1474981125719__endTimestamp 05:58:45 INFO - PROCESS | 1670 | 05:58:45 INFO - PROCESS | 1670 | ------- Summary: start ------- 05:58:45 INFO - PROCESS | 1670 | Number of tests: 6 05:58:45 INFO - PROCESS | 1670 | 05:58:45 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5646.70 Median:5731.46 stddev:617.50 (10.8%) stddev-sans-first:590.54 05:58:45 INFO - PROCESS | 1670 | Values: 3268.7 3281.2 3304.8 3311.5 3354.9 5497.8 5572.4 5592.4 5628.5 5663.0 5601.5 5629.4 5629.6 5632.9 5637.3 5087.0 5114.8 5122.3 5126.6 5170.5 5132.2 5194.5 5202.6 5229.1 5245.3 5164.6 5167.8 5179.4 5201.1 5209.5 5217.2 5236.5 5236.6 5241.8 5277.0 5041.4 5045.0 5106.8 5161.4 5179.9 5538.4 5621.1 5639.7 5656.5 5665.2 6123.4 6138.6 6143.2 6147.6 6183.7 6110.2 6139.0 6178.3 6233.4 6251.2 5684.4 5702.5 5722.4 5725.7 5782.3 5662.6 6254.2 6290.2 6295.7 6300.1 5890.6 5900.7 5978.8 6047.2 6055.8 6093.4 6101.0 6102.4 6159.7 6193.0 6123.0 6130.9 6134.8 6139.8 6142.2 6148.6 6149.5 6155.1 6162.4 6171.2 4746.6 4818.1 4822.5 4834.8 4873.0 4363.6 4364.0 4401.0 4404.6 4428.0 5672.3 5708.9 5726.5 5743.7 5748.9 6086.8 6097.6 6130.3 6214.3 6221.1 5683.5 5714.1 5723.9 5755.8 5810.7 5306.4 5306.7 5307.3 5312.9 5325.0 6103.6 6237.5 6245.3 6256.7 6259.6 5930.3 6100.2 6119.4 6142.8 6158.8 6319.8 6330.7 6336.9 6341.3 6365.6 5979.2 6020.4 6026.6 6030.6 6041.0 5850.2 6035.6 6086.2 6095.2 6114.2 5662.4 5716.1 5733.0 5786.1 5786.4 5704.8 5706.2 5713.3 5719.7 5731.5 5526.7 5561.1 5595.9 5707.5 5770.0 5922.1 5951.6 6006.5 6019.1 6079.5 5689.3 5833.0 5833.1 5842.3 5861.6 05:58:45 INFO - PROCESS | 1670 | 05:58:45 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:71242.21 Median:38248.83 stddev:156994.89 (410.5%) stddev-sans-first:157345.49 05:58:45 INFO - PROCESS | 1670 | Values: 514.0 522.6 526.6 530.9 533.7 21541.5 32209.0 32219.0 32226.8 32406.0 32594.3 33233.0 33270.5 33320.5 33395.8 9383.0 9756.3 9789.4 9906.8 9923.7 9682.8 9760.7 9770.0 9784.3 9803.0 8676.9 8836.4 9597.4 9755.4 9785.4 8836.3 11123.7 11291.0 12230.6 12434.7 11938.3 12001.9 12023.9 12025.6 12026.4 40070.0 40229.4 40233.0 40299.0 40337.0 2686.6 3321.7 3338.1 3387.5 3768.3 25105.0 30294.8 30340.7 30645.0 31008.8 3195.5 3211.7 3221.0 3235.1 3328.2 508676.5 511861.0 513592.0 514093.0 520032.0 61114.0 61393.7 61398.8 61421.4 61491.7 54423.9 63965.0 64101.0 64182.0 64218.7 13992.5 15654.2 15894.3 15971.0 16252.3 12298.1 12410.5 12421.2 12423.4 12425.6 13851.6 14017.3 17310.1 17448.9 17456.8 5214.4 6176.4 6217.1 6226.1 6266.9 856.5 909.2 918.3 957.9 1019.7 29554.9 29692.7 29710.4 30225.2 30424.1 886.2 1023.9 1033.5 1046.3 1092.0 14982.8 15421.0 15480.5 15541.4 15784.4 627146.9 633947.0 635400.0 635998.0 636784.0 56700.0 56977.4 57022.0 57087.7 57227.6 1164.0 1191.9 1224.1 1353.6 1379.0 26616.0 30757.4 31544.0 32091.2 33303.3 55409.4 56071.4 56199.9 56207.4 56261.0 600328.0 607617.0 608355.0 608518.0 608801.0 38432.2 38864.8 39647.8 39732.8 39854.4 45563.5 45789.3 46987.8 47088.5 47361.8 29204.9 30187.2 37587.0 39272.0 41581.2 32787.2 37926.8 38065.4 38603.0 39545.6 37348.8 38441.6 38470.0 38696.0 38704.0 25498.0 28280.7 28699.7 32528.0 34230.0 25160.6 25202.4 25215.5 25555.8 25900.7 05:58:45 INFO - PROCESS | 1670 | 05:58:45 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:33699.93 Median:2386.30 stddev:94453.58 (3958.2%) stddev-sans-first:94685.30 05:58:45 INFO - PROCESS | 1670 | Values: 320.3 376.4 378.8 390.7 405.0 18804.2 19481.3 20330.9 20395.7 20547.3 19568.7 19606.5 20092.6 20215.4 20333.6 5302.7 5527.0 5530.8 5616.0 6068.9 6000.6 6099.6 6100.7 6100.8 6119.3 5844.8 6070.7 6073.4 6116.1 6196.3 5966.3 6152.7 6194.3 6197.1 6205.9 5940.3 6004.4 6012.7 6016.4 6019.2 12969.0 13016.9 13023.3 13164.9 13206.8 1880.4 2127.1 2259.8 2512.8 2529.0 9916.1 9942.3 10447.6 13439.4 14037.6 1882.4 1907.8 1919.9 1923.9 1956.1 111970.0 119418.0 119633.0 121702.4 123259.0 11172.4 11215.7 11250.6 11339.5 11624.1 14468.6 14478.3 14479.3 14486.2 14487.9 6930.5 8050.8 8321.7 8358.8 8475.0 8217.4 8217.8 8241.8 8378.9 8400.8 4398.8 4538.6 4551.1 4611.7 4630.8 1501.7 1579.8 1910.3 1912.3 1914.6 847.1 896.9 903.3 916.4 963.2 18245.0 20105.0 20749.9 20786.3 20807.4 739.7 898.2 915.0 918.8 990.1 7950.2 9854.7 10665.8 10764.9 10800.8 555863.0 557448.2 565162.0 568519.0 568721.0 128474.1 128774.0 129941.0 132342.0 133896.9 951.8 967.0 1025.5 1032.0 1037.3 18136.8 18867.7 18976.2 19023.6 19106.0 54047.9 54786.6 55111.7 55139.7 55773.2 71122.6 72047.0 72792.5 74311.6 75247.6 5419.2 5967.3 7682.5 7992.2 8242.0 10171.9 12731.4 12893.0 13480.7 13498.4 10877.3 11018.3 11186.9 11685.5 11854.1 10997.3 11342.2 11406.0 11771.9 11833.8 11310.4 11323.2 11748.8 11911.3 12042.9 8060.5 8068.1 8147.7 8241.4 8375.2 9921.3 10110.3 10920.3 11153.7 11319.9 05:58:45 INFO - PROCESS | 1670 | 05:58:45 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:5675.72 Median:4870.35 stddev:3196.33 (65.6%) stddev-sans-first:3188.60 05:58:45 INFO - PROCESS | 1670 | Values: 1329.2 1380.5 1561.8 1746.8 1923.4 7876.5 8368.1 8377.5 8390.3 8406.6 8181.2 8512.8 8733.5 8784.3 8867.0 1998.0 2353.9 2359.9 2361.2 2385.7 2331.5 2368.1 2382.0 2386.2 2391.8 2357.0 2374.2 2390.8 2392.4 2402.2 2329.5 2357.8 2360.5 2364.1 2381.9 2338.6 2342.0 2349.0 2349.8 2358.1 7512.4 8892.6 8970.5 8980.3 9005.1 4786.1 5006.5 5312.3 5390.4 5393.7 3309.3 3396.6 3499.5 3669.2 3685.2 894.5 1093.6 1097.9 1651.1 1765.9 10059.1 11733.0 11792.8 11920.3 11935.8 4722.0 4737.5 4774.3 4857.0 4896.4 10252.0 10259.4 10271.6 10283.1 10293.8 5399.0 5410.9 5414.4 5414.8 5420.0 4723.9 4883.8 4916.9 4938.7 4942.4 3355.7 3745.4 3767.5 3805.2 3876.7 996.9 1153.9 1162.6 1173.8 1178.3 846.5 866.7 887.7 914.3 943.2 5592.7 5670.1 5967.3 5977.6 6007.4 409.5 430.0 436.5 448.5 458.2 3545.1 3741.8 3887.6 3914.1 4047.7 9891.4 10332.8 10570.8 10997.4 11017.3 10166.6 10402.8 10444.6 10593.3 10782.4 6783.5 8028.2 8044.9 8055.5 8136.5 5753.5 5894.7 6043.3 6071.9 6103.2 10034.0 10085.0 10094.7 10095.4 10101.6 8671.8 9970.7 10255.4 10287.3 10441.9 7575.4 7733.1 7739.6 7740.3 7765.0 8115.2 8246.5 8321.4 8334.4 8339.6 7334.0 7467.0 7471.0 7477.9 7548.3 7340.8 7385.0 7386.0 7468.0 7483.9 5970.4 6994.9 7048.4 7063.4 7078.9 4932.9 5000.9 5073.0 5082.7 5255.9 5082.9 5093.0 5127.5 5169.5 5249.1 05:58:45 INFO - PROCESS | 1670 | 05:58:45 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:4421.50 Median:4930.95 stddev:1359.41 (27.6%) stddev-sans-first:1327.59 05:58:45 INFO - PROCESS | 1670 | Values: 301.7 302.5 310.9 315.4 318.6 4316.9 4821.7 4930.5 5332.7 5336.7 4416.7 4937.6 5078.8 5099.3 5264.6 3566.9 3851.8 3890.2 3899.0 3921.5 3448.4 3939.3 3991.2 4031.9 4064.6 3307.5 3747.4 3769.8 3973.7 4038.9 3549.4 3986.8 3988.4 4003.0 4020.0 3452.5 3464.8 3471.5 3476.2 3479.4 4220.6 5094.7 5125.6 5126.0 5160.3 4372.4 4506.4 4536.4 4574.0 4588.0 4961.7 5528.8 5544.8 5545.3 5559.6 3696.7 3789.6 3802.5 3831.3 3842.3 4716.8 5578.3 5821.7 5853.2 5875.6 3076.0 3860.7 3863.2 3868.2 3875.7 3267.7 3928.2 3935.7 3942.5 3945.5 4177.7 4314.6 4449.2 4548.3 4561.7 5486.4 5605.6 5615.4 5618.7 5628.8 1183.5 1303.2 1331.0 1332.9 1341.0 792.8 834.6 859.8 863.4 863.5 4420.6 4780.3 5264.3 5303.5 5359.9 4507.5 5225.1 5712.9 5725.9 5726.4 4242.9 5114.7 5247.7 5286.8 5325.5 2371.5 2959.6 2962.5 2996.2 3012.2 4909.5 5617.6 5879.6 5902.7 5958.5 4845.6 5081.4 5247.8 5309.0 5430.7 4851.7 5805.9 5817.6 5817.9 5831.2 4326.8 4772.8 5525.3 5606.9 5638.8 5569.6 5606.4 5615.6 5628.7 5655.5 5100.7 5343.4 5819.5 5830.6 5899.1 3655.9 3732.6 3754.6 3795.1 3834.2 5168.9 5494.5 5643.7 5673.6 5679.9 4646.9 4725.0 5051.5 5470.5 5571.1 4161.7 4593.5 5441.2 5476.1 5533.7 4946.0 5186.8 5392.8 5402.8 5431.4 4931.4 5427.2 5478.9 5530.9 5542.8 4109.6 4579.4 5144.3 5439.6 5483.3 05:58:45 INFO - PROCESS | 1670 | 05:58:45 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:22435.68 Median:3863.12 stddev:34493.04 (892.9%) stddev-sans-first:34551.04 05:58:45 INFO - PROCESS | 1670 | Values: 656.8 698.8 699.3 775.5 801.2 14844.5 15134.8 15732.8 15742.8 15772.1 14095.0 14410.1 14431.4 14438.1 14450.5 836.3 855.1 855.8 856.0 858.8 671.2 694.7 695.8 823.2 844.0 915.6 919.3 919.7 921.8 923.0 912.3 912.9 916.0 916.0 918.3 519.6 535.3 539.1 540.7 674.8 12268.5 14179.9 14704.4 14771.7 15123.1 14132.6 14401.4 14409.9 14459.9 14858.3 10805.6 10815.8 10841.9 10857.7 11130.1 3806.0 3810.0 3845.4 3880.8 3993.6 90738.6 96031.5 99499.0 114461.4 124136.7 10863.3 10906.5 11009.7 11050.9 11391.5 21611.7 21742.5 21824.8 21833.0 22085.8 7916.2 7927.2 7961.9 7982.4 8036.9 4308.9 4393.4 4408.6 4538.8 4583.9 3544.6 3705.7 3707.6 3708.2 3711.3 665.7 673.1 689.7 691.3 696.9 535.7 583.6 610.9 646.2 655.4 8722.8 8755.3 9241.2 9350.2 9516.6 617.9 642.5 645.9 656.7 664.6 4348.6 4628.1 4652.7 4655.3 4778.1 93796.0 118468.0 124573.4 125026.4 128697.0 117549.4 118931.4 119970.0 120011.4 120310.0 53448.2 90796.0 91850.1 97648.5 111605.4 8507.5 9245.8 9874.3 9886.4 9926.0 42250.9 60499.8 61002.0 61904.7 62473.1 29910.1 75727.5 91773.1 92143.5 93250.6 13056.7 13173.3 13250.3 13301.5 13619.3 14475.4 14717.9 14778.0 14902.6 15225.0 13335.9 13507.0 13595.7 13773.0 14085.0 13539.8 13542.6 13605.5 13641.5 13685.0 11597.6 11863.5 11891.3 11922.6 12373.7 10174.0 10616.7 11443.5 11502.3 11884.5 11395.5 11446.5 11495.8 11545.6 11699.6 05:58:45 INFO - PROCESS | 1670 | -------- Summary: end -------- 05:58:45 INFO - PROCESS | 1670 | 05:58:46 INFO - TEST-INFO | 1670: exit 0 05:58:46 INFO - TEST-OK | dromaeo_css | took 1117329ms 05:58:46 INFO - TEST-START | kraken 05:58:46 INFO - operating with platform_type : mac_ 05:58:46 INFO - Initialising browser for kraken test... 05:58:46 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmp2fiP7Z/profile http://localhost:49280/getInfo.html) 05:58:48 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 05:58:48 INFO - PROCESS | 1676 | colorDepth:24 05:58:48 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 05:58:48 INFO - PROCESS | 1676 | __metrics 05:58:48 INFO - PROCESS | 1676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:58:48 INFO - PROCESS | 1676 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:58:49 INFO - TEST-INFO | 1676: exit 0 05:58:49 INFO - Browser initialized. 05:58:49 INFO - Running cycle 1/1 for kraken test... 05:58:49 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmp2fiP7Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:01 INFO - PROCESS | 1678 | RSS: Main: 235876352 05:59:01 INFO - PROCESS | 1678 | 05:59:04 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 05:59:05 INFO - PROCESS | 1678 | RSS: Main: 294633472 05:59:05 INFO - PROCESS | 1678 | 05:59:08 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 05:59:08 INFO - PROCESS | 1678 | RSS: Main: 295780352 05:59:08 INFO - PROCESS | 1678 | 05:59:12 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 05:59:13 INFO - PROCESS | 1678 | RSS: Main: 383356928 05:59:13 INFO - PROCESS | 1678 | 05:59:15 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 05:59:15 INFO - PROCESS | 1678 | RSS: Main: 284467200 05:59:15 INFO - PROCESS | 1678 | 05:59:17 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:59:18 INFO - PROCESS | 1678 | RSS: Main: 286806016 05:59:18 INFO - PROCESS | 1678 | 05:59:21 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 05:59:21 INFO - PROCESS | 1678 | RSS: Main: 324702208 05:59:21 INFO - PROCESS | 1678 | 05:59:24 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 05:59:25 INFO - PROCESS | 1678 | RSS: Main: 324907008 05:59:25 INFO - PROCESS | 1678 | 05:59:28 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 05:59:29 INFO - PROCESS | 1678 | RSS: Main: 324583424 05:59:29 INFO - PROCESS | 1678 | 05:59:30 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:59:31 INFO - PROCESS | 1678 | RSS: Main: 299487232 05:59:31 INFO - PROCESS | 1678 | 05:59:33 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:59:33 INFO - PROCESS | 1678 | RSS: Main: 303607808 05:59:33 INFO - PROCESS | 1678 | 05:59:36 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:59:36 INFO - PROCESS | 1678 | RSS: Main: 311672832 05:59:36 INFO - PROCESS | 1678 | 05:59:39 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:59:40 INFO - PROCESS | 1678 | RSS: Main: 317685760 05:59:40 INFO - PROCESS | 1678 | 05:59:43 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:59:43 INFO - PROCESS | 1678 | RSS: Main: 320065536 05:59:43 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 05:59:45 INFO - PROCESS | 1678 | RSS: Main: 362782720 05:59:45 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | __start_tp_report 05:59:45 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 05:59:45 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 05:59:45 INFO - PROCESS | 1678 | |i|pagename|runs| 05:59:45 INFO - PROCESS | 1678 | |0;ai-astar;155;169;139;115;114;113;113;114;113;112 05:59:45 INFO - PROCESS | 1678 | |1;audio-beat-detection;150;131;138;151;111;91;123;145;176;110 05:59:45 INFO - PROCESS | 1678 | |2;audio-dft;182;182;182;183;185;181;259;258;183;182 05:59:45 INFO - PROCESS | 1678 | |3;audio-fft;77;60;61;105;84;84;58;62;91;58 05:59:45 INFO - PROCESS | 1678 | |4;audio-oscillator;90;75;94;72;90;100;128;76;70;90 05:59:45 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;118;129;90;88;90;87;91;88;90;88 05:59:45 INFO - PROCESS | 1678 | |6;imaging-darkroom;98;101;97;98;107;159;160;98;98;98 05:59:45 INFO - PROCESS | 1678 | |7;imaging-desaturate;83;87;87;126;140;113;83;87;85;86 05:59:45 INFO - PROCESS | 1678 | |8;json-parse-financial;55;53;53;53;54;54;56;54;53;53 05:59:45 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;66;73;68;79;72;73;69;70;70;71 05:59:45 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;84;89;87;86;88;88;87;83;90;89 05:59:45 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;151;172;116;136;147;151;150;136;169;140 05:59:45 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;170;167;169;169;169;168;167;168;169;168 05:59:45 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;67;68;69;67;68;70;80;83;84;83 05:59:45 INFO - PROCESS | 1678 | __end_tp_report 05:59:45 INFO - PROCESS | 1678 | __start_cc_report 05:59:45 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1956 05:59:45 INFO - PROCESS | 1678 | __end_cc_report 05:59:45 INFO - PROCESS | 1678 | __startTimestamp1474981185951__endTimestamp 05:59:45 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | ------- Summary: start ------- 05:59:45 INFO - PROCESS | 1678 | Number of tests: 14 05:59:45 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:125.70 Median:114.50 stddev:21.00 (18.3%) stddev-sans-first:19.42 05:59:45 INFO - PROCESS | 1678 | Values: 155.0 169.0 139.0 115.0 114.0 113.0 113.0 114.0 113.0 112.0 05:59:45 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:147.50 stddev:24.74 (16.8%) stddev-sans-first:25.43 05:59:45 INFO - PROCESS | 1678 | Values: 150.0 131.0 138.0 151.0 111.0 91.0 123.0 145.0 176.0 110.0 05:59:45 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:197.70 Median:183.00 stddev:32.06 (17.5%) stddev-sans-first:33.50 05:59:45 INFO - PROCESS | 1678 | Values: 182.0 182.0 182.0 183.0 185.0 181.0 259.0 258.0 183.0 182.0 05:59:45 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:74.00 Median:69.50 stddev:16.60 (23.9%) stddev-sans-first:17.57 05:59:45 INFO - PROCESS | 1678 | Values: 77.0 60.0 61.0 105.0 84.0 84.0 58.0 62.0 91.0 58.0 05:59:45 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:88.50 Median:83.00 stddev:17.26 (20.8%) stddev-sans-first:18.30 05:59:45 INFO - PROCESS | 1678 | Values: 90.0 75.0 94.0 72.0 90.0 100.0 128.0 76.0 70.0 90.0 05:59:45 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:95.90 Median:89.00 stddev:14.83 (16.7%) stddev-sans-first:13.40 05:59:45 INFO - PROCESS | 1678 | Values: 118.0 129.0 90.0 88.0 90.0 87.0 91.0 88.0 90.0 88.0 05:59:45 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:111.40 Median:98.00 stddev:25.52 (26.0%) stddev-sans-first:26.60 05:59:45 INFO - PROCESS | 1678 | Values: 98.0 101.0 97.0 98.0 107.0 159.0 160.0 98.0 98.0 98.0 05:59:45 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:85.50 stddev:20.81 (24.3%) stddev-sans-first:21.38 05:59:45 INFO - PROCESS | 1678 | Values: 83.0 87.0 87.0 126.0 140.0 113.0 83.0 87.0 85.0 86.0 05:59:45 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.03 (1.9%) stddev-sans-first:1.00 05:59:45 INFO - PROCESS | 1678 | Values: 55.0 53.0 53.0 53.0 54.0 54.0 56.0 54.0 53.0 53.0 05:59:45 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.50 stddev:3.54 (5.0%) stddev-sans-first:3.24 05:59:45 INFO - PROCESS | 1678 | Values: 66.0 73.0 68.0 79.0 72.0 73.0 69.0 70.0 70.0 71.0 05:59:45 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:88.00 stddev:2.23 (2.5%) stddev-sans-first:2.07 05:59:45 INFO - PROCESS | 1678 | Values: 84.0 89.0 87.0 86.0 88.0 88.0 87.0 83.0 90.0 89.0 05:59:45 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:150.50 stddev:16.34 (10.9%) stddev-sans-first:17.26 05:59:45 INFO - PROCESS | 1678 | Values: 151.0 172.0 116.0 136.0 147.0 151.0 150.0 136.0 169.0 140.0 05:59:45 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:169.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 05:59:45 INFO - PROCESS | 1678 | Values: 170.0 167.0 169.0 169.0 169.0 168.0 167.0 168.0 169.0 168.0 05:59:45 INFO - PROCESS | 1678 | 05:59:45 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:75.00 stddev:7.52 (10.0%) stddev-sans-first:7.55 05:59:45 INFO - PROCESS | 1678 | Values: 67.0 68.0 69.0 67.0 68.0 70.0 80.0 83.0 84.0 83.0 05:59:45 INFO - PROCESS | 1678 | -------- Summary: end -------- 05:59:45 INFO - PROCESS | 1678 | 05:59:46 INFO - TEST-INFO | 1678: exit 0 05:59:46 INFO - TEST-OK | kraken | took 60496ms 05:59:46 INFO - SUITE-END | took 1177s 05:59:47 INFO - Completed test suite (00:19:38) 05:59:47 INFO - javascript benchmark 05:59:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3268.7221586165174, 3281.245313577877, 3304.7521435892313, 3311.4701647736338, 3354.899353019409, 5497.780088796443, 5572.442755724425, 5592.4407559244055, 5628.493435590796, 5663.0, 5601.523870471015, 5629.437056294369, 5629.6340737852015, 5632.915506267399, 5637.3235211774545, 5086.974565127179, 5114.7698353574, 5122.282880396748, 5126.641135120543, 5170.53465188133, 5132.178851383779, 5194.454582268864, 5202.583793296546, 5229.137192363255, 5245.344331958505, 5164.586833053347, 5167.767450464719, 5179.378474583036, 5201.0898092833795, 5209.479052094798, 5217.191335343028, 5236.450172731885, 5236.554892834114, 5241.816536421207, 5276.9736151319385, 5041.395032596112, 5045.0, 5106.770195341219, 5161.4322424533275, 5179.896402071938, 5538.418466061086, 5621.128725047624, 5639.746211420496, 5656.547476201935, 5665.178549110397, 6123.357047509992, 6138.570300078996, 6143.201383820075, 6147.600405973642, 6183.690815459209, 6110.175126357974, 6139.017757158833, 6178.320384757673, 6233.407826256498, 6251.187345645082, 5684.4315568443235, 5702.4582664647205, 5722.399148089474, 5725.685087320154, 5782.335031471434, 5662.6036177468, 6254.186955695731, 6290.24517057956, 6295.716692748837, 6300.086487459293, 5890.617109887844, 5900.675462849585, 5978.790742323998, 6047.15339852421, 6055.788047418319, 6093.360197179321, 6101.03536932808, 6102.398363691488, 6159.6612186329285, 6193.0, 6123.0, 6130.877382452326, 6134.8159555213415, 6139.754409823647, 6142.170806941095, 6148.569600128038, 6149.5080393568405, 6155.1075094112, 6162.352952939967, 6171.228596425447, 4746.59653929413, 4818.060478206786, 4822.493638168012, 4834.806607735722, 4873.025394920959, 4363.563643635611, 4364.0, 4400.977995110004, 4404.6035856772405, 4428.0, 5672.262605861211, 5708.857278567986, 5726.513246374022, 5743.741531631003, 5748.913766293509, 6086.756529738849, 6097.573169878155, 6130.3369889931655, 6214.25428948529, 6221.06683997395, 5683.54531637468, 5714.114312281603, 5723.942760572341, 5755.798547050833, 5810.651360918274, 5306.416294207634, 5306.708131052829, 5307.283516725192, 5312.893742125136, 5325.0148722486465, 6103.610425594382, 6237.4698150656795, 6245.250569931637, 6256.74973001084, 6259.561830671809, 5930.34766175729, 6100.157317757147, 6119.441623354662, 6142.805741014558, 6158.815235542941, 6319.842003949938, 6330.746770129327, 6336.873262534631, 6341.302456729663, 6365.586236894772, 5979.192808970907, 6020.4280593343565, 6026.638401695912, 6030.638161710312, 6040.969795150996, 5850.23946886902, 6035.6076855004285, 6086.239220097488, 6095.207623009158, 6114.175715401237, 5662.433756624305, 5716.114002329646, 5733.02538568436, 5786.132080188006, 5786.363500014911, 5704.80033198836, 5706.201131841629, 5713.314402271754, 5719.7426115824055, 5731.455511726379, 5526.723663816712, 5561.110222364564, 5595.860103497445, 5707.5433965281845, 5769.9711501442225, 5922.082077278029, 5951.583389162717, 6006.549508786771, 6019.097135429721, 6079.544034197364, 5689.288838895138, 5832.970835145967, 5833.0667093266575, 5842.269716285465, 5861.560382971379], "value": 5607.010103157501, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.9665921715089, 522.5975998481168, 526.6339893773826, 530.8725905782613, 533.6851257757925, 21541.4614634634, 32209.0, 32219.03342899714, 32226.83886580564, 32406.0, 32594.348113037784, 33233.018056749774, 33270.50094248588, 33320.50019249713, 33395.83302083492, 9382.999999999984, 9756.268279879003, 9789.412635241908, 9906.801863962717, 9923.702288931343, 9682.806343873119, 9760.707178784647, 9770.0, 9784.315097943147, 9803.0, 8676.8698469523, 8836.42563233391, 9597.424154550748, 9755.41467511948, 9785.412875227474, 8836.33727470439, 11123.72077211119, 11291.040261577777, 12230.571929982409, 12434.689132771662, 11938.28370297785, 12001.87998120025, 12023.939880300542, 12025.57910473138, 12026.39868006605, 40070.0, 40229.39655905164, 40233.0, 40299.0, 40337.0, 2686.5835795451735, 3321.7342612590933, 3338.0820274424727, 3387.5088112223834, 3768.302863970147, 25104.995800168155, 30294.84852575723, 30340.69659303401, 30645.0, 31008.8449557753, 3195.472746996743, 3211.7270032047304, 3221.0497903118635, 3235.142687187897, 3328.1845947742718, 508676.45661771455, 511861.0, 513592.0, 514093.0, 520032.0, 61114.0, 61393.69303153545, 61398.79018147314, 61421.38578614157, 61491.6925415379, 54423.91152176934, 63965.0, 64101.038484422774, 64182.0, 64218.67890660517, 13992.510262140777, 15654.217289135499, 15894.284757185955, 15971.0, 16252.268647910872, 12298.139130260975, 12410.503579856886, 12421.19262247951, 12423.378831058591, 12425.565105221274, 13851.584452466443, 14017.299135043411, 17310.134493275287, 17448.912755436395, 17456.825431745772, 5214.374275087014, 6176.382361763877, 6217.129601855744, 6226.104861239545, 6266.937330626726, 856.5374697663317, 909.2453263791037, 918.3020904112923, 957.8706874571983, 1019.6991887393089, 29554.852225738734, 29692.663830127694, 29710.405791884474, 30225.244368890515, 30424.087277381714, 886.2334081019872, 1023.9436830974367, 1033.503918119307, 1046.2937517176028, 1091.9508622111864, 14982.775258371134, 15421.0, 15480.5355839325, 15541.42033974398, 15784.447544335893, 627146.8642656758, 633947.0, 635400.0, 635998.0, 636784.0, 56700.0, 56977.430225698045, 57022.0, 57087.714561426925, 57227.56931076756, 1164.0047759165961, 1191.92252503587, 1224.1430998301225, 1353.61421994733, 1378.9793153102712, 26616.0, 30757.384852303276, 31544.0, 32091.19772005625, 33303.33393332071, 55409.44590554043, 56071.439285608256, 56199.87600248054, 56207.43792562022, 56261.0, 600328.0, 607617.0, 608355.0, 608518.0, 608801.0, 38432.2313553733, 38864.80567597144, 39647.80176099101, 39732.801335993136, 39854.40218396668, 45563.54436455593, 45789.31316030329, 46987.76506117584, 47088.52911470841, 47361.763191183825, 29204.853975729984, 30187.245318866324, 37587.0, 39272.01819954524, 41581.1683766329, 32787.18032049122, 37926.810365948, 38065.4290185653, 38603.0, 39545.60454395534, 37348.813255934634, 38441.61558384492, 38470.0, 38696.032599185244, 38704.0, 25498.0, 28280.717192827808, 28699.71300287054, 32528.0, 34229.973100807016, 25160.622590661522, 25202.36184647992, 25215.495690086464, 25555.84998675027, 25900.740992590585], "value": 19741.854637754965, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.2633941933553, 376.42031271841347, 378.8371000469798, 390.6796426929915, 404.9878503644892, 18804.24783008678, 19481.318153864617, 20330.89834550829, 20395.694064589043, 20547.280845170386, 19568.70646940297, 19606.50983725404, 20092.598148037032, 20215.393538193843, 20333.59332813343, 5302.681839089648, 5527.0, 5530.778768849241, 5615.971920140393, 6068.878622427549, 6000.639961602296, 6099.634021958675, 6100.725467353957, 6100.81697549072, 6119.326874043873, 5844.795432159875, 6070.696465176746, 6073.362296958822, 6116.0520119381345, 6196.318404975449, 5966.343702192756, 6152.661603611799, 6194.256689197326, 6197.101420294032, 6205.9069113963105, 5940.257467816523, 6004.399560044004, 6012.699365031731, 6016.368281330485, 6019.187409699678, 12969.0, 13016.869831301661, 13023.28371939543, 13164.86835131646, 13206.820874555688, 1880.3982725527837, 2127.106615221611, 2259.762724913877, 2512.8366656167473, 2529.0389651932333, 9916.107550320434, 9942.304038717293, 10447.582096716122, 13439.395227214798, 14037.578872633838, 1882.3694062489083, 1907.83783378413, 1919.865609407342, 1923.855710821694, 1956.1392987085637, 111970.0, 119418.0, 119633.0, 121702.39148804288, 123259.0, 11172.385518796544, 11215.66353009411, 11250.606228781953, 11339.546418143182, 11624.070074394198, 14468.638284042983, 14478.276086195649, 14479.276036198358, 14486.203258820655, 14487.855121448862, 6930.5148639594745, 8050.758477245692, 8321.708740194184, 8358.832823343499, 8475.0, 8217.424780265444, 8217.83564328722, 8241.752747417588, 8378.916210837813, 8400.83198336042, 4398.780060996937, 4538.614217791524, 4551.112533056023, 4611.7232966021475, 4630.83792067276, 1501.6996600679909, 1579.8025246844145, 1910.2931915191468, 1912.2733361322607, 1914.5787926656114, 847.1443841719907, 896.8968568614563, 903.2728653434049, 916.4318122763929, 963.1524258652481, 18245.0, 20105.0, 20749.89625051865, 20786.27248046311, 20807.375778726662, 739.7336958694866, 898.1662853696598, 914.9862752058724, 918.7611221082567, 990.1484723138095, 7950.165232650604, 9854.655087071918, 10665.786684266272, 10764.946175269073, 10800.837987430195, 555863.0, 557448.2127589417, 565162.0, 568519.0, 568721.0, 128474.07288890674, 128774.0, 129941.0, 132342.0, 133896.88165485163, 951.8143961927497, 967.0, 1025.5231317437429, 1032.0195813976752, 1037.2998226197287, 18136.818631813512, 18867.716984244973, 18976.240950362382, 19023.619527609095, 19106.0, 54047.91904161816, 54786.63033424196, 55111.72444137753, 55139.724301378235, 55773.16340254818, 71122.64438677774, 72047.0, 72792.54414911778, 74311.62844185745, 75247.62376188303, 5419.214213938878, 5967.254093238345, 7682.462227644011, 7992.16082311349, 8241.95879020601, 10171.898281017095, 12731.363431828186, 12893.0, 13480.6629834251, 13498.392572334073, 10877.347359158475, 11018.283811552223, 11186.944065279622, 11685.532578696757, 11854.051675866083, 10997.285176463503, 11342.20604557673, 11405.973462388425, 11771.941140294244, 11833.82249266279, 11310.377929213972, 11323.16792901538, 11748.765024699287, 11911.344876031555, 12042.879571204527, 8060.476069055727, 8068.12729889668, 8147.714829980922, 8241.423100382915, 8375.20435558621, 9921.305508614329, 10110.342827716175, 10920.344779313267, 11153.665390038312, 11319.886801131883], "value": 9332.66929939787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.2024785128922, 1380.468519619946, 1561.8125824901012, 1746.8427841494263, 1923.3556758485906, 7876.488028278165, 8368.079511253758, 8377.497350158994, 8390.286825619822, 8406.579671016456, 8181.181881811815, 8512.787180320494, 8733.475991440502, 8784.341174411913, 8866.980297265816, 1997.9600407991868, 2353.870537120458, 2359.917402890899, 2361.2207971369407, 2385.737568867432, 2331.463763334434, 2368.100121953655, 2382.0233704181287, 2386.1767690146958, 2391.820613453989, 2357.0, 2374.2165085521824, 2390.8206884483734, 2392.449736560592, 2402.159244264511, 2329.4758679297192, 2357.8467399619058, 2360.527894421114, 2364.1252736487436, 2381.904723811063, 2338.649202619604, 2341.9648705269433, 2349.036894873094, 2349.835511514195, 2358.0803486640225, 7512.436567257478, 8892.555372231363, 8970.50662213578, 8980.281577473786, 9005.14451127142, 4786.0667169901535, 5006.4743201964, 5312.335958005249, 5390.434004429557, 5393.73031348435, 3309.3381323735107, 3396.575428071491, 3499.4925735768425, 3669.192777588926, 3685.244524872395, 894.485670739321, 1093.578972095741, 1097.868255809308, 1651.1414064686296, 1765.938192163268, 10059.144972677332, 11733.0, 11792.823107653392, 11920.344381059038, 11935.820962685566, 4722.0, 4737.5397150264225, 4774.2599897015325, 4856.95143048572, 4896.436909755353, 10252.026057524523, 10259.384436933808, 10271.589136434459, 10283.125934295518, 10293.794124117476, 5399.0, 5410.91883621746, 5414.40441551429, 5414.783408663609, 5420.0, 4723.881902952454, 4883.755812209375, 4916.901661966812, 4938.703677779345, 4942.357493525818, 3355.731541476676, 3745.419459983707, 3767.547894252707, 3805.238952209569, 3876.6898648108086, 996.8704068471052, 1153.901918336934, 1162.593092417647, 1173.7535117625393, 1178.2871362825367, 846.4794151596724, 866.7183165471121, 887.7070566712969, 914.3416739947228, 943.2312665177858, 5592.692401917933, 5670.149477578396, 5967.283925928829, 5977.6114552553945, 6007.3992600739575, 409.47266695226375, 429.98065087071154, 436.52636888975184, 448.5268042215494, 458.19586625472084, 3545.0782796472586, 3741.794201318899, 3887.609120390996, 3914.080191155076, 4047.6964227683043, 9891.35706179096, 10332.793344133075, 10570.788584228427, 10997.395143267197, 11017.338959662446, 10166.644167454104, 10402.843957340647, 10444.63443779464, 10593.311434756715, 10782.4069676167, 6783.491238157059, 8028.237317454832, 8044.879326810103, 8055.4763940344865, 8136.471129376571, 5753.453421924911, 5894.70526473666, 6043.335233124265, 6071.908921366095, 6103.169049285108, 10034.046765557261, 10084.991500849856, 10094.747631309276, 10095.394276343442, 10101.595936162765, 8671.783205419915, 9970.700878973643, 10255.435951022766, 10287.331323463952, 10441.895581044093, 7575.431842611716, 7733.110692270461, 7739.574323412041, 7740.26467485588, 7764.961175194087, 8115.229053239933, 8246.54643994586, 8321.417500774887, 8334.416590838826, 8339.624716887633, 7333.963330183315, 7467.0, 7470.962645186739, 7477.92522074794, 7548.320651141424, 7340.816479588053, 7384.96307518459, 7385.9630701846145, 7467.962660186664, 7483.925160748323, 5970.432808883149, 6994.895076573957, 7048.436125110082, 7063.399611032914, 7078.929210708033, 4932.926006109839, 5000.899982000413, 5073.036123136592, 5082.745862706776, 5255.921161182662, 5082.949170508396, 5092.9745351273, 5127.512886275797, 5169.4830516948, 5249.107651699297], "value": 4487.8425311972205, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.7133722963185, 302.5220152159588, 310.87098853975596, 315.43222200039924, 318.5778843032979, 4316.892077698059, 4821.734804585755, 4930.506949305068, 5332.733363331832, 5336.745864721787, 4416.71291366061, 4937.5556199942, 5078.79684812608, 5099.2606072119615, 5264.6051546134, 3566.8573257069816, 3851.7688938663628, 3890.1636148228126, 3899.0447340401643, 3921.509811273591, 3448.4480984585916, 3939.3303138466385, 3991.241664083829, 4031.8588849390276, 4064.634182923536, 3307.487339462375, 3747.4191500317356, 3769.8303576338994, 3973.7482692951626, 4038.8586399476026, 3549.432090865462, 3986.7873330301672, 3988.364770444133, 4002.9799851000557, 4019.9799001004953, 3452.5166476693284, 3464.8094354810473, 3471.548698669182, 3476.217850983534, 3479.373712731707, 4220.6412454941055, 5094.694318340874, 5125.641205115643, 5125.974370128163, 5160.303359046518, 4372.431583894106, 4506.391637128979, 4536.387587675687, 4574.0, 4588.0365123324145, 4961.652684312099, 5528.75120619573, 5544.805931792368, 5545.3086808523385, 5559.581582011838, 3696.667299942991, 3789.6357311367888, 3802.4866643003115, 3831.3103641344546, 3842.2507611015862, 4716.787744551503, 5578.30271216098, 5821.7380217890295, 5853.209816674737, 5875.559333050039, 3075.984620076885, 3860.6911447084167, 3863.2466668999837, 3868.187680587052, 3875.670568001695, 3267.725587021064, 3928.175083232496, 3935.685145188378, 3942.4677668514382, 3945.467361906106, 4177.665786737114, 4314.590113939171, 4449.221386257392, 4548.295014272793, 4561.657875659339, 5486.423925487846, 5605.635633683797, 5615.410381909841, 5618.719064046863, 5628.802991895264, 1183.5325046606542, 1303.1985329022773, 1330.966725831862, 1332.946682132704, 1340.9741547716005, 792.7542461836849, 834.5660256666499, 859.7576501954741, 863.4301361101643, 863.4673454618103, 4420.602145806893, 4780.32301910931, 5264.263003179558, 5303.522682958475, 5359.892802143935, 4507.504174540798, 5225.137852254412, 5712.942870571241, 5725.912076705413, 5726.3700992890745, 4242.851500197478, 5114.667546609458, 5247.717242999308, 5286.810467644749, 5325.520703136736, 2371.4782747795457, 2959.564611163584, 2962.4595210490425, 2996.2471953906775, 3012.156596153037, 4909.5090490950615, 5617.634853734494, 5879.588428810028, 5902.734376953047, 5958.523318134538, 4845.63657725672, 5081.390233171969, 5247.842564722988, 5309.0, 5430.67415955044, 4851.738547977551, 5805.883882322414, 5817.592768506249, 5817.94182058174, 5831.241938548046, 4326.836581709145, 4772.761361931959, 5525.254090697705, 5606.88817706177, 5638.815848671825, 5569.610127291213, 5606.355269144101, 5615.634983726045, 5628.746706398304, 5655.4910058094965, 5100.719460429564, 5343.4389389113585, 5819.534437244925, 5830.5627077968475, 5899.056151015989, 3655.8720444784303, 3732.6406234388182, 3754.586995430555, 3795.0891785970616, 3834.213986132892, 5168.9483105169975, 5494.478024587658, 5643.71781410936, 5673.574481913791, 5679.886402271849, 4646.933024204009, 4725.0, 5051.494850514919, 5470.468268884719, 5571.08077167279, 4161.708680392465, 4593.494715581351, 5441.238226648352, 5476.09644408684, 5533.7390209537625, 4945.950540494549, 5186.792528298825, 5392.838214853561, 5402.783888644411, 5431.37539182999, 4931.3835770528685, 5427.232111623021, 5478.945210547843, 5530.944690553043, 5542.7551841504255, 4109.630133288018, 4579.381783459324, 5144.279800827812, 5439.5920305976415, 5483.341998959991], "value": 3993.0021280566116, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.7766959233861, 698.7833771530823, 699.3041923286331, 775.5114278004856, 801.1587832775584, 14844.480443184477, 15134.772978405319, 15732.764008539882, 15742.842571574281, 15772.132532710712, 14095.01334906557, 14410.135391876494, 14431.350589223484, 14438.133711977289, 14450.49423270183, 836.347648833909, 855.110684887716, 855.8074433252531, 856.0497847389424, 858.8196478739472, 671.2113266911384, 694.7394726977384, 695.7703957693974, 823.2261674026425, 843.9915600843974, 915.5971372596069, 919.2691810011024, 919.6643225222779, 921.8156368726249, 922.9676961306355, 912.2610685344891, 912.8904531456235, 916.0335845682802, 916.0335845682802, 918.2699753695828, 519.6154845414366, 535.341529918199, 539.0539602996755, 540.664787831547, 674.8279188806823, 12268.509259629604, 14179.858201417957, 14704.411823527045, 14771.704565908729, 15123.092614443169, 14132.576022719335, 14401.423943042266, 14409.855901440957, 14459.855401445957, 14858.257087145708, 10805.5677772889, 10815.83776243357, 10841.891581084246, 10857.67426977192, 11130.05394541457, 3805.9809700951596, 3810.0284427471097, 3845.4231865220163, 3880.825362858678, 3993.5806740292433, 90738.63892041559, 96031.51984240035, 99499.0, 114461.427692861, 124136.65577178712, 10863.293885897392, 10906.5092070857, 11009.724756880982, 11050.944745276222, 11391.544338226378, 21611.67582486264, 21742.45643858916, 21824.781752182593, 21833.0, 22085.779142208692, 7916.208379162038, 7927.246911543394, 7961.920380796118, 7982.361411087099, 8036.879446808302, 4308.870733877989, 4393.362962370438, 4408.58118478744, 4538.750368729751, 4583.9083218335445, 3544.6455354464347, 3705.7035437164964, 3707.5550933888107, 3708.1841994761107, 3711.257748450321, 665.6738198282807, 673.1249375811426, 689.7034275261685, 691.2638040486866, 696.8710788504143, 535.72945662441, 583.6381443504969, 610.8778244351058, 646.1503123392723, 655.3904868472271, 8722.781930451789, 8755.255803256667, 9241.168294853496, 9350.205232555309, 9516.571754271074, 617.9124740456739, 642.5437939063224, 645.8901986662279, 656.7176114270814, 664.6344510519195, 4348.565143485626, 4628.143793398232, 4652.651051171108, 4655.285100314943, 4778.1399348117675, 93796.0, 118468.0, 124573.37713311557, 125026.37486812507, 128697.0, 117549.41225293819, 118931.40534297274, 119970.0, 120011.39994299972, 120310.0, 53448.19827702588, 90796.0, 91850.08149918549, 97648.51175744076, 111605.44197278962, 8507.489550626982, 9245.815083698153, 9874.308798384043, 9886.406815591088, 9926.0, 42250.94372640709, 60499.79000420055, 61002.0, 61904.69047654913, 62473.062904057384, 29910.102696919126, 75727.48545028959, 91773.08226917645, 92143.53928230316, 93250.60124098009, 13056.673583160496, 13173.27546984925, 13250.337483125997, 13301.46794128224, 13619.25094119833, 14475.420983160555, 14717.852821472077, 14778.0, 14902.627434314229, 15225.0, 13335.933320333335, 13507.0, 13595.660108497366, 13773.03588748778, 14085.0, 13539.796903046265, 13542.59372218835, 13605.455781768618, 13641.522546710818, 13685.0, 11597.594084207012, 11863.525458981545, 11891.28652280866, 11922.642320730392, 12373.690657733629, 10174.0, 10616.734581635521, 11443.542258309575, 11502.252353596989, 11884.46519906589, 11395.544178232778, 11446.542138314708, 11495.76613506506, 11545.595904143314, 11699.590514331958], "value": 7577.724744484214, "unit": "score"}], "name": "dromaeo_css", "value": 7208.442076084427, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 169.0, 139.0, 115.0, 114.0, 113.0, 113.0, 114.0, 113.0, 112.0], "value": 125.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 131.0, 138.0, 151.0, 111.0, 91.0, 123.0, 145.0, 176.0, 110.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 182.0, 183.0, 185.0, 181.0, 259.0, 258.0, 183.0, 182.0], "value": 197.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 60.0, 61.0, 105.0, 84.0, 84.0, 58.0, 62.0, 91.0, 58.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 75.0, 94.0, 72.0, 90.0, 100.0, 128.0, 76.0, 70.0, 90.0], "value": 88.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 129.0, 90.0, 88.0, 90.0, 87.0, 91.0, 88.0, 90.0, 88.0], "value": 95.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 101.0, 97.0, 98.0, 107.0, 159.0, 160.0, 98.0, 98.0, 98.0], "value": 111.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 87.0, 126.0, 140.0, 113.0, 83.0, 87.0, 85.0, 86.0], "value": 97.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 53.0, 54.0, 54.0, 56.0, 54.0, 53.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 68.0, 79.0, 72.0, 73.0, 69.0, 70.0, 70.0, 71.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 89.0, 87.0, 86.0, 88.0, 88.0, 87.0, 83.0, 90.0, 89.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 172.0, 116.0, 136.0, 147.0, 151.0, 150.0, 136.0, 169.0, 140.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 167.0, 169.0, 169.0, 169.0, 168.0, 167.0, 168.0, 169.0, 168.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 67.0, 68.0, 70.0, 80.0, 83.0, 84.0, 83.0], "value": 73.9, "unit": "score"}], "name": "kraken", "value": 1524.6, "alertThreshold": 2.0}]} 05:59:47 INFO - Return code: 0 05:59:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:59:47 INFO - # TBPL SUCCESS # 05:59:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:59:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:59:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:59:47 INFO - 2016-09-27 05:59:47.274 screenresolution[1682:11024] starting screenresolution argv=screenresolution get 05:59:47 INFO - 2016-09-27 05:59:47.277 screenresolution[1682:11024] Display 0: 1600x1200x32@60 05:59:47 INFO - 2016-09-27 05:59:47.283 screenresolution[1683:11027] starting screenresolution argv=screenresolution list 05:59:47 INFO - Available Modes on Display 0 05:59:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:59:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:59:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:59:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:59:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:59:47 INFO - Intel Iris: 05:59:47 INFO - Chipset Model: Intel Iris 05:59:47 INFO - Type: GPU 05:59:47 INFO - Bus: Built-In 05:59:47 INFO - VRAM (Dynamic, Max): 1536 MB 05:59:47 INFO - Vendor: Intel (0x8086) 05:59:47 INFO - Device ID: 0x0a2e 05:59:47 INFO - Revision ID: 0x0009 05:59:47 INFO - Displays: 05:59:47 INFO - Display: 05:59:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:59:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:59:47 INFO - Display Serial Number: 1600x1200 60 05:59:47 INFO - Main Display: Yes 05:59:47 INFO - Mirror: Off 05:59:47 INFO - Online: Yes 05:59:47 INFO - Rotation: Supported 05:59:47 INFO - Return code: 0 05:59:47 INFO - Running post-action listener: _resource_record_post_action 05:59:47 INFO - [mozharness: 2016-09-27 12:59:47.527522Z] Finished run-tests step (success) 05:59:47 INFO - Running post-run listener: _resource_record_post_run 05:59:47 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 31988736; Write bytes: 707556864; Read time: 198; Write time: 1950 05:59:47 INFO - TinderboxPrint: CPU usage
53.5% 05:59:47 INFO - TinderboxPrint: I/O read bytes / time
31,988,736 / 198 05:59:47 INFO - TinderboxPrint: I/O write bytes / time
707,556,864 / 1,950 05:59:47 INFO - TinderboxPrint: CPU idle
2,255.1 (46.5%) 05:59:47 INFO - TinderboxPrint: CPU system
971.2 (20.0%) 05:59:47 INFO - TinderboxPrint: CPU user
1,627.3 (33.5%) 05:59:47 INFO - TinderboxPrint: Swap in / out
435,314,688 / 0 05:59:47 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 388983296; Write bytes: 381056000; Read time: 29160; Write time: 784 05:59:47 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 31067136; Write bytes: 298095104; Read time: 187; Write time: 1101 05:59:48 INFO - Running post-run listener: _upload_blobber_files 05:59:48 INFO - Blob upload gear active. 05:59:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:59:48 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:59:48 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:59:48 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:59:48 INFO - (blobuploader) - INFO - Open directory for files ... 05:59:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:59:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:59:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:49 INFO - (blobuploader) - INFO - Done attempting. 05:59:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:59:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:59:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:50 INFO - (blobuploader) - INFO - Done attempting. 05:59:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:59:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:59:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:53 INFO - (blobuploader) - INFO - Done attempting. 05:59:53 INFO - (blobuploader) - INFO - Iteration through files over. 05:59:53 INFO - Return code: 0 05:59:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:59:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:59:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6314b5b885f18fbce273c90f3fb3191ee1dec11969565ae26f54b4eaef31268a542d6f8c5aa0b11cf52377fb29f3cfd1638502f9c0bff684489b5df2031b668", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585a5dd1062a9b082cdc277686cf0e3bf075a350af88faf4fab7c0ebb0f85535038a68bd8e1f7600f6da84fa8aaed059ad168e9c4935a1891602365e6515131c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22231a36a22d42ff80fc243c86dbbe057ecce3b66abc8b1d04c2f753ccb758a058e3d8b5999669f736802f16fa9e180af5a56bf9921c30f5f006cf66cf65fbb9"} 05:59:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:59:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:59:53 INFO - Contents: 05:59:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6314b5b885f18fbce273c90f3fb3191ee1dec11969565ae26f54b4eaef31268a542d6f8c5aa0b11cf52377fb29f3cfd1638502f9c0bff684489b5df2031b668", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585a5dd1062a9b082cdc277686cf0e3bf075a350af88faf4fab7c0ebb0f85535038a68bd8e1f7600f6da84fa8aaed059ad168e9c4935a1891602365e6515131c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22231a36a22d42ff80fc243c86dbbe057ecce3b66abc8b1d04c2f753ccb758a058e3d8b5999669f736802f16fa9e180af5a56bf9921c30f5f006cf66cf65fbb9"} 05:59:53 INFO - Running post-run listener: copy_logs_to_upload_dir 05:59:53 INFO - Copying logs to upload dir... 05:59:53 INFO - mkdir: /builds/slave/test/build/upload/logs 05:59:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.588660 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-27 05:59:53.754762) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 05:59:53.758481) ========= 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.9HJSdLGYOq/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.JdSh0GTEnl/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6314b5b885f18fbce273c90f3fb3191ee1dec11969565ae26f54b4eaef31268a542d6f8c5aa0b11cf52377fb29f3cfd1638502f9c0bff684489b5df2031b668", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585a5dd1062a9b082cdc277686cf0e3bf075a350af88faf4fab7c0ebb0f85535038a68bd8e1f7600f6da84fa8aaed059ad168e9c4935a1891602365e6515131c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22231a36a22d42ff80fc243c86dbbe057ecce3b66abc8b1d04c2f753ccb758a058e3d8b5999669f736802f16fa9e180af5a56bf9921c30f5f006cf66cf65fbb9"} build_url:https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011028 build_url: 'https://queue.taskcluster.net/v1/task/RLX0zjxTSDiMdK4TKQ-XcQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6314b5b885f18fbce273c90f3fb3191ee1dec11969565ae26f54b4eaef31268a542d6f8c5aa0b11cf52377fb29f3cfd1638502f9c0bff684489b5df2031b668", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/585a5dd1062a9b082cdc277686cf0e3bf075a350af88faf4fab7c0ebb0f85535038a68bd8e1f7600f6da84fa8aaed059ad168e9c4935a1891602365e6515131c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22231a36a22d42ff80fc243c86dbbe057ecce3b66abc8b1d04c2f753ccb758a058e3d8b5999669f736802f16fa9e180af5a56bf9921c30f5f006cf66cf65fbb9"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 05:59:53.796504) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 05:59:53.796858) ========= 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.9HJSdLGYOq/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.JdSh0GTEnl/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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.005057 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 05:59:53.848776) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 05:59:53.849559) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 05:59:53.850330) ========= ========= Total master_lag: 0.20 =========