builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0259 starttime: 1482040046.97 results: success (0) buildid: 20161217201235 builduid: d61100b0b8f94ab2a50f3e31796cc1d0 revision: 5baae61449c43851c961a83babe18adaa28e3c6b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-17 21:47:26.973127) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-17 21:47:26.973518) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-17 21:47:26.973836) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-17 21:47:27.163889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:47:27.164150) ========= 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.3xSyFIP5MP/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.pP7H9xmCIQ/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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-12-17 21:47:27-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 173M=0s 2016-12-17 21:47:27 (173 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.510545 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:47:27.762403) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:47:27.762688) ========= 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.3xSyFIP5MP/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.pP7H9xmCIQ/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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.026261 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:47:27.831428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-17 21:47:27.831781) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5baae61449c43851c961a83babe18adaa28e3c6b --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 5baae61449c43851c961a83babe18adaa28e3c6b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3xSyFIP5MP/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.pP7H9xmCIQ/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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-12-17 21:47:27,935 truncating revision to first 12 chars 2016-12-17 21:47:27,936 Setting DEBUG logging. 2016-12-17 21:47:27,936 attempt 1/10 2016-12-17 21:47:27,936 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5baae61449c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-17 21:47:29,235 unpacking tar archive at: mozilla-central-5baae61449c4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.590544 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-17 21:47:29.452778) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-17 21:47:29.453139) ========= script_repo_revision: 5baae61449c43851c961a83babe18adaa28e3c6b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-17 21:47:29.453612) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-17 21:47:29.453917) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-17 21:47:29.474238) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-12-17 21:47:29.474916) ========= /tools/buildbot/bin/python -u 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', '-u', '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.3xSyFIP5MP/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.pP7H9xmCIQ/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 21:47:29 INFO - MultiFileLogger online at 20161217 21:47:29 in /builds/slave/test 21:47:29 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 21:47:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:47:29 INFO - {'append_to_log': False, 21:47:29 INFO - 'base_work_dir': '/builds/slave/test', 21:47:29 INFO - 'blob_upload_branch': 'Firefox', 21:47:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:47:29 INFO - 'branch': 'Firefox', 21:47:29 INFO - 'buildbot_json_path': 'buildprops.json', 21:47:29 INFO - 'config_files': ('talos/mac_config.py',), 21:47:29 INFO - 'default_actions': ('clobber', 21:47:29 INFO - 'read-buildbot-config', 21:47:29 INFO - 'download-and-extract', 21:47:29 INFO - 'populate-webroot', 21:47:29 INFO - 'create-virtualenv', 21:47:29 INFO - 'install', 21:47:29 INFO - 'run-tests'), 21:47:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:47:29 INFO - 'download_minidump_stackwalk': True, 21:47:29 INFO - 'download_symbols': 'ondemand', 21:47:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:47:29 INFO - 'tooltool.py': '/tools/tooltool.py', 21:47:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:47:29 INFO - '/tools/misc-python/virtualenv.py')}, 21:47:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:47:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:47:29 INFO - 'installer_path': 'installer.exe', 21:47:29 INFO - 'log_level': 'info', 21:47:29 INFO - 'log_name': 'talos', 21:47:29 INFO - 'log_to_console': True, 21:47:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:47:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:47:29 INFO - 'opt_config_files': (), 21:47:29 INFO - 'pip_index': False, 21:47:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:47:29 INFO - 'cmd': ('bash', 21:47:29 INFO - '-c', 21:47:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:47:29 INFO - 'enabled': True, 21:47:29 INFO - 'halt_on_failure': False, 21:47:29 INFO - 'name': 'check_screen_resolution'},), 21:47:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:47:29 INFO - 'cmd': ('bash', 21:47:29 INFO - '-c', 21:47:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:47:29 INFO - 'enabled': True, 21:47:29 INFO - 'halt_on_failure': False, 21:47:29 INFO - 'name': 'check_screen_resolution'},), 21:47:29 INFO - 'run_cmd_checks_enabled': True, 21:47:29 INFO - 'sps_profile': False, 21:47:29 INFO - 'sps_profile_interval': 0, 21:47:29 INFO - 'suite': 'dromaeojs', 21:47:29 INFO - 'system_bits': '32', 21:47:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:47:29 INFO - 'title': 't-yosemite-r7-0259', 21:47:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:47:29 INFO - 'use_talos_json': True, 21:47:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:47:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:47:29 INFO - 'work_dir': 'build'} 21:47:29 INFO - [mozharness: 2016-12-18 05:47:29.683390Z] Running clobber step. 21:47:29 INFO - Running pre-action listener: _resource_record_pre_action 21:47:29 INFO - Running main action method: clobber 21:47:29 INFO - rmtree: /builds/slave/test/build 21:47:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:47:31 INFO - Running post-action listener: _resource_record_post_action 21:47:31 INFO - [mozharness: 2016-12-18 05:47:31.990651Z] Finished clobber step (success) 21:47:31 INFO - [mozharness: 2016-12-18 05:47:31.990820Z] Running read-buildbot-config step. 21:47:31 INFO - Running pre-action listener: _resource_record_pre_action 21:47:31 INFO - Running main action method: read_buildbot_config 21:47:31 INFO - Using buildbot properties: 21:47:31 INFO - { 21:47:31 INFO - "project": "", 21:47:31 INFO - "product": "firefox", 21:47:31 INFO - "script_repo_revision": "production", 21:47:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:47:31 INFO - "repository": "", 21:47:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:47:31 INFO - "buildid": "20161217201235", 21:47:31 INFO - "pgo_build": "False", 21:47:31 INFO - "basedir": "/builds/slave/test", 21:47:31 INFO - "buildnumber": 87, 21:47:31 INFO - "slavename": "t-yosemite-r7-0259", 21:47:31 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 21:47:31 INFO - "platform": "yosemite_r7", 21:47:31 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:47:31 INFO - "branch": "mozilla-central", 21:47:31 INFO - "repo_path": "mozilla-central", 21:47:31 INFO - "revision": "5baae61449c43851c961a83babe18adaa28e3c6b", 21:47:31 INFO - "stage_platform": "macosx64", 21:47:31 INFO - "builduid": "d61100b0b8f94ab2a50f3e31796cc1d0", 21:47:31 INFO - "slavebuilddir": "test" 21:47:31 INFO - } 21:47:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 21:47:31 INFO - Running post-action listener: _resource_record_post_action 21:47:31 INFO - [mozharness: 2016-12-18 05:47:31.994178Z] Finished read-buildbot-config step (success) 21:47:31 INFO - [mozharness: 2016-12-18 05:47:31.994310Z] Running download-and-extract step. 21:47:31 INFO - Running pre-action listener: _resource_record_pre_action 21:47:31 INFO - Running main action method: download_and_extract 21:47:31 INFO - mkdir: /builds/slave/test/build/tests 21:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:31 INFO - trying https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 21:47:31 INFO - Downloading https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:47:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 21:47:33 INFO - Downloaded 1199 bytes. 21:47:33 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:47:33 INFO - Using the following test package requirements: 21:47:33 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:47:33 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:47:33 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 21:47:33 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:47:33 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 21:47:33 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:47:33 INFO - u'jsshell-mac.zip'], 21:47:33 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:47:33 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 21:47:33 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:47:33 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:47:33 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 21:47:33 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:47:33 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 21:47:33 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:47:33 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 21:47:33 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:47:33 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 21:47:33 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:47:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:47:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:47:33 INFO - Fetch https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:47:34 INFO - Expected file size: 16275318 21:47:34 INFO - Obtained file size: 16275318 21:47:40 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:47:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:47:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:47:40 INFO - Fetch https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:47:42 INFO - Expected file size: 16275318 21:47:42 INFO - Obtained file size: 16275318 21:47:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 21:47:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:47:48 INFO - Fetch https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 21:47:49 INFO - Expected file size: 14409734 21:47:49 INFO - Obtained file size: 14409734 21:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:49 INFO - trying https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:47:49 INFO - Downloading https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 21:47:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 21:47:55 INFO - Downloaded 69562714 bytes. 21:47:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:47:55 INFO - mkdir: /builds/slave/test/properties 21:47:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:47:55 INFO - Writing to file /builds/slave/test/properties/build_url 21:47:55 INFO - Contents: 21:47:55 INFO - build_url:https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:47:56 INFO - Running post-action listener: _resource_record_post_action 21:47:56 INFO - Running post-action listener: set_extra_try_arguments 21:47:56 INFO - [mozharness: 2016-12-18 05:47:56.530491Z] Finished download-and-extract step (success) 21:47:56 INFO - [mozharness: 2016-12-18 05:47:56.530618Z] Running populate-webroot step. 21:47:56 INFO - Running pre-action listener: _resource_record_pre_action 21:47:56 INFO - Running main action method: populate_webroot 21:47:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:47:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:47:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:47:56 INFO - '--tppagecycles', 21:47:56 INFO - '7'], 21:47:56 INFO - 'tests': ['tsvgm']}}, 21:47:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:47:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:47:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:47:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:47:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:47:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:47:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:47:56 INFO - 'talos_options': ['--disable-e10s'], 21:47:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:47:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:47:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:47:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:47:56 INFO - 'talos_options': ['--disable-e10s'], 21:47:56 INFO - 'tests': ['damp', 'tps']}, 21:47:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:47:56 INFO - 'tests': ['damp', 'tps']}, 21:47:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:47:56 INFO - 'tests': ['dromaeo_dom']}, 21:47:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:47:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:47:56 INFO - 'tests': ['basic_compositor_video']}, 21:47:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:47:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:47:56 INFO - 'tests': ['a11yr', 21:47:56 INFO - 'ts_paint', 21:47:56 INFO - 'tpaint', 21:47:56 INFO - 'sessionrestore', 21:47:56 INFO - 'sessionrestore_no_auto_restore', 21:47:56 INFO - 'tabpaint']}, 21:47:56 INFO - 'other-e10s': {'tests': ['a11yr', 21:47:56 INFO - 'ts_paint', 21:47:56 INFO - 'tpaint', 21:47:56 INFO - 'sessionrestore', 21:47:56 INFO - 'sessionrestore_no_auto_restore', 21:47:56 INFO - 'tabpaint']}, 21:47:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:47:56 INFO - 'ts_paint', 21:47:56 INFO - 'tpaint', 21:47:56 INFO - 'sessionrestore', 21:47:56 INFO - 'sessionrestore_no_auto_restore', 21:47:56 INFO - 'tabpaint']}, 21:47:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:47:56 INFO - 'ts_paint', 21:47:56 INFO - 'tpaint', 21:47:56 INFO - 'sessionrestore', 21:47:56 INFO - 'sessionrestore_no_auto_restore', 21:47:56 INFO - 'tabpaint']}, 21:47:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:47:56 INFO - 'tests': ['a11yr', 21:47:56 INFO - 'ts_paint', 21:47:56 INFO - 'tpaint', 21:47:56 INFO - 'sessionrestore', 21:47:56 INFO - 'sessionrestore_no_auto_restore', 21:47:56 INFO - 'tabpaint']}, 21:47:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:47:56 INFO - 'tests': ['a11yr', 21:47:56 INFO - 'ts_paint', 21:47:56 INFO - 'tpaint', 21:47:56 INFO - 'sessionrestore', 21:47:56 INFO - 'sessionrestore_no_auto_restore', 21:47:56 INFO - 'tabpaint']}, 21:47:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:47:56 INFO - 'tests': ['tsvgx', 21:47:56 INFO - 'tsvgr_opacity', 21:47:56 INFO - 'tart', 21:47:56 INFO - 'tscrollx', 21:47:56 INFO - 'cart', 21:47:56 INFO - 'tsvg_static']}, 21:47:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:47:56 INFO - 'tsvgr_opacity', 21:47:56 INFO - 'tart', 21:47:56 INFO - 'tscrollx', 21:47:56 INFO - 'cart', 21:47:56 INFO - 'tsvg_static']}, 21:47:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:47:56 INFO - 'talos_options': ['--disable-e10s'], 21:47:56 INFO - 'tests': ['tp5o']}, 21:47:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:47:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:47:56 INFO - 'talos_options': ['--disable-e10s', 21:47:56 INFO - '--xperf_path', 21:47:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:47:56 INFO - 'tests': ['tp5n']}, 21:47:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:47:56 INFO - 'talos_options': ['--xperf_path', 21:47:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:47:56 INFO - 'tests': ['tp5n']}}, 21:47:56 INFO - 'talos.zip': {'path': '', 21:47:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:47:56 INFO - Running post-action listener: _resource_record_post_action 21:47:56 INFO - [mozharness: 2016-12-18 05:47:56.548990Z] Finished populate-webroot step (success) 21:47:56 INFO - [mozharness: 2016-12-18 05:47:56.549119Z] Running create-virtualenv step. 21:47:56 INFO - Running pre-action listener: _resource_record_pre_action 21:47:56 INFO - Running main action method: create_virtualenv 21:47:56 INFO - Creating virtualenv /builds/slave/test/build/venv 21:47:56 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 21:47:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:47:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:47:56 INFO - Using real prefix '/tools/python27' 21:47:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:47:57 INFO - Installing distribute.............................................................................................................................................................................................done. 21:48:00 INFO - Installing pip.................done. 21:48:00 INFO - Return code: 0 21:48:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:48:00 INFO - Reading from file tmpfile_stdout 21:48:00 INFO - Output received: 21:48:00 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) 21:48:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1034d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda0bc7f250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3d30>, '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 0x1031dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032a8be8>, '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.3xSyFIP5MP/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.pP7H9xmCIQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 21:48:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:48:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3xSyFIP5MP/Render', 21:48:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:00 INFO - 'HOME': '/Users/cltbld', 21:48:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:00 INFO - 'LOGNAME': 'cltbld', 21:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:00 INFO - 'MOZ_NO_REMOTE': '1', 21:48:00 INFO - 'NO_EM_RESTART': '1', 21:48:00 INFO - 'PAGER': '/bin/cat', 21:48:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:00 INFO - 'PWD': '/builds/slave/test', 21:48:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:00 INFO - 'SHELL': '/bin/bash', 21:48:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pP7H9xmCIQ/Listeners', 21:48:00 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 21:48:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:00 INFO - 'USER': 'cltbld', 21:48:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:00 INFO - 'XPC_FLAGS': '0x0', 21:48:00 INFO - 'XPC_SERVICE_NAME': '0', 21:48:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:00 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 21:48:00 INFO - Cleaning up... 21:48:00 INFO - Return code: 0 21:48:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1034d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda0bc7f250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3d30>, '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 0x1031dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032a8be8>, '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.3xSyFIP5MP/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.pP7H9xmCIQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 21:48:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:48:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3xSyFIP5MP/Render', 21:48:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:00 INFO - 'HOME': '/Users/cltbld', 21:48:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:00 INFO - 'LOGNAME': 'cltbld', 21:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:00 INFO - 'MOZ_NO_REMOTE': '1', 21:48:00 INFO - 'NO_EM_RESTART': '1', 21:48:00 INFO - 'PAGER': '/bin/cat', 21:48:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:00 INFO - 'PWD': '/builds/slave/test', 21:48:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:00 INFO - 'SHELL': '/bin/bash', 21:48:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pP7H9xmCIQ/Listeners', 21:48:00 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 21:48:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:00 INFO - 'USER': 'cltbld', 21:48:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:00 INFO - 'XPC_FLAGS': '0x0', 21:48:00 INFO - 'XPC_SERVICE_NAME': '0', 21:48:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:01 INFO - Downloading/unpacking psutil>=3.1.1 21:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:48:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:48:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:48:04 INFO - Installing collected packages: psutil 21:48:04 INFO - Running setup.py install for psutil 21:48:04 INFO - building 'psutil._psutil_osx' extension 21:48:04 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 21:48:05 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 21:48:05 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 21:48:05 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 21:48:05 INFO - building 'psutil._psutil_posix' extension 21:48:05 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 21:48:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:48:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:48:05 INFO - ^ 21:48:05 INFO - 1 warning generated. 21:48:05 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 21:48:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:48:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:48:06 INFO - Successfully installed psutil 21:48:06 INFO - Cleaning up... 21:48:06 INFO - Return code: 0 21:48:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:48: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')]} 21:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48: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')]} 21:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1034d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda0bc7f250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3d30>, '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 0x1031dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032a8be8>, '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.3xSyFIP5MP/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.pP7H9xmCIQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 21:48: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:48: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 mozsystemmonitor==0.3 21:48:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3xSyFIP5MP/Render', 21:48:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:06 INFO - 'HOME': '/Users/cltbld', 21:48:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:06 INFO - 'LOGNAME': 'cltbld', 21:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:06 INFO - 'MOZ_NO_REMOTE': '1', 21:48:06 INFO - 'NO_EM_RESTART': '1', 21:48:06 INFO - 'PAGER': '/bin/cat', 21:48:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:06 INFO - 'PWD': '/builds/slave/test', 21:48:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:06 INFO - 'SHELL': '/bin/bash', 21:48:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pP7H9xmCIQ/Listeners', 21:48:06 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 21:48:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:06 INFO - 'USER': 'cltbld', 21:48:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:06 INFO - 'XPC_FLAGS': '0x0', 21:48:06 INFO - 'XPC_SERVICE_NAME': '0', 21:48:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:48: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 21:48: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 21:48: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 21:48: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 21:48: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 21:48: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 21:48:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:48:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:48:08 INFO - Installing collected packages: mozsystemmonitor 21:48:08 INFO - Running setup.py install for mozsystemmonitor 21:48:09 INFO - Successfully installed mozsystemmonitor 21:48:09 INFO - Cleaning up... 21:48:09 INFO - Return code: 0 21:48:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:09 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 0x1034d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda0bc7f250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3d30>, '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 0x1031dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032a8be8>, '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.3xSyFIP5MP/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.pP7H9xmCIQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 21:48:09 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 21:48:09 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 21:48:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3xSyFIP5MP/Render', 21:48:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:09 INFO - 'HOME': '/Users/cltbld', 21:48:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:09 INFO - 'LOGNAME': 'cltbld', 21:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:09 INFO - 'MOZ_NO_REMOTE': '1', 21:48:09 INFO - 'NO_EM_RESTART': '1', 21:48:09 INFO - 'PAGER': '/bin/cat', 21:48:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:09 INFO - 'PWD': '/builds/slave/test', 21:48:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:09 INFO - 'SHELL': '/bin/bash', 21:48:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pP7H9xmCIQ/Listeners', 21:48:09 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 21:48:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:09 INFO - 'USER': 'cltbld', 21:48:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:09 INFO - 'XPC_FLAGS': '0x0', 21:48:09 INFO - 'XPC_SERVICE_NAME': '0', 21:48:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:09 INFO - Downloading/unpacking jsonschema==2.5.1 21:48:09 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 21:48:09 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 21:48:09 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 21:48:09 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 21:48:09 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 21:48:09 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 21:48:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:48:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:48:12 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 21:48:12 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 21:48:12 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 21:48:12 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 21:48:12 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 21:48:12 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 21:48:12 INFO - Downloading functools32-3.2.3-2.tar.gz 21:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:48:12 INFO - warning: no files found matching '*.txt' 21:48:12 INFO - no previously-included directories found matching 'build' 21:48:12 INFO - no previously-included directories found matching 'dist' 21:48:12 INFO - no previously-included directories found matching '.git*' 21:48:12 INFO - Installing collected packages: jsonschema, functools32 21:48:12 INFO - Running setup.py install for functools32 21:48:12 INFO - warning: no files found matching '*.txt' 21:48:12 INFO - no previously-included directories found matching 'build' 21:48:12 INFO - no previously-included directories found matching 'dist' 21:48:12 INFO - no previously-included directories found matching '.git*' 21:48:12 INFO - Successfully installed jsonschema functools32 21:48:12 INFO - Cleaning up... 21:48:12 INFO - Return code: 0 21:48:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:12 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 0x1034d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda0bc7f250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3d30>, '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 0x1031dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032a8be8>, '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.3xSyFIP5MP/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.pP7H9xmCIQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 21:48:12 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 21:48:12 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 21:48:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3xSyFIP5MP/Render', 21:48:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:12 INFO - 'HOME': '/Users/cltbld', 21:48:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:12 INFO - 'LOGNAME': 'cltbld', 21:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:12 INFO - 'MOZ_NO_REMOTE': '1', 21:48:12 INFO - 'NO_EM_RESTART': '1', 21:48:12 INFO - 'PAGER': '/bin/cat', 21:48:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:12 INFO - 'PWD': '/builds/slave/test', 21:48:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:12 INFO - 'SHELL': '/bin/bash', 21:48:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pP7H9xmCIQ/Listeners', 21:48:12 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 21:48:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:12 INFO - 'USER': 'cltbld', 21:48:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:12 INFO - 'XPC_FLAGS': '0x0', 21:48:12 INFO - 'XPC_SERVICE_NAME': '0', 21:48:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:48:13 INFO - Cleaning up... 21:48:13 INFO - Return code: 0 21:48:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:13 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 0x1034d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda0bc7f250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3d30>, '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 0x1031dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032a8be8>, '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.3xSyFIP5MP/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.pP7H9xmCIQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 21:48:13 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 21:48:13 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 21:48:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3xSyFIP5MP/Render', 21:48:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:13 INFO - 'HOME': '/Users/cltbld', 21:48:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:13 INFO - 'LOGNAME': 'cltbld', 21:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:13 INFO - 'MOZ_NO_REMOTE': '1', 21:48:13 INFO - 'NO_EM_RESTART': '1', 21:48:13 INFO - 'PAGER': '/bin/cat', 21:48:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:13 INFO - 'PWD': '/builds/slave/test', 21:48:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:13 INFO - 'SHELL': '/bin/bash', 21:48:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pP7H9xmCIQ/Listeners', 21:48:13 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 21:48:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:13 INFO - 'USER': 'cltbld', 21:48:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:13 INFO - 'XPC_FLAGS': '0x0', 21:48:13 INFO - 'XPC_SERVICE_NAME': '0', 21:48:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:13 INFO - Downloading/unpacking blobuploader==1.2.4 21:48:13 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 21:48:13 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 21:48:13 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 21:48:13 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 21:48:13 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 21:48:13 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 21:48:15 INFO - Downloading blobuploader-1.2.4.tar.gz 21:48:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:48:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:48:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:17 INFO - Downloading docopt-0.6.1.tar.gz 21:48:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:48:17 INFO - Installing collected packages: blobuploader, requests, docopt 21:48:17 INFO - Running setup.py install for blobuploader 21:48:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:48:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:48:17 INFO - Running setup.py install for requests 21:48:17 INFO - Running setup.py install for docopt 21:48:18 INFO - Successfully installed blobuploader requests docopt 21:48:18 INFO - Cleaning up... 21:48:18 INFO - Return code: 0 21:48:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:48: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')]} 21:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48: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')]} 21:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:18 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 0x1034d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda0bc7f250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3d30>, '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 0x1031dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032a8be8>, '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.3xSyFIP5MP/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.pP7H9xmCIQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 21:48:18 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 21:48:18 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 21:48:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3xSyFIP5MP/Render', 21:48:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:18 INFO - 'HOME': '/Users/cltbld', 21:48:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:18 INFO - 'LOGNAME': 'cltbld', 21:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:18 INFO - 'MOZ_NO_REMOTE': '1', 21:48:18 INFO - 'NO_EM_RESTART': '1', 21:48:18 INFO - 'PAGER': '/bin/cat', 21:48:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:18 INFO - 'PWD': '/builds/slave/test', 21:48:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:18 INFO - 'SHELL': '/bin/bash', 21:48:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pP7H9xmCIQ/Listeners', 21:48:18 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 21:48:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:18 INFO - 'USER': 'cltbld', 21:48:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:18 INFO - 'XPC_FLAGS': '0x0', 21:48:18 INFO - 'XPC_SERVICE_NAME': '0', 21:48:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:48:18 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-xYvnfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:48:18 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-T0rj80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:48:18 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-5dskDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:48:18 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-0zeeJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:48:18 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-43oXtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:48:18 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-x8NZy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:48:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-PHx3vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:48:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-y39Pa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:48:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-i6F1u5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:48:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-q1DWeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:48:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-XtMEyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:48:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-d0y9nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:48:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-7Ny65R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:48:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-ZeoIkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:48:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-sBcRzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:48:19 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-l6pejp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:48:20 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-4eMKZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:48:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:48:20 INFO - Running setup.py install for manifestparser 21:48:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:48:20 INFO - Running setup.py install for mozcrash 21:48:20 INFO - Running setup.py install for mozdebug 21:48:20 INFO - Running setup.py install for mozdevice 21:48:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:48:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:48:20 INFO - Running setup.py install for mozfile 21:48:20 INFO - Running setup.py install for mozhttpd 21:48:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:48:21 INFO - Running setup.py install for mozinfo 21:48:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:48:21 INFO - Running setup.py install for mozInstall 21:48:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:48:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:48:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:48:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:48:21 INFO - Running setup.py install for mozleak 21:48:21 INFO - Running setup.py install for mozlog 21:48:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:48:21 INFO - Running setup.py install for moznetwork 21:48:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:48:21 INFO - Running setup.py install for mozprocess 21:48:21 INFO - Running setup.py install for mozprofile 21:48:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:48:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:48:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:48:22 INFO - Running setup.py install for mozrunner 21:48:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:48:22 INFO - Running setup.py install for mozscreenshot 21:48:22 INFO - Running setup.py install for moztest 21:48:22 INFO - Running setup.py install for mozversion 21:48:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:48:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:48:22 INFO - Cleaning up... 21:48:22 INFO - Return code: 0 21:48:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:22 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 0x1034d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda0bc7f250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3d30>, '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 0x1031dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032a8be8>, '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.3xSyFIP5MP/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.pP7H9xmCIQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 21:48:22 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 21:48:22 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 21:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3xSyFIP5MP/Render', 21:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:22 INFO - 'HOME': '/Users/cltbld', 21:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:22 INFO - 'LOGNAME': 'cltbld', 21:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:22 INFO - 'MOZ_NO_REMOTE': '1', 21:48:22 INFO - 'NO_EM_RESTART': '1', 21:48:22 INFO - 'PAGER': '/bin/cat', 21:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:22 INFO - 'PWD': '/builds/slave/test', 21:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:22 INFO - 'SHELL': '/bin/bash', 21:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pP7H9xmCIQ/Listeners', 21:48:22 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 21:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:22 INFO - 'USER': 'cltbld', 21:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:22 INFO - 'XPC_FLAGS': '0x0', 21:48:22 INFO - 'XPC_SERVICE_NAME': '0', 21:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:48:23 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-dCOuGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:48:23 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)) 21:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:48:23 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-0r_59L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 21:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:48:23 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-SKMK_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:48:23 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)) 21:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:48:23 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-C2olxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 21:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:48:23 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-8E4WLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:48:23 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)) 21:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:48:23 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-rlsl8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:48:23 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)) 21:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:48:23 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-_y_HRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:48:23 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)) 21:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:48:23 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-b8vpt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:48:23 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)) 21:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:48:23 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-vHp9ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:48:23 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)) 21:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:48:23 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-Nhveq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:48:24 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)) 21:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:48:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-ctFLo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:48:24 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)) 21:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:48:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-h_OqIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:48:24 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)) 21:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:48:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-v0XOk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:48:24 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)) 21:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:48:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-4njMHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 21:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:48:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-kgjpZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:48:24 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)) 21:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:48:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-InNlu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:48:24 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)) 21:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:48:24 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-dVaXW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:48:24 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)) 21:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:48:24 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)) 21:48:24 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:48:24 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:48:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:27 INFO - Downloading blessings-1.6.tar.gz 21:48:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:48:27 INFO - Installing collected packages: blessings 21:48:27 INFO - Running setup.py install for blessings 21:48:27 INFO - Successfully installed blessings 21:48:27 INFO - Cleaning up... 21:48:27 INFO - Return code: 0 21:48:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:48:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:48:27 INFO - Reading from file tmpfile_stdout 21:48:27 INFO - Current package versions: 21:48:27 INFO - blessings == 1.6 21:48:27 INFO - blobuploader == 1.2.4 21:48:27 INFO - docopt == 0.6.1 21:48:27 INFO - functools32 == 3.2.3-2 21:48:27 INFO - jsonschema == 2.5.1 21:48:27 INFO - manifestparser == 1.1 21:48:27 INFO - mozInstall == 1.12 21:48:27 INFO - mozcrash == 1.0 21:48:27 INFO - mozdebug == 0.1 21:48:27 INFO - mozdevice == 0.49 21:48:27 INFO - mozfile == 1.2 21:48:27 INFO - mozhttpd == 0.7 21:48:27 INFO - mozinfo == 0.9 21:48:27 INFO - mozleak == 0.1 21:48:27 INFO - mozlog == 3.4 21:48:27 INFO - moznetwork == 0.27 21:48:27 INFO - mozprocess == 0.23 21:48:27 INFO - mozprofile == 0.28 21:48:27 INFO - mozrunner == 6.13 21:48:27 INFO - mozscreenshot == 0.1 21:48:27 INFO - mozsystemmonitor == 0.3 21:48:27 INFO - moztest == 0.7 21:48:27 INFO - mozversion == 1.4 21:48:27 INFO - psutil == 3.1.1 21:48:27 INFO - requests == 1.2.3 21:48:27 INFO - wsgiref == 0.1.2 21:48:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:48: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')]} 21:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48: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')]} 21:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:28 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 0x1034d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda0bc7f250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3d30>, '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 0x1031dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032a8be8>, '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.3xSyFIP5MP/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.pP7H9xmCIQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 21:48:28 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 21:48:28 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 21:48:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3xSyFIP5MP/Render', 21:48:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:28 INFO - 'HOME': '/Users/cltbld', 21:48:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:28 INFO - 'LOGNAME': 'cltbld', 21:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:28 INFO - 'MOZ_NO_REMOTE': '1', 21:48:28 INFO - 'NO_EM_RESTART': '1', 21:48:28 INFO - 'PAGER': '/bin/cat', 21:48:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:28 INFO - 'PWD': '/builds/slave/test', 21:48:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:28 INFO - 'SHELL': '/bin/bash', 21:48:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pP7H9xmCIQ/Listeners', 21:48:28 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 21:48:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:28 INFO - 'USER': 'cltbld', 21:48:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:28 INFO - 'XPC_FLAGS': '0x0', 21:48:28 INFO - 'XPC_SERVICE_NAME': '0', 21:48:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:28 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)) 21:48:28 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)) 21:48:28 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)) 21:48:28 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)) 21:48:28 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)) 21:48:28 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)) 21:48:28 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)) 21:48:28 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)) 21:48:28 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)) 21:48:28 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)) 21:48:28 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)) 21:48:28 INFO - Cleaning up... 21:48:28 INFO - Return code: 0 21:48:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:28 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 0x1034d5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034d8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda0bc7f250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032b3d30>, '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 0x1031dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032a8be8>, '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.3xSyFIP5MP/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.pP7H9xmCIQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 21:48:28 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 21:48:28 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 21:48:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3xSyFIP5MP/Render', 21:48:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:28 INFO - 'HOME': '/Users/cltbld', 21:48:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:28 INFO - 'LOGNAME': 'cltbld', 21:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:28 INFO - 'MOZ_NO_REMOTE': '1', 21:48:28 INFO - 'NO_EM_RESTART': '1', 21:48:28 INFO - 'PAGER': '/bin/cat', 21:48:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:28 INFO - 'PWD': '/builds/slave/test', 21:48:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:28 INFO - 'SHELL': '/bin/bash', 21:48:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pP7H9xmCIQ/Listeners', 21:48:28 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 21:48:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:28 INFO - 'USER': 'cltbld', 21:48:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:28 INFO - 'XPC_FLAGS': '0x0', 21:48:28 INFO - 'XPC_SERVICE_NAME': '0', 21:48:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:48:28 INFO - Cleaning up... 21:48:28 INFO - Return code: 0 21:48:28 INFO - Running post-action listener: _resource_record_post_action 21:48:28 INFO - Running post-action listener: _start_resource_monitoring 21:48:28 INFO - Starting resource monitoring. 21:48:28 INFO - [mozharness: 2016-12-18 05:48:28.564229Z] Finished create-virtualenv step (success) 21:48:28 INFO - [mozharness: 2016-12-18 05:48:28.565213Z] Running install step. 21:48:28 INFO - Running pre-action listener: _resource_record_pre_action 21:48:28 INFO - Running main action method: install 21:48:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:48:28 INFO - Reading from file tmpfile_stdout 21:48:28 INFO - Detecting whether we're running mozinstall >=1.0... 21:48:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:48:28 INFO - Reading from file tmpfile_stdout 21:48:28 INFO - Output received: 21:48:28 INFO - Usage: mozinstall [options] installer 21:48:28 INFO - Options: 21:48:28 INFO - -h, --help show this help message and exit 21:48:28 INFO - -d DEST, --destination=DEST 21:48:28 INFO - Directory to install application into. [default: 21:48:28 INFO - "/builds/slave/test"] 21:48:28 INFO - --app=APP Application being installed. [default: firefox] 21:48:28 INFO - mkdir: /builds/slave/test/build/application 21:48:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:48:50 INFO - Reading from file tmpfile_stdout 21:48:50 INFO - Output received: 21:48:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:48:50 INFO - Running post-action listener: _resource_record_post_action 21:48:50 INFO - [mozharness: 2016-12-18 05:48:50.833374Z] Finished install step (success) 21:48:50 INFO - [mozharness: 2016-12-18 05:48:50.833519Z] Running run-tests step. 21:48:50 INFO - Running pre-action listener: _resource_record_pre_action 21:48:50 INFO - Running main action method: run_tests 21:48:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:48:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:48:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:48:50 INFO - 2016-12-17 21:48:50.848 screenresolution[1642:8921] starting screenresolution argv=screenresolution get 21:48:50 INFO - 2016-12-17 21:48:50.850 screenresolution[1642:8921] Display 0: 1600x1200x32@60 21:48:50 INFO - 2016-12-17 21:48:50.856 screenresolution[1643:8924] starting screenresolution argv=screenresolution list 21:48:50 INFO - Available Modes on Display 0 21:48:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:48:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:48:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:48:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:48:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:48:51 INFO - Intel Iris: 21:48:51 INFO - Chipset Model: Intel Iris 21:48:51 INFO - Type: GPU 21:48:51 INFO - Bus: Built-In 21:48:51 INFO - VRAM (Dynamic, Max): 1536 MB 21:48:51 INFO - Vendor: Intel (0x8086) 21:48:51 INFO - Device ID: 0x0a2e 21:48:51 INFO - Revision ID: 0x0009 21:48:51 INFO - Displays: 21:48:51 INFO - Display: 21:48:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:48:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:48:51 INFO - Display Serial Number: 1600x1200 60 21:48:51 INFO - Main Display: Yes 21:48:51 INFO - Mirror: Off 21:48:51 INFO - Online: Yes 21:48:51 INFO - Rotation: Supported 21:48:51 INFO - Return code: 0 21:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:48:51 INFO - Python 2.7.3 21:48:51 INFO - Return code: 0 21:48:51 INFO - grabbing minidump binary from tooltool 21:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:51 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 0x1032b3d30>, '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 0x1031dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032a8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:48:51 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 21:48:51 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 21:48:51 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 21:48:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:48:51 INFO - Return code: 0 21:48:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:48:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:48:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:48:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:48:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:48:51 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0259', '--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 21:48:51 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0259 --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 21:48:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3xSyFIP5MP/Render', 21:48:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:51 INFO - 'HOME': '/Users/cltbld', 21:48:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:51 INFO - 'LOGNAME': 'cltbld', 21:48:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:48:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:51 INFO - 'MOZ_NO_REMOTE': '1', 21:48:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:48:51 INFO - 'NO_EM_RESTART': '1', 21:48:51 INFO - 'PAGER': '/bin/cat', 21:48:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:51 INFO - 'PWD': '/builds/slave/test', 21:48:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:48:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:51 INFO - 'SHELL': '/bin/bash', 21:48:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pP7H9xmCIQ/Listeners', 21:48:51 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 21:48:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:51 INFO - 'USER': 'cltbld', 21:48:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:51 INFO - 'XPC_FLAGS': '0x0', 21:48:51 INFO - 'XPC_SERVICE_NAME': '0', 21:48:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:51 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0259', '--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 21:48:51 INFO - mozversion application_buildid: 20161217201235 21:48:51 INFO - mozversion application_changeset: 5baae61449c43851c961a83babe18adaa28e3c6b 21:48:51 INFO - mozversion application_display_name: Nightly 21:48:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:48:51 INFO - mozversion application_name: Firefox 21:48:51 INFO - mozversion application_remotingname: firefox 21:48:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:48:51 INFO - mozversion application_vendor: Mozilla 21:48:51 INFO - mozversion application_version: 53.0a1 21:48:51 INFO - mozversion platform_buildid: 20161217201235 21:48:51 INFO - mozversion platform_changeset: 5baae61449c43851c961a83babe18adaa28e3c6b 21:48:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:48:51 INFO - mozversion platform_version: 53.0a1 21:48:51 INFO - using testdate: 1482040131 21:48:51 INFO - actual date: 1482040131 21:48:51 INFO - starting webserver on 'localhost:49243' 21:48:51 INFO - SUITE-START | Running 2 tests 21:48:51 INFO - TEST-START | dromaeo_css 21:48:51 INFO - operating with platform_type : mac_ 21:48:51 INFO - Initialising browser for dromaeo_css test... 21:48:51 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpuSpBMC/profile http://localhost:49243/getInfo.html) 21:48:53 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 21:48:53 INFO - PROCESS | 1653 | colorDepth:24 21:48:53 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 21:48:53 INFO - PROCESS | 1653 | __metrics 21:48:53 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:48:53 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:48:54 INFO - TEST-INFO | 1653: exit 0 21:48:54 INFO - Browser initialized. 21:48:54 INFO - Running cycle 1/1 for dromaeo_css test... 21:48:54 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpuSpBMC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:49:06 INFO - PROCESS | 1656 | RSS: Main: 237043712 21:49:06 INFO - PROCESS | 1656 | 21:49:58 INFO - PROCESS | 1656 | 1482040198292 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] 21:52:10 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 21:52:13 INFO - PROCESS | 1656 | RSS: Main: 459669504 21:52:13 INFO - PROCESS | 1656 | 21:55:16 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 21:55:17 INFO - PROCESS | 1656 | RSS: Main: 379928576 21:55:17 INFO - PROCESS | 1656 | 21:58:19 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 21:58:20 INFO - PROCESS | 1656 | RSS: Main: 353656832 21:58:20 INFO - PROCESS | 1656 | 22:01:23 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 22:01:23 INFO - PROCESS | 1656 | RSS: Main: 342183936 22:01:23 INFO - PROCESS | 1656 | 22:04:27 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 22:04:28 INFO - PROCESS | 1656 | RSS: Main: 333717504 22:04:28 INFO - PROCESS | 1656 | 22:07:31 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 22:07:31 INFO - PROCESS | 1656 | RSS: Main: 546127872 22:07:31 INFO - PROCESS | 1656 | 22:07:31 INFO - PROCESS | 1656 | __start_tp_report 22:07:31 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 22:07:31 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 22:07:31 INFO - PROCESS | 1656 | |i|pagename|runs| 22:07:31 INFO - PROCESS | 1656 | |0;dojo.html;2979.7914146009775;3268.035929400828;3279.573385577274;3292.489664102065;3322.76740628156;5311.57507399408;5387.299651045363;5393.217983392406;5442.020436321461;5461.262729531512;5412.242286079952;5419.078756611376;5422.53908417785;5433.266509021281;5446.7276636168235;4956.776945037482;4990.87522811929;4991.450940396553;5027.673201241908;5080.466551012146;5047.369078865142;5124.9487505125035;5134.332536770234;5135.409427915782;5148.691078535281;4996.400431948153;5038.722870242135;5075.061113693979;5078.339815823956;5123.282740416326;5096.235564665311;5117.360329958755;5121.206213036985;5121.897562048738;5165.612579056586;4039.4950631171105;4922.729249891255;4927.989762098761;5035.899282014376;5045.192769156954;4601.976990115028;5350.652207606493;5403.8108666196495;5421.728913554307;5423.945760542383;5885.146653735227;5910.527157827363;5922;5922.763089476416;5936.1392598073035;5802.390748971339;5880.088586269135;5980;6028.939710602882;6052.667103309316;5527.309086364205;5541.861453463695;5553.111502159635;5576.442355764391;5624.128260119688;6088.2694076710195;6126.23422072241;6154.815355539341;6172.598781079216;6172.938270617236;5649.378568357477;5811.389804070596;5823.854403639943;5833.912491312633;5836.328822185503;5837.124431335249;5901.557383196277;5907.261592300963;5909.379515150933;5914.112883067488;5621.409751976065;5775.393583673737;5819.6508209507565;5825.854353641108;5839.591228613956;5393.271908292409;5845.269341332333;5851;5856.472917437451;5873.559483038789;4647.697899636512;4670.089332580114;4694.906101877943;4704.411948506437;4711.599514041276;4197;4250.766207858535;4277.165952639268;4277.208716387416;4288.742675439421;5543.417941116206;5562.415946325658;5570.387257401682;5575.968445837533;5577.2191893135;5919.141724449931;5928.584999050111;5966.194563733927;5998.220231369981;6012.669303188279;5593.608447408642;5608;5610.4670056344585;5618.634788738719;5619.381867994517;4945.184044632667;4948.8762780930765;4978.452370239271;5013.49865013503;5164.14791559396;6221.595596286227;6264.310925798159;6294.464970477469;6335.683215839282;6350.206224221973;5941.435563621449;5952.732127054206;5963;5978.4021597839865;6045.063015232646;6088.607784207314;6290.0879372491645;6331.746730130927;6340.365963403623;6357.554971151975;5760.0783874579865;5810.4189581041555;5820.70896455184;5828.854278643068;5845.736941837713;4920.581750551243;5838.1826544282985;5874.911876321944;5887.116932460165;5912.940870591411;4883.731394773179;5742.023855944583;5793.478586927028;5812.157237200667;5813.215215945962;5779.075347944308;5781.537477001913;5782.768689252551;5785.218995435563;5807.796727114531;5541.612087153861;5601.991641504405;5672.205891175321;5676.545876329967;5688.800891968761;5709.9714501427225;5732.398098199796;5737.282839645044;5747.7413516391025;5761.769529218952;4904.828331008398;5607.971960140337;5679.488846003879;5682.602217844877;5691.089425692035 22:07:31 INFO - PROCESS | 1656 | |1;ext.html;409.9487564054495;462.1773243626345;480.7115730561661;500.4845009640072;501.32321366155696;37757.43363849541;39872.80063599685;39995;40296.79851600738;40354.79822600883;40973.59026409735;41386.17227655445;41543.37684934721;41559.37660935081;41595.96010099749;8318.66725330989;9202.63189472422;9428.434293942351;9435.292353073513;9453.527323633825;8473.15268473154;11101.83347249792;11336.979671829533;11373.488193031291;11510.654680359561;11298;11366.545338186463;11374.658760237206;11391.829122563167;11475.540978360856;8438.662453501853;8657.826843463095;11261.380624065672;11341.886581134208;11355.091592672648;10957.452127393679;11213.990740833282;11234.10127189823;11423.714407139805;11438.142139339583;38961.22077558461;39256.41115383271;39371.40942885859;39382.606173938184;39458;3290.7038366546885;3435.879744208966;3549.804760738158;3552.3250582389264;3784.148566572499;27396;27847.86076069607;27881.58177627337;28365.716342836513;28687.282817929718;2810.170999555136;3164.6259852277753;3169.8098114112995;3181.9204519886957;3189.059227527885;462466;462926;462996;463387.6830615859;465596;53190.73404632952;53615.463845361046;53749.462505375224;53870.7306463473;53964.46035539673;56674.149887751715;56723.71638141783;56741.865162696515;56887.71556142193;56955.57611059757;14713.852861471249;15189.544313670607;15217.467388641344;15227.390904363923;15284.235788210544;10706.357618542912;10935.28920620157;10945.781084378268;11922.642320730392;11973.52105915771;16571.585710357336;16810.075445850594;17128.74306885398;17161.570960726083;17194.054327012134;6753.425958793558;7017.4035207006955;7496;7568.810779730551;7595.848083038309;864.4726716702806;906.1618003346878;929.6281487405092;973.2992245583168;1138.6071805227184;28477;29976.55035174474;30056.849715751283;30617.693823061483;30736.077917662507;965.7875267441152;1004.55799448244;1013.0730381700808;1022.1669339488293;1029.696239609302;13801.930990345185;14294.499692510712;14522.419103235752;14655;14657.48698795537;622696;629096;629733;632000;634411;46453.535464645596;49038.01923961501;51133.74433127885;51588.48411515912;51614;1161.8315344275202;1218.8171774233758;1267.8922291605318;1354.1671871798774;1367.787992861108;26936.32659183536;28113;28266.717332826407;28955.710442896143;29007.85496072506;44690.776546117064;45309.54690453185;45355.09289814251;45379.09241815211;45420;484400;566829;567179;568604.0814694064;569372;24606.384840379134;24774.50450991006;25941.87029064918;25959.351016224744;26001.219963401127;41159;41654.16691666211;42178.7891060555;42359.576404235566;42673.57326426696;34792;34914.47628285629;35105;35869;36202.63797361992;32127.518087228244;33557.16107097342;34330.82834585811;34987.30025399529;35609.82195089008;33477.16307092245;33498.162545936546;33597.83201083979;33868.57818415811;35018.474722878665;28724.138275851757;29976.850115749283;30451.39097217999;31122;31144.844275778476;19097.809021909605;23432.297031089096;23445.88277058604;23689.763102368757;23770.286891393287 22:07:31 INFO - PROCESS | 1656 | |2;jquery.html;323.45982209709786;350.1613635343351;374.6628034768708;378.6421831369356;404.9673333000847;14396.280185990698;14622.707545849076;15439.228038598067;19586.608267834636;20367.694484582742;18777.90611046943;19967.400977970647;20181.59636807263;20320.898395508;20384.388468345936;5478.945210547883;5772.191893134965;5772.740226689788;5780.624259423145;5786.855328616797;5033.697978121324;5591.4688104629995;5730.226419433365;5765.481106700396;5790.507806836424;5723.5421166306805;5724.685142317192;5728.885422291552;5737.3688894221605;5737.938481380937;4661.76691165442;5625.240592519998;5657.321121465409;5683.658980461186;5686.346070201897;4809.591184749301;4950.727709975949;5002.1496345621335;5002.649814512985;5027.798888044474;25145.371365715822;25398.619020714705;25545.978160873543;25745.356366090997;25790.226293211235;2317.9652305215436;2747.931301717453;3029.242689327668;3045.5888455058507;3131.6711745266875;14462.783058254134;14586.34361453737;14903.329350179269;15322.23388830554;15856.841431585652;1515.7195918754956;1767.2930827668906;1773.733939909011;1822.3986084592052;1909.1695112625914;109336.07987640575;111713;112541.43729281383;112644;114453.42773286163;8733.737987860375;10932;10933.671989840317;11143.387113708824;11201.37580050888;13434.596962091153;13798.379072941741;13803.447862085604;13860.861391386159;13869.959753018362;8174.019117705794;8513.957430212933;8517.276031537389;8622.784430389165;8654;8466.32269418445;8466.534340611202;8505.489670619783;8595.742127736177;8666.739997800076;6608.801735947833;6695.330466953265;6712.597244165366;6723.327667233238;6806.659667016629;1678.742091886411;1806.2955447375534;1853.5366158460386;1870.5978214683907;1904.8571357148269;831.9209675080857;989.5101924547395;1005.527402121002;1032.700516850105;1083.6694808083453;20771.480712982295;21435.356939291847;21835.580687255595;21850.361222908345;21933;944.4286206844897;966.7239244197592;969.3699095587924;974.6101559376165;1050.112654806687;10722.195835312383;11144.721381965353;11679.941600291944;11760.647180584596;11771;510125;514365;519813;541485;542108;70595.94106088413;86426;96036.51981740046;96535;97239.0276097244;970.7379007668031;1009.3590569987964;1015.7816069545083;1039.101177481473;1042.598599539183;18521.35175268859;18600.813991859908;18835.717464237772;18919.90540047346;19282.93943833103;43556.34665479957;43667.78166109149;43789.56210437855;43888;46174.769126154155;60068;60158.39841601528;60709.69645151746;60778;61240.387596123466;7800.921990780246;8113.269805717514;8137.877931830909;8183.3862460316905;8302.418830681794;12360.56738014201;12447.875521244672;12467.688307792378;12798.61604151877;12963.027772916881;10809.56761729522;10947.945260273647;11111.944440277746;11144.832827507757;11229.855640420696;10015.649452269136;10714.089302409071;10776.353418794897;10982.395968221825;10986.121110310996;8809.691660791841;9349.439033658002;10784.137269018616;11103;11269.71825704364;8043.436959412785;8091.797705057421;8142.307903828241;8173.223543763333;8208;10900.945495272474;11180.720481988015;11432.256903301259;11459.713507162387;11483.712907177052 22:07:31 INFO - PROCESS | 1656 | |3;mootools.html;1435.8707716305535;1524.8627623513883;1724.9655006899861;1873.821986911243;1905.2759951218534;7461.888071678929;8011.479253848495;8473.91526084739;8484.490930544163;8498.787530311738;7547.622618869062;7698.692052317914;8001.359891208704;8266.297364724005;8274.462159959598;2308.8383813133046;2349.9177528786495;2350.27141586108;2357.56385068762;2363.6454531820277;2326.5695846268495;2343.789058984691;2369;2374.798142157919;2375.6436534519876;2154.881481518516;2197.110170380998;2286.8399212055165;2315.6294992801154;2333.195047708538;2282.8402011859175;2283.8515496492673;2308.5959957007626;2315.7452680205165;2320.9303720888315;2272.6591011348264;2307.7692230776956;2319.2926157521947;2319.605667036608;2320.083566991046;7537.869319602049;8391.874121888177;8456.154384561556;8460.873086903639;8477.745667629919;4856.344393506866;5074.188129899236;5097.057044446789;5103.260027296022;5109.540141387256;3290.8683652653867;3399.0312760863035;3542.2030043240065;3578.481120237577;3585.6772890439984;1010.8382658774634;1044.670928657478;1053.4206186597341;1073.8926107389277;1096.681962230952;10830.241883068109;10944.343339399662;10966.287191332538;10978.945105274583;10992.560297588087;4210.799922022209;4354.9765805035795;4463.2635615123145;4649.18639238132;4704.388429504143;9416.199623031982;9421.858672119924;9425.764355891157;9427.010163932688;9449.385789923634;4799.496052914464;5014.2979982802435;5236.450172731885;5237.528622424;5253.658512196695;4289.399484072233;4399.824007039682;4422.75674837887;4694.554017368345;4825.324454576362;3703.8888833335045;3837.366834472281;3881.3207688654375;3937.704672149543;3947.2302900934615;1269.3018839638162;1282.224254326138;1286.2539726958341;1298.5844529750577;1311.3377744239099;802.8073262417095;821.1255013410698;847.0428415890004;850.664456802826;958.6165533786541;5244.160934250502;5532.225488431623;5805.767769289181;5867.794627188114;6067.878642427215;939.4691999020531;975.020104794691;986.5560497775886;998.2114129837493;1032.6540608895955;3706.721995850322;3707.4624179494363;3713.291885732593;3782.981085094557;3898.473706049647;9841.114299713061;10181.898181018243;10209.897901021044;10225;10233;10082.546285417027;10180.643677471253;10199.898001020043;10202.591896324213;10207.795844083077;6988.825279367955;7774.6890124394395;7959.403044771665;7965.920340796518;7972;5214.878801057791;5287.629865909349;5822.970885145547;5903.409659034234;5919.792807251725;9159;9172.174504294646;9409.247260219028;9534.761630959281;9555;9267.165955064076;9421.434713917188;9595.376300540442;9671.661491847752;9689.467079310705;6677.732890684319;6900.482463815133;6921.480888933451;7060.223375428596;7196.5682059074525;7158.713651454092;7945.880811787712;7965.4822436541435;8020.679172833022;8046.155153708776;6969.198542167513;7057;7162.355388015104;7191.964040179766;7216.5670059796585;6783.389494945479;6980.310798536842;7048.189458212371;7054.929450705427;7135.50051496411;6573.57271777333;6580.025992202416;6630.602163870183;6712.932870671426;6728.629925354153;4832.371791667061;4859.611231101574;4902.436219834622;4948.430930442901;5021.548060674557;4797.280407938837;4841.1285968526;4911.263310503453;4960.900781984412;4983.75081245929 22:07:31 INFO - PROCESS | 1656 | |4;prototype.html;351.09242607858687;355.96591900528955;356.93396721606507;360.5475128713463;372.69811452723314;4525.352668688817;4545.409096817418;4754.025424787918;4884.900897298106;5095.898082038357;4362.585554372337;4861.659683822134;4882.827141921846;4986.900261994767;4999.800007999685;3542.2030043240325;3598.748087633873;4036.777977211252;4052.6555242804397;4100.815463304159;3394.6435624259466;3444.569428821397;4029.81865816039;4042.6967977401664;4122.763171048673;3341.1480072581458;3868.78721670308;3872.2255548890193;4065.5527891931865;4066.654334381581;3541.4594651326756;3855.2289542091694;3862.053796819769;3889.883303500914;3892.5328960524776;3310.7584655754094;3319.5850518685165;3327.284633803744;3346.866125354983;3353.4299169141304;4114.979425102885;4851.733154676492;4878.390201224847;4911.214205727102;4914.852554423337;3825.5271720387573;4191.015111448837;4267.082577245876;4414.947049621909;4496.8875778105485;4299.292274958946;4662.883427914296;5305.3898801637915;5477.808276710336;5509.449055094498;3208.278137419062;3718.9628103718887;3729.601399475197;3729.981350093259;3766.6610005099396;5053.5742843435355;5431.8593095450005;5492;5635.887282254332;5635.887282254373;3468.289000754839;3778.848846046127;3786.8106594670157;3795.5065841440437;3798.9240215196096;3763.2285381496727;3779.0712198046185;3814.504114465102;3821.961780382216;3859.9421008684894;3652.342578335872;4202.474690663667;4417.580329868657;4457.442819647544;4463.687541872037;4967.453580106186;5313.973430132902;5367.704776237344;5402.51377376038;5410.513053825174;1069.79139067881;1070.4112737994071;1081.2377274021796;1091.9135460217135;1241.7702724995904;796.5181065455432;806.8951036365353;835.1834759398406;849.1466076592984;855.7732200966749;4149.875503734893;4234.809433575497;4423.579759922803;4864.294677271776;4984.526469985346;4500;4851.539103785135;5186.481351864783;5258.685328667833;5280.9207861882105;4885.95114048855;4914.680545764514;4950.777215025332;5183.50756678115;5285.920711189336;2403.1108489858866;2501.6622755927715;2718.3689786128166;2792.2600510864636;2792.315882608774;4699.506551812011;4895.632827537949;5051.974740126276;5666.883214232156;5684.442001099522;4907.484714105039;4936.7284799336385;5161.974190129025;5306.469353064663;5463.825277565263;5531.621402796836;5574.944250557523;5575.215930902073;5581.860453488695;5592.524635406036;4954.77703503336;5194.766235519486;5232.5552328052545;5235.816746413857;5248.580113590827;4637.559431853969;4813.855584332476;4871.391076115486;5212.817551385835;5228.9738551307;4828.251620998751;5209.869753256199;5382.461753824743;5536.89262147564;5601.775928962796;3506.8421921013105;3531.717462603037;3535.929281414306;3551.271989242251;3574.7140228782155;4895.412550493964;4905.754712264444;5013.807947185151;5233.3196684432305;5252.686828292927;4925.433575138905;5022.598192144546;5047;5074.517920797518;5074.517920797518;4352.891177720582;4875.561199492063;4936.555709985975;5103.137354865373;5190.352920010746;4103.994521342291;4585.70192937458;4960.851174464772;4979.91245427837;5005.249212618136;4734.84564523148;5117.4114976776655;5169.948300516947;5330.8933821324135;5352.5450336721815;5043.672161309503;5205.735505055313;5228.137357336149;5230.189320655304;5230.843074707765 22:07:31 INFO - PROCESS | 1656 | |5;yui.html;720.7153174496074;727.8762610356239;746.182929691987;763.164335053117;814.8044469327361;14969.850301496981;15523;15528.068315901053;15534.22328883557;15551.53345399637;13795.2412617306;13900;13999.720005599882;14193.361298741556;14217.573472795833;686.4439803758971;708.9255628159046;720.3624792059039;863.935204859638;871.1332224436678;884.0187391994881;886.2599729226072;903.412781691899;903.5978989349742;904.5884122724177;893.964241430342;895.3553441522093;927.2674587076202;962.3888830592589;971.946542940138;733.3729661139702;750.2160242546552;948.5921053946801;956.3687965942479;962.4321650226365;535.5528134008108;712.3019440947849;714.6391072508402;715.6850985566334;722.819295176206;14648.12111273327;14648.487302944452;14683.48607798722;14694.265286735726;14705.264736763225;11265.831012534818;12580.056495762763;12614.432350544248;12911.418986145552;13041.347932603332;12417.689557761129;12609.991200703922;12662.176958497761;12704.6823829405;13318.267495287755;3736.4955730976512;4399.912001759947;4543.886402839922;4600.17196904557;4617.976910115462;107126;108969.91030089676;109300;109640.9999999992;113155;10418.583256669648;10540;10635.202359823044;10673.146148308117;11033.83449248262;20079.096440660207;21330.78669213319;21658.458538536663;21672.78327216739;21699.132034718434;7781.105172905189;7827.373810095179;7927.445078844541;7931;8132.430729848972;4147.274227010261;4266.466691663542;4299.376590394438;4328.567143285709;4392.9896123891685;3459.2562599041325;3506.4915587239707;3577.373959557067;3582.802945837952;3588.4796704478226;568.8066057540456;655.6688872119645;665.8102440804445;675.6081472745796;689.055993289197;588.3910152991718;601.425638515217;622.2191150106678;693.3343989769777;701.3442431326725;8765.34259930495;9350.392224505385;9403.90596094044;9726.36778609388;9737.707868763948;627.3694936588699;660.4510445606761;663.5587334422555;677.3971165662466;684.4421796236052;3674.9710081177313;4301.651846224851;4690.5543973323165;4761.762390249233;4835.371401717754;102363.46454803184;106972;107509;108295;111833;92623.07376926279;94365;95618.5219073914;95662;96690;63044;81565.59217203876;83472.16527834644;84098.73851892227;87590.56204718935;7591.2043978011;8085.070216925129;9103.635854565744;9224.389878350521;9576.90423095788;40023.799286021465;42691.93270168271;42938.1412371757;43548;43723.56276437195;60543.69728151331;61500.07749883845;64014;65056.69886602336;73793.89309160474;12335.75328493443;12834.479032953512;13217.339133043117;13321.866781332063;13567.321633918462;14160.645983850487;14534.93285871251;14544.157568312017;14726.35028958824;15078.698426031198;11708.47311870985;12425.502979880703;13404.061715679809;13894.791578126538;13975.231362275172;12237.877621223673;13678.794818077937;13887.791683124558;14105.365258563594;14309.713805723619;13206.009549284034;13264.469421223042;13624.978126640342;13754.93122534381;13961.022728408914;10730.302530335503;11234.662960111209;11245.606403775828;11306.773864522498;11340.716482088013;9075.364724469224;11240.718982025515;11331.263467874562;11463.598774043203;11534.192606517463 22:07:31 INFO - PROCESS | 1656 | __end_tp_report 22:07:31 INFO - PROCESS | 1656 | __start_cc_report 22:07:31 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2657 22:07:31 INFO - PROCESS | 1656 | __end_cc_report 22:07:31 INFO - PROCESS | 1656 | __startTimestamp1482041251751__endTimestamp 22:07:31 INFO - PROCESS | 1656 | 22:07:31 INFO - PROCESS | 1656 | ------- Summary: start ------- 22:07:31 INFO - PROCESS | 1656 | Number of tests: 6 22:07:31 INFO - PROCESS | 1656 | 22:07:31 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5473.62 Median:5624.13 stddev:624.49 (11.1%) stddev-sans-first:594.98 22:07:31 INFO - PROCESS | 1656 | Values: 2979.8 3268.0 3279.6 3292.5 3322.8 5311.6 5387.3 5393.2 5442.0 5461.3 5412.2 5419.1 5422.5 5433.3 5446.7 4956.8 4990.9 4991.5 5027.7 5080.5 5047.4 5124.9 5134.3 5135.4 5148.7 4996.4 5038.7 5075.1 5078.3 5123.3 5096.2 5117.4 5121.2 5121.9 5165.6 4039.5 4922.7 4928.0 5035.9 5045.2 4602.0 5350.7 5403.8 5421.7 5423.9 5885.1 5910.5 5922.0 5922.8 5936.1 5802.4 5880.1 5980.0 6028.9 6052.7 5527.3 5541.9 5553.1 5576.4 5624.1 6088.3 6126.2 6154.8 6172.6 6172.9 5649.4 5811.4 5823.9 5833.9 5836.3 5837.1 5901.6 5907.3 5909.4 5914.1 5621.4 5775.4 5819.7 5825.9 5839.6 5393.3 5845.3 5851.0 5856.5 5873.6 4647.7 4670.1 4694.9 4704.4 4711.6 4197.0 4250.8 4277.2 4277.2 4288.7 5543.4 5562.4 5570.4 5576.0 5577.2 5919.1 5928.6 5966.2 5998.2 6012.7 5593.6 5608.0 5610.5 5618.6 5619.4 4945.2 4948.9 4978.5 5013.5 5164.1 6221.6 6264.3 6294.5 6335.7 6350.2 5941.4 5952.7 5963.0 5978.4 6045.1 6088.6 6290.1 6331.7 6340.4 6357.6 5760.1 5810.4 5820.7 5828.9 5845.7 4920.6 5838.2 5874.9 5887.1 5912.9 4883.7 5742.0 5793.5 5812.2 5813.2 5779.1 5781.5 5782.8 5785.2 5807.8 5541.6 5602.0 5672.2 5676.5 5688.8 5710.0 5732.4 5737.3 5747.7 5761.8 4904.8 5608.0 5679.5 5682.6 5691.1 22:07:31 INFO - PROCESS | 1656 | 22:07:31 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:66906.47 Median:19113.94 stddev:147791.68 (773.2%) stddev-sans-first:148121.94 22:07:31 INFO - PROCESS | 1656 | Values: 409.9 462.2 480.7 500.5 501.3 37757.4 39872.8 39995.0 40296.8 40354.8 40973.6 41386.2 41543.4 41559.4 41596.0 8318.7 9202.6 9428.4 9435.3 9453.5 8473.2 11101.8 11337.0 11373.5 11510.7 11298.0 11366.5 11374.7 11391.8 11475.5 8438.7 8657.8 11261.4 11341.9 11355.1 10957.5 11214.0 11234.1 11423.7 11438.1 38961.2 39256.4 39371.4 39382.6 39458.0 3290.7 3435.9 3549.8 3552.3 3784.1 27396.0 27847.9 27881.6 28365.7 28687.3 2810.2 3164.6 3169.8 3181.9 3189.1 462466.0 462926.0 462996.0 463387.7 465596.0 53190.7 53615.5 53749.5 53870.7 53964.5 56674.1 56723.7 56741.9 56887.7 56955.6 14713.9 15189.5 15217.5 15227.4 15284.2 10706.4 10935.3 10945.8 11922.6 11973.5 16571.6 16810.1 17128.7 17161.6 17194.1 6753.4 7017.4 7496.0 7568.8 7595.8 864.5 906.2 929.6 973.3 1138.6 28477.0 29976.6 30056.8 30617.7 30736.1 965.8 1004.6 1013.1 1022.2 1029.7 13801.9 14294.5 14522.4 14655.0 14657.5 622696.0 629096.0 629733.0 632000.0 634411.0 46453.5 49038.0 51133.7 51588.5 51614.0 1161.8 1218.8 1267.9 1354.2 1367.8 26936.3 28113.0 28266.7 28955.7 29007.9 44690.8 45309.5 45355.1 45379.1 45420.0 484400.0 566829.0 567179.0 568604.1 569372.0 24606.4 24774.5 25941.9 25959.4 26001.2 41159.0 41654.2 42178.8 42359.6 42673.6 34792.0 34914.5 35105.0 35869.0 36202.6 32127.5 33557.2 34330.8 34987.3 35609.8 33477.2 33498.2 33597.8 33868.6 35018.5 28724.1 29976.9 30451.4 31122.0 31144.8 19097.8 23432.3 23445.9 23689.8 23770.3 22:07:31 INFO - PROCESS | 1656 | 22:07:31 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:31070.43 Median:14269.08 stddev:87149.15 (610.8%) stddev-sans-first:87363.05 22:07:31 INFO - PROCESS | 1656 | Values: 323.5 350.2 374.7 378.6 405.0 14396.3 14622.7 15439.2 19586.6 20367.7 18777.9 19967.4 20181.6 20320.9 20384.4 5478.9 5772.2 5772.7 5780.6 5786.9 5033.7 5591.5 5730.2 5765.5 5790.5 5723.5 5724.7 5728.9 5737.4 5737.9 4661.8 5625.2 5657.3 5683.7 5686.3 4809.6 4950.7 5002.1 5002.6 5027.8 25145.4 25398.6 25546.0 25745.4 25790.2 2318.0 2747.9 3029.2 3045.6 3131.7 14462.8 14586.3 14903.3 15322.2 15856.8 1515.7 1767.3 1773.7 1822.4 1909.2 109336.1 111713.0 112541.4 112644.0 114453.4 8733.7 10932.0 10933.7 11143.4 11201.4 13434.6 13798.4 13803.4 13860.9 13870.0 8174.0 8514.0 8517.3 8622.8 8654.0 8466.3 8466.5 8505.5 8595.7 8666.7 6608.8 6695.3 6712.6 6723.3 6806.7 1678.7 1806.3 1853.5 1870.6 1904.9 831.9 989.5 1005.5 1032.7 1083.7 20771.5 21435.4 21835.6 21850.4 21933.0 944.4 966.7 969.4 974.6 1050.1 10722.2 11144.7 11679.9 11760.6 11771.0 510125.0 514365.0 519813.0 541485.0 542108.0 70595.9 86426.0 96036.5 96535.0 97239.0 970.7 1009.4 1015.8 1039.1 1042.6 18521.4 18600.8 18835.7 18919.9 19282.9 43556.3 43667.8 43789.6 43888.0 46174.8 60068.0 60158.4 60709.7 60778.0 61240.4 7800.9 8113.3 8137.9 8183.4 8302.4 12360.6 12447.9 12467.7 12798.6 12963.0 10809.6 10947.9 11111.9 11144.8 11229.9 10015.6 10714.1 10776.4 10982.4 10986.1 8809.7 9349.4 10784.1 11103.0 11269.7 8043.4 8091.8 8142.3 8173.2 8208.0 10900.9 11180.7 11432.3 11459.7 11483.7 22:07:31 INFO - PROCESS | 1656 | 22:07:31 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5447.85 Median:4999.02 stddev:2979.50 (59.6%) stddev-sans-first:2972.60 22:07:31 INFO - PROCESS | 1656 | Values: 1435.9 1524.9 1725.0 1873.8 1905.3 7461.9 8011.5 8473.9 8484.5 8498.8 7547.6 7698.7 8001.4 8266.3 8274.5 2308.8 2349.9 2350.3 2357.6 2363.6 2326.6 2343.8 2369.0 2374.8 2375.6 2154.9 2197.1 2286.8 2315.6 2333.2 2282.8 2283.9 2308.6 2315.7 2320.9 2272.7 2307.8 2319.3 2319.6 2320.1 7537.9 8391.9 8456.2 8460.9 8477.7 4856.3 5074.2 5097.1 5103.3 5109.5 3290.9 3399.0 3542.2 3578.5 3585.7 1010.8 1044.7 1053.4 1073.9 1096.7 10830.2 10944.3 10966.3 10978.9 10992.6 4210.8 4355.0 4463.3 4649.2 4704.4 9416.2 9421.9 9425.8 9427.0 9449.4 4799.5 5014.3 5236.5 5237.5 5253.7 4289.4 4399.8 4422.8 4694.6 4825.3 3703.9 3837.4 3881.3 3937.7 3947.2 1269.3 1282.2 1286.3 1298.6 1311.3 802.8 821.1 847.0 850.7 958.6 5244.2 5532.2 5805.8 5867.8 6067.9 939.5 975.0 986.6 998.2 1032.7 3706.7 3707.5 3713.3 3783.0 3898.5 9841.1 10181.9 10209.9 10225.0 10233.0 10082.5 10180.6 10199.9 10202.6 10207.8 6988.8 7774.7 7959.4 7965.9 7972.0 5214.9 5287.6 5823.0 5903.4 5919.8 9159.0 9172.2 9409.2 9534.8 9555.0 9267.2 9421.4 9595.4 9671.7 9689.5 6677.7 6900.5 6921.5 7060.2 7196.6 7158.7 7945.9 7965.5 8020.7 8046.2 6969.2 7057.0 7162.4 7192.0 7216.6 6783.4 6980.3 7048.2 7054.9 7135.5 6573.6 6580.0 6630.6 6712.9 6728.6 4832.4 4859.6 4902.4 4948.4 5021.5 4797.3 4841.1 4911.3 4960.9 4983.8 22:07:31 INFO - PROCESS | 1656 | 22:07:31 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4246.61 Median:4856.70 stddev:1282.17 (26.4%) stddev-sans-first:1251.98 22:07:31 INFO - PROCESS | 1656 | Values: 351.1 356.0 356.9 360.5 372.7 4525.4 4545.4 4754.0 4884.9 5095.9 4362.6 4861.7 4882.8 4986.9 4999.8 3542.2 3598.7 4036.8 4052.7 4100.8 3394.6 3444.6 4029.8 4042.7 4122.8 3341.1 3868.8 3872.2 4065.6 4066.7 3541.5 3855.2 3862.1 3889.9 3892.5 3310.8 3319.6 3327.3 3346.9 3353.4 4115.0 4851.7 4878.4 4911.2 4914.9 3825.5 4191.0 4267.1 4414.9 4496.9 4299.3 4662.9 5305.4 5477.8 5509.4 3208.3 3719.0 3729.6 3730.0 3766.7 5053.6 5431.9 5492.0 5635.9 5635.9 3468.3 3778.8 3786.8 3795.5 3798.9 3763.2 3779.1 3814.5 3822.0 3859.9 3652.3 4202.5 4417.6 4457.4 4463.7 4967.5 5314.0 5367.7 5402.5 5410.5 1069.8 1070.4 1081.2 1091.9 1241.8 796.5 806.9 835.2 849.1 855.8 4149.9 4234.8 4423.6 4864.3 4984.5 4500.0 4851.5 5186.5 5258.7 5280.9 4886.0 4914.7 4950.8 5183.5 5285.9 2403.1 2501.7 2718.4 2792.3 2792.3 4699.5 4895.6 5052.0 5666.9 5684.4 4907.5 4936.7 5162.0 5306.5 5463.8 5531.6 5574.9 5575.2 5581.9 5592.5 4954.8 5194.8 5232.6 5235.8 5248.6 4637.6 4813.9 4871.4 5212.8 5229.0 4828.3 5209.9 5382.5 5536.9 5601.8 3506.8 3531.7 3535.9 3551.3 3574.7 4895.4 4905.8 5013.8 5233.3 5252.7 4925.4 5022.6 5047.0 5074.5 5074.5 4352.9 4875.6 4936.6 5103.1 5190.4 4104.0 4585.7 4960.9 4979.9 5005.2 4734.8 5117.4 5169.9 5330.9 5352.5 5043.7 5205.7 5228.1 5230.2 5230.8 22:07:31 INFO - PROCESS | 1656 | 22:07:31 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:20567.83 Median:23618.76 stddev:30315.95 (128.4%) stddev-sans-first:30364.37 22:07:31 INFO - PROCESS | 1656 | Values: 720.7 727.9 746.2 763.2 814.8 14969.9 15523.0 15528.1 15534.2 15551.5 13795.2 13900.0 13999.7 14193.4 14217.6 686.4 708.9 720.4 863.9 871.1 884.0 886.3 903.4 903.6 904.6 894.0 895.4 927.3 962.4 971.9 733.4 750.2 948.6 956.4 962.4 535.6 712.3 714.6 715.7 722.8 14648.1 14648.5 14683.5 14694.3 14705.3 11265.8 12580.1 12614.4 12911.4 13041.3 12417.7 12610.0 12662.2 12704.7 13318.3 3736.5 4399.9 4543.9 4600.2 4618.0 107126.0 108969.9 109300.0 109641.0 113155.0 10418.6 10540.0 10635.2 10673.1 11033.8 20079.1 21330.8 21658.5 21672.8 21699.1 7781.1 7827.4 7927.4 7931.0 8132.4 4147.3 4266.5 4299.4 4328.6 4393.0 3459.3 3506.5 3577.4 3582.8 3588.5 568.8 655.7 665.8 675.6 689.1 588.4 601.4 622.2 693.3 701.3 8765.3 9350.4 9403.9 9726.4 9737.7 627.4 660.5 663.6 677.4 684.4 3675.0 4301.7 4690.6 4761.8 4835.4 102363.5 106972.0 107509.0 108295.0 111833.0 92623.1 94365.0 95618.5 95662.0 96690.0 63044.0 81565.6 83472.2 84098.7 87590.6 7591.2 8085.1 9103.6 9224.4 9576.9 40023.8 42691.9 42938.1 43548.0 43723.6 60543.7 61500.1 64014.0 65056.7 73793.9 12335.8 12834.5 13217.3 13321.9 13567.3 14160.6 14534.9 14544.2 14726.4 15078.7 11708.5 12425.5 13404.1 13894.8 13975.2 12237.9 13678.8 13887.8 14105.4 14309.7 13206.0 13264.5 13625.0 13754.9 13961.0 10730.3 11234.7 11245.6 11306.8 11340.7 9075.4 11240.7 11331.3 11463.6 11534.2 22:07:31 INFO - PROCESS | 1656 | -------- Summary: end -------- 22:07:31 INFO - PROCESS | 1656 | 22:07:32 INFO - TEST-INFO | 1656: exit 0 22:07:32 INFO - TEST-OK | dromaeo_css | took 1120984ms 22:07:32 INFO - TEST-START | kraken 22:07:32 INFO - operating with platform_type : mac_ 22:07:32 INFO - Initialising browser for kraken test... 22:07:32 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpfFMGPR/profile http://localhost:49243/getInfo.html) 22:07:34 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 22:07:34 INFO - PROCESS | 1662 | colorDepth:24 22:07:34 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 22:07:34 INFO - PROCESS | 1662 | __metrics 22:07:34 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:07:34 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:07:35 INFO - TEST-INFO | 1662: exit 0 22:07:35 INFO - Browser initialized. 22:07:35 INFO - Running cycle 1/1 for kraken test... 22:07:35 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpfFMGPR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:07:47 INFO - PROCESS | 1663 | RSS: Main: 238092288 22:07:47 INFO - PROCESS | 1663 | 22:07:50 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 22:07:51 INFO - PROCESS | 1663 | RSS: Main: 289099776 22:07:51 INFO - PROCESS | 1663 | 22:07:54 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 22:07:54 INFO - PROCESS | 1663 | RSS: Main: 290459648 22:07:54 INFO - PROCESS | 1663 | 22:07:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 22:07:58 INFO - PROCESS | 1663 | RSS: Main: 384053248 22:07:58 INFO - PROCESS | 1663 | 22:08:00 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 22:08:01 INFO - PROCESS | 1663 | RSS: Main: 283836416 22:08:01 INFO - PROCESS | 1663 | 22:08:03 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:08:03 INFO - PROCESS | 1663 | RSS: Main: 288714752 22:08:03 INFO - PROCESS | 1663 | 22:08:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 22:08:07 INFO - PROCESS | 1663 | RSS: Main: 331886592 22:08:07 INFO - PROCESS | 1663 | 22:08:10 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 22:08:10 INFO - PROCESS | 1663 | RSS: Main: 332595200 22:08:10 INFO - PROCESS | 1663 | 22:08:13 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 22:08:14 INFO - PROCESS | 1663 | RSS: Main: 328298496 22:08:14 INFO - PROCESS | 1663 | 22:08:16 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:08:16 INFO - PROCESS | 1663 | RSS: Main: 305930240 22:08:16 INFO - PROCESS | 1663 | 22:08:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:08:19 INFO - PROCESS | 1663 | RSS: Main: 308469760 22:08:19 INFO - PROCESS | 1663 | 22:08:21 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:08:22 INFO - PROCESS | 1663 | RSS: Main: 310484992 22:08:22 INFO - PROCESS | 1663 | 22:08:25 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:08:25 INFO - PROCESS | 1663 | RSS: Main: 328065024 22:08:25 INFO - PROCESS | 1663 | 22:08:28 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:08:29 INFO - PROCESS | 1663 | RSS: Main: 322580480 22:08:29 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 22:08:31 INFO - PROCESS | 1663 | RSS: Main: 366641152 22:08:31 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | __start_tp_report 22:08:31 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 22:08:31 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 22:08:31 INFO - PROCESS | 1663 | |i|pagename|runs| 22:08:31 INFO - PROCESS | 1663 | |0;ai-astar;114;116;115;114;113;114;114;114;112;113 22:08:31 INFO - PROCESS | 1663 | |1;audio-beat-detection;146;125;139;138;141;141;146;109;131;108 22:08:31 INFO - PROCESS | 1663 | |2;audio-dft;182;184;184;185;185;182;183;179;182;184 22:08:31 INFO - PROCESS | 1663 | |3;audio-fft;75;58;58;86;61;58;58;58;72;58 22:08:31 INFO - PROCESS | 1663 | |4;audio-oscillator;88;70;85;71;68;68;84;70;68;84 22:08:31 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;107;110;109;110;107;111;109;112;107;110 22:08:31 INFO - PROCESS | 1663 | |6;imaging-darkroom;94;104;149;123;93;93;94;94;98;95 22:08:31 INFO - PROCESS | 1663 | |7;imaging-desaturate;112;133;115;88;89;85;87;85;85;87 22:08:31 INFO - PROCESS | 1663 | |8;json-parse-financial;59;57;52;54;54;54;56;57;55;55 22:08:31 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;66;92;113;111;80;69;69;71;71;71 22:08:31 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;87;86;91;86;87;86;87;86;88;88 22:08:31 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;142;139;139;140;137;139;142;142;206;166 22:08:31 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;169;165;174;169;169;169;171;170;167;169 22:08:31 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;67;67;68;65;65;68;65;82;66;66 22:08:31 INFO - PROCESS | 1663 | __end_tp_report 22:08:31 INFO - PROCESS | 1663 | __start_cc_report 22:08:31 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1962 22:08:31 INFO - PROCESS | 1663 | __end_cc_report 22:08:31 INFO - PROCESS | 1663 | __startTimestamp1482041311267__endTimestamp 22:08:31 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | ------- Summary: start ------- 22:08:31 INFO - PROCESS | 1663 | Number of tests: 14 22:08:31 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:1.10 (1.0%) stddev-sans-first:1.17 22:08:31 INFO - PROCESS | 1663 | Values: 114.0 116.0 115.0 114.0 113.0 114.0 114.0 114.0 112.0 113.0 22:08:31 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:140.00 stddev:14.11 (10.1%) stddev-sans-first:14.08 22:08:31 INFO - PROCESS | 1663 | Values: 146.0 125.0 139.0 138.0 141.0 141.0 146.0 109.0 131.0 108.0 22:08:31 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:183.00 Median:184.00 stddev:1.83 (1.0%) stddev-sans-first:1.90 22:08:31 INFO - PROCESS | 1663 | Values: 182.0 184.0 184.0 185.0 185.0 182.0 183.0 179.0 182.0 184.0 22:08:31 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:64.20 Median:59.50 stddev:9.96 (16.7%) stddev-sans-first:9.77 22:08:31 INFO - PROCESS | 1663 | Values: 75.0 58.0 58.0 86.0 61.0 58.0 58.0 58.0 72.0 58.0 22:08:31 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:77.50 stddev:8.44 (10.9%) stddev-sans-first:7.66 22:08:31 INFO - PROCESS | 1663 | Values: 88.0 70.0 85.0 71.0 68.0 68.0 84.0 70.0 68.0 84.0 22:08:31 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:110.00 stddev:1.75 (1.6%) stddev-sans-first:1.67 22:08:31 INFO - PROCESS | 1663 | Values: 107.0 110.0 109.0 110.0 107.0 111.0 109.0 112.0 107.0 110.0 22:08:31 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:103.70 Median:94.00 stddev:18.39 (19.6%) stddev-sans-first:19.17 22:08:31 INFO - PROCESS | 1663 | Values: 94.0 104.0 149.0 123.0 93.0 93.0 94.0 94.0 98.0 95.0 22:08:31 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:86.00 stddev:17.06 (19.8%) stddev-sans-first:17.16 22:08:31 INFO - PROCESS | 1663 | Values: 112.0 133.0 115.0 88.0 89.0 85.0 87.0 85.0 85.0 87.0 22:08:31 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:2.00 (3.6%) stddev-sans-first:1.62 22:08:31 INFO - PROCESS | 1663 | Values: 59.0 57.0 52.0 54.0 54.0 54.0 56.0 57.0 55.0 55.0 22:08:31 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:81.30 Median:71.00 stddev:17.82 (25.1%) stddev-sans-first:18.02 22:08:31 INFO - PROCESS | 1663 | Values: 66.0 92.0 113.0 111.0 80.0 69.0 69.0 71.0 71.0 71.0 22:08:31 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.00 stddev:1.55 (1.8%) stddev-sans-first:1.64 22:08:31 INFO - PROCESS | 1663 | Values: 87.0 86.0 91.0 86.0 87.0 86.0 87.0 86.0 88.0 88.0 22:08:31 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:142.00 stddev:21.63 (15.2%) stddev-sans-first:22.78 22:08:31 INFO - PROCESS | 1663 | Values: 142.0 139.0 139.0 140.0 137.0 139.0 142.0 142.0 206.0 166.0 22:08:31 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:169.00 stddev:2.35 (1.4%) stddev-sans-first:2.49 22:08:31 INFO - PROCESS | 1663 | Values: 169.0 165.0 174.0 169.0 169.0 169.0 171.0 170.0 167.0 169.0 22:08:31 INFO - PROCESS | 1663 | 22:08:31 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.00 stddev:5.09 (7.6%) stddev-sans-first:5.39 22:08:31 INFO - PROCESS | 1663 | Values: 67.0 67.0 68.0 65.0 65.0 68.0 65.0 82.0 66.0 66.0 22:08:31 INFO - PROCESS | 1663 | -------- Summary: end -------- 22:08:31 INFO - PROCESS | 1663 | 22:08:32 INFO - TEST-INFO | 1663: exit 0 22:08:32 INFO - TEST-OK | kraken | took 59745ms 22:08:32 INFO - SUITE-END | took 1180s 22:08:32 INFO - Completed test suite (00:19:40) 22:08:32 INFO - javascript benchmark 22:08:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2979.7914146009775, 3268.035929400828, 3279.573385577274, 3292.489664102065, 3322.76740628156, 5311.57507399408, 5387.299651045363, 5393.217983392406, 5442.020436321461, 5461.262729531512, 5412.242286079952, 5419.078756611376, 5422.53908417785, 5433.266509021281, 5446.7276636168235, 4956.776945037482, 4990.87522811929, 4991.450940396553, 5027.673201241908, 5080.466551012146, 5047.369078865142, 5124.9487505125035, 5134.332536770234, 5135.409427915782, 5148.691078535281, 4996.400431948153, 5038.722870242135, 5075.061113693979, 5078.339815823956, 5123.282740416326, 5096.235564665311, 5117.360329958755, 5121.206213036985, 5121.897562048738, 5165.612579056586, 4039.4950631171105, 4922.729249891255, 4927.989762098761, 5035.899282014376, 5045.192769156954, 4601.976990115028, 5350.652207606493, 5403.8108666196495, 5421.728913554307, 5423.945760542383, 5885.146653735227, 5910.527157827363, 5922.0, 5922.763089476416, 5936.1392598073035, 5802.390748971339, 5880.088586269135, 5980.0, 6028.939710602882, 6052.667103309316, 5527.309086364205, 5541.861453463695, 5553.111502159635, 5576.442355764391, 5624.128260119688, 6088.2694076710195, 6126.23422072241, 6154.815355539341, 6172.598781079216, 6172.938270617236, 5649.378568357477, 5811.389804070596, 5823.854403639943, 5833.912491312633, 5836.328822185503, 5837.124431335249, 5901.557383196277, 5907.261592300963, 5909.379515150933, 5914.112883067488, 5621.409751976065, 5775.393583673737, 5819.6508209507565, 5825.854353641108, 5839.591228613956, 5393.271908292409, 5845.269341332333, 5851.0, 5856.472917437451, 5873.559483038789, 4647.697899636512, 4670.089332580114, 4694.906101877943, 4704.411948506437, 4711.599514041276, 4197.0, 4250.766207858535, 4277.165952639268, 4277.208716387416, 4288.742675439421, 5543.417941116206, 5562.415946325658, 5570.387257401682, 5575.968445837533, 5577.2191893135, 5919.141724449931, 5928.584999050111, 5966.194563733927, 5998.220231369981, 6012.669303188279, 5593.608447408642, 5608.0, 5610.4670056344585, 5618.634788738719, 5619.381867994517, 4945.184044632667, 4948.8762780930765, 4978.452370239271, 5013.49865013503, 5164.14791559396, 6221.595596286227, 6264.310925798159, 6294.464970477469, 6335.683215839282, 6350.206224221973, 5941.435563621449, 5952.732127054206, 5963.0, 5978.4021597839865, 6045.063015232646, 6088.607784207314, 6290.0879372491645, 6331.746730130927, 6340.365963403623, 6357.554971151975, 5760.0783874579865, 5810.4189581041555, 5820.70896455184, 5828.854278643068, 5845.736941837713, 4920.581750551243, 5838.1826544282985, 5874.911876321944, 5887.116932460165, 5912.940870591411, 4883.731394773179, 5742.023855944583, 5793.478586927028, 5812.157237200667, 5813.215215945962, 5779.075347944308, 5781.537477001913, 5782.768689252551, 5785.218995435563, 5807.796727114531, 5541.612087153861, 5601.991641504405, 5672.205891175321, 5676.545876329967, 5688.800891968761, 5709.9714501427225, 5732.398098199796, 5737.282839645044, 5747.7413516391025, 5761.769529218952, 4904.828331008398, 5607.971960140337, 5679.488846003879, 5682.602217844877, 5691.089425692035], "value": 5434.291016214367, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.9487564054495, 462.1773243626345, 480.7115730561661, 500.4845009640072, 501.32321366155696, 37757.43363849541, 39872.80063599685, 39995.0, 40296.79851600738, 40354.79822600883, 40973.59026409735, 41386.17227655445, 41543.37684934721, 41559.37660935081, 41595.96010099749, 8318.66725330989, 9202.63189472422, 9428.434293942351, 9435.292353073513, 9453.527323633825, 8473.15268473154, 11101.83347249792, 11336.979671829533, 11373.488193031291, 11510.654680359561, 11298.0, 11366.545338186463, 11374.658760237206, 11391.829122563167, 11475.540978360856, 8438.662453501853, 8657.826843463095, 11261.380624065672, 11341.886581134208, 11355.091592672648, 10957.452127393679, 11213.990740833282, 11234.10127189823, 11423.714407139805, 11438.142139339583, 38961.22077558461, 39256.41115383271, 39371.40942885859, 39382.606173938184, 39458.0, 3290.7038366546885, 3435.879744208966, 3549.804760738158, 3552.3250582389264, 3784.148566572499, 27396.0, 27847.86076069607, 27881.58177627337, 28365.716342836513, 28687.282817929718, 2810.170999555136, 3164.6259852277753, 3169.8098114112995, 3181.9204519886957, 3189.059227527885, 462466.0, 462926.0, 462996.0, 463387.6830615859, 465596.0, 53190.73404632952, 53615.463845361046, 53749.462505375224, 53870.7306463473, 53964.46035539673, 56674.149887751715, 56723.71638141783, 56741.865162696515, 56887.71556142193, 56955.57611059757, 14713.852861471249, 15189.544313670607, 15217.467388641344, 15227.390904363923, 15284.235788210544, 10706.357618542912, 10935.28920620157, 10945.781084378268, 11922.642320730392, 11973.52105915771, 16571.585710357336, 16810.075445850594, 17128.74306885398, 17161.570960726083, 17194.054327012134, 6753.425958793558, 7017.4035207006955, 7496.0, 7568.810779730551, 7595.848083038309, 864.4726716702806, 906.1618003346878, 929.6281487405092, 973.2992245583168, 1138.6071805227184, 28477.0, 29976.55035174474, 30056.849715751283, 30617.693823061483, 30736.077917662507, 965.7875267441152, 1004.55799448244, 1013.0730381700808, 1022.1669339488293, 1029.696239609302, 13801.930990345185, 14294.499692510712, 14522.419103235752, 14655.0, 14657.48698795537, 622696.0, 629096.0, 629733.0, 632000.0, 634411.0, 46453.535464645596, 49038.01923961501, 51133.74433127885, 51588.48411515912, 51614.0, 1161.8315344275202, 1218.8171774233758, 1267.8922291605318, 1354.1671871798774, 1367.787992861108, 26936.32659183536, 28113.0, 28266.717332826407, 28955.710442896143, 29007.85496072506, 44690.776546117064, 45309.54690453185, 45355.09289814251, 45379.09241815211, 45420.0, 484400.0, 566829.0, 567179.0, 568604.0814694064, 569372.0, 24606.384840379134, 24774.50450991006, 25941.87029064918, 25959.351016224744, 26001.219963401127, 41159.0, 41654.16691666211, 42178.7891060555, 42359.576404235566, 42673.57326426696, 34792.0, 34914.47628285629, 35105.0, 35869.0, 36202.63797361992, 32127.518087228244, 33557.16107097342, 34330.82834585811, 34987.30025399529, 35609.82195089008, 33477.16307092245, 33498.162545936546, 33597.83201083979, 33868.57818415811, 35018.474722878665, 28724.138275851757, 29976.850115749283, 30451.39097217999, 31122.0, 31144.844275778476, 19097.809021909605, 23432.297031089096, 23445.88277058604, 23689.763102368757, 23770.286891393287], "value": 19087.2582240661, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.45982209709786, 350.1613635343351, 374.6628034768708, 378.6421831369356, 404.9673333000847, 14396.280185990698, 14622.707545849076, 15439.228038598067, 19586.608267834636, 20367.694484582742, 18777.90611046943, 19967.400977970647, 20181.59636807263, 20320.898395508, 20384.388468345936, 5478.945210547883, 5772.191893134965, 5772.740226689788, 5780.624259423145, 5786.855328616797, 5033.697978121324, 5591.4688104629995, 5730.226419433365, 5765.481106700396, 5790.507806836424, 5723.5421166306805, 5724.685142317192, 5728.885422291552, 5737.3688894221605, 5737.938481380937, 4661.76691165442, 5625.240592519998, 5657.321121465409, 5683.658980461186, 5686.346070201897, 4809.591184749301, 4950.727709975949, 5002.1496345621335, 5002.649814512985, 5027.798888044474, 25145.371365715822, 25398.619020714705, 25545.978160873543, 25745.356366090997, 25790.226293211235, 2317.9652305215436, 2747.931301717453, 3029.242689327668, 3045.5888455058507, 3131.6711745266875, 14462.783058254134, 14586.34361453737, 14903.329350179269, 15322.23388830554, 15856.841431585652, 1515.7195918754956, 1767.2930827668906, 1773.733939909011, 1822.3986084592052, 1909.1695112625914, 109336.07987640575, 111713.0, 112541.43729281383, 112644.0, 114453.42773286163, 8733.737987860375, 10932.0, 10933.671989840317, 11143.387113708824, 11201.37580050888, 13434.596962091153, 13798.379072941741, 13803.447862085604, 13860.861391386159, 13869.959753018362, 8174.019117705794, 8513.957430212933, 8517.276031537389, 8622.784430389165, 8654.0, 8466.32269418445, 8466.534340611202, 8505.489670619783, 8595.742127736177, 8666.739997800076, 6608.801735947833, 6695.330466953265, 6712.597244165366, 6723.327667233238, 6806.659667016629, 1678.742091886411, 1806.2955447375534, 1853.5366158460386, 1870.5978214683907, 1904.8571357148269, 831.9209675080857, 989.5101924547395, 1005.527402121002, 1032.700516850105, 1083.6694808083453, 20771.480712982295, 21435.356939291847, 21835.580687255595, 21850.361222908345, 21933.0, 944.4286206844897, 966.7239244197592, 969.3699095587924, 974.6101559376165, 1050.112654806687, 10722.195835312383, 11144.721381965353, 11679.941600291944, 11760.647180584596, 11771.0, 510125.0, 514365.0, 519813.0, 541485.0, 542108.0, 70595.94106088413, 86426.0, 96036.51981740046, 96535.0, 97239.0276097244, 970.7379007668031, 1009.3590569987964, 1015.7816069545083, 1039.101177481473, 1042.598599539183, 18521.35175268859, 18600.813991859908, 18835.717464237772, 18919.90540047346, 19282.93943833103, 43556.34665479957, 43667.78166109149, 43789.56210437855, 43888.0, 46174.769126154155, 60068.0, 60158.39841601528, 60709.69645151746, 60778.0, 61240.387596123466, 7800.921990780246, 8113.269805717514, 8137.877931830909, 8183.3862460316905, 8302.418830681794, 12360.56738014201, 12447.875521244672, 12467.688307792378, 12798.61604151877, 12963.027772916881, 10809.56761729522, 10947.945260273647, 11111.944440277746, 11144.832827507757, 11229.855640420696, 10015.649452269136, 10714.089302409071, 10776.353418794897, 10982.395968221825, 10986.121110310996, 8809.691660791841, 9349.439033658002, 10784.137269018616, 11103.0, 11269.71825704364, 8043.436959412785, 8091.797705057421, 8142.307903828241, 8173.223543763333, 8208.0, 10900.945495272474, 11180.720481988015, 11432.256903301259, 11459.713507162387, 11483.712907177052], "value": 9410.148635087442, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.8707716305535, 1524.8627623513883, 1724.9655006899861, 1873.821986911243, 1905.2759951218534, 7461.888071678929, 8011.479253848495, 8473.91526084739, 8484.490930544163, 8498.787530311738, 7547.622618869062, 7698.692052317914, 8001.359891208704, 8266.297364724005, 8274.462159959598, 2308.8383813133046, 2349.9177528786495, 2350.27141586108, 2357.56385068762, 2363.6454531820277, 2326.5695846268495, 2343.789058984691, 2369.0, 2374.798142157919, 2375.6436534519876, 2154.881481518516, 2197.110170380998, 2286.8399212055165, 2315.6294992801154, 2333.195047708538, 2282.8402011859175, 2283.8515496492673, 2308.5959957007626, 2315.7452680205165, 2320.9303720888315, 2272.6591011348264, 2307.7692230776956, 2319.2926157521947, 2319.605667036608, 2320.083566991046, 7537.869319602049, 8391.874121888177, 8456.154384561556, 8460.873086903639, 8477.745667629919, 4856.344393506866, 5074.188129899236, 5097.057044446789, 5103.260027296022, 5109.540141387256, 3290.8683652653867, 3399.0312760863035, 3542.2030043240065, 3578.481120237577, 3585.6772890439984, 1010.8382658774634, 1044.670928657478, 1053.4206186597341, 1073.8926107389277, 1096.681962230952, 10830.241883068109, 10944.343339399662, 10966.287191332538, 10978.945105274583, 10992.560297588087, 4210.799922022209, 4354.9765805035795, 4463.2635615123145, 4649.18639238132, 4704.388429504143, 9416.199623031982, 9421.858672119924, 9425.764355891157, 9427.010163932688, 9449.385789923634, 4799.496052914464, 5014.2979982802435, 5236.450172731885, 5237.528622424, 5253.658512196695, 4289.399484072233, 4399.824007039682, 4422.75674837887, 4694.554017368345, 4825.324454576362, 3703.8888833335045, 3837.366834472281, 3881.3207688654375, 3937.704672149543, 3947.2302900934615, 1269.3018839638162, 1282.224254326138, 1286.2539726958341, 1298.5844529750577, 1311.3377744239099, 802.8073262417095, 821.1255013410698, 847.0428415890004, 850.664456802826, 958.6165533786541, 5244.160934250502, 5532.225488431623, 5805.767769289181, 5867.794627188114, 6067.878642427215, 939.4691999020531, 975.020104794691, 986.5560497775886, 998.2114129837493, 1032.6540608895955, 3706.721995850322, 3707.4624179494363, 3713.291885732593, 3782.981085094557, 3898.473706049647, 9841.114299713061, 10181.898181018243, 10209.897901021044, 10225.0, 10233.0, 10082.546285417027, 10180.643677471253, 10199.898001020043, 10202.591896324213, 10207.795844083077, 6988.825279367955, 7774.6890124394395, 7959.403044771665, 7965.920340796518, 7972.0, 5214.878801057791, 5287.629865909349, 5822.970885145547, 5903.409659034234, 5919.792807251725, 9159.0, 9172.174504294646, 9409.247260219028, 9534.761630959281, 9555.0, 9267.165955064076, 9421.434713917188, 9595.376300540442, 9671.661491847752, 9689.467079310705, 6677.732890684319, 6900.482463815133, 6921.480888933451, 7060.223375428596, 7196.5682059074525, 7158.713651454092, 7945.880811787712, 7965.4822436541435, 8020.679172833022, 8046.155153708776, 6969.198542167513, 7057.0, 7162.355388015104, 7191.964040179766, 7216.5670059796585, 6783.389494945479, 6980.310798536842, 7048.189458212371, 7054.929450705427, 7135.50051496411, 6573.57271777333, 6580.025992202416, 6630.602163870183, 6712.932870671426, 6728.629925354153, 4832.371791667061, 4859.611231101574, 4902.436219834622, 4948.430930442901, 5021.548060674557, 4797.280407938837, 4841.1285968526, 4911.263310503453, 4960.900781984412, 4983.75081245929], "value": 4431.24401525988, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.09242607858687, 355.96591900528955, 356.93396721606507, 360.5475128713463, 372.69811452723314, 4525.352668688817, 4545.409096817418, 4754.025424787918, 4884.900897298106, 5095.898082038357, 4362.585554372337, 4861.659683822134, 4882.827141921846, 4986.900261994767, 4999.800007999685, 3542.2030043240325, 3598.748087633873, 4036.777977211252, 4052.6555242804397, 4100.815463304159, 3394.6435624259466, 3444.569428821397, 4029.81865816039, 4042.6967977401664, 4122.763171048673, 3341.1480072581458, 3868.78721670308, 3872.2255548890193, 4065.5527891931865, 4066.654334381581, 3541.4594651326756, 3855.2289542091694, 3862.053796819769, 3889.883303500914, 3892.5328960524776, 3310.7584655754094, 3319.5850518685165, 3327.284633803744, 3346.866125354983, 3353.4299169141304, 4114.979425102885, 4851.733154676492, 4878.390201224847, 4911.214205727102, 4914.852554423337, 3825.5271720387573, 4191.015111448837, 4267.082577245876, 4414.947049621909, 4496.8875778105485, 4299.292274958946, 4662.883427914296, 5305.3898801637915, 5477.808276710336, 5509.449055094498, 3208.278137419062, 3718.9628103718887, 3729.601399475197, 3729.981350093259, 3766.6610005099396, 5053.5742843435355, 5431.8593095450005, 5492.0, 5635.887282254332, 5635.887282254373, 3468.289000754839, 3778.848846046127, 3786.8106594670157, 3795.5065841440437, 3798.9240215196096, 3763.2285381496727, 3779.0712198046185, 3814.504114465102, 3821.961780382216, 3859.9421008684894, 3652.342578335872, 4202.474690663667, 4417.580329868657, 4457.442819647544, 4463.687541872037, 4967.453580106186, 5313.973430132902, 5367.704776237344, 5402.51377376038, 5410.513053825174, 1069.79139067881, 1070.4112737994071, 1081.2377274021796, 1091.9135460217135, 1241.7702724995904, 796.5181065455432, 806.8951036365353, 835.1834759398406, 849.1466076592984, 855.7732200966749, 4149.875503734893, 4234.809433575497, 4423.579759922803, 4864.294677271776, 4984.526469985346, 4500.0, 4851.539103785135, 5186.481351864783, 5258.685328667833, 5280.9207861882105, 4885.95114048855, 4914.680545764514, 4950.777215025332, 5183.50756678115, 5285.920711189336, 2403.1108489858866, 2501.6622755927715, 2718.3689786128166, 2792.2600510864636, 2792.315882608774, 4699.506551812011, 4895.632827537949, 5051.974740126276, 5666.883214232156, 5684.442001099522, 4907.484714105039, 4936.7284799336385, 5161.974190129025, 5306.469353064663, 5463.825277565263, 5531.621402796836, 5574.944250557523, 5575.215930902073, 5581.860453488695, 5592.524635406036, 4954.77703503336, 5194.766235519486, 5232.5552328052545, 5235.816746413857, 5248.580113590827, 4637.559431853969, 4813.855584332476, 4871.391076115486, 5212.817551385835, 5228.9738551307, 4828.251620998751, 5209.869753256199, 5382.461753824743, 5536.89262147564, 5601.775928962796, 3506.8421921013105, 3531.717462603037, 3535.929281414306, 3551.271989242251, 3574.7140228782155, 4895.412550493964, 4905.754712264444, 5013.807947185151, 5233.3196684432305, 5252.686828292927, 4925.433575138905, 5022.598192144546, 5047.0, 5074.517920797518, 5074.517920797518, 4352.891177720582, 4875.561199492063, 4936.555709985975, 5103.137354865373, 5190.352920010746, 4103.994521342291, 4585.70192937458, 4960.851174464772, 4979.91245427837, 5005.249212618136, 4734.84564523148, 5117.4114976776655, 5169.948300516947, 5330.8933821324135, 5352.5450336721815, 5043.672161309503, 5205.735505055313, 5228.137357336149, 5230.189320655304, 5230.843074707765], "value": 3850.0072382322223, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.7153174496074, 727.8762610356239, 746.182929691987, 763.164335053117, 814.8044469327361, 14969.850301496981, 15523.0, 15528.068315901053, 15534.22328883557, 15551.53345399637, 13795.2412617306, 13900.0, 13999.720005599882, 14193.361298741556, 14217.573472795833, 686.4439803758971, 708.9255628159046, 720.3624792059039, 863.935204859638, 871.1332224436678, 884.0187391994881, 886.2599729226072, 903.412781691899, 903.5978989349742, 904.5884122724177, 893.964241430342, 895.3553441522093, 927.2674587076202, 962.3888830592589, 971.946542940138, 733.3729661139702, 750.2160242546552, 948.5921053946801, 956.3687965942479, 962.4321650226365, 535.5528134008108, 712.3019440947849, 714.6391072508402, 715.6850985566334, 722.819295176206, 14648.12111273327, 14648.487302944452, 14683.48607798722, 14694.265286735726, 14705.264736763225, 11265.831012534818, 12580.056495762763, 12614.432350544248, 12911.418986145552, 13041.347932603332, 12417.689557761129, 12609.991200703922, 12662.176958497761, 12704.6823829405, 13318.267495287755, 3736.4955730976512, 4399.912001759947, 4543.886402839922, 4600.17196904557, 4617.976910115462, 107126.0, 108969.91030089676, 109300.0, 109640.9999999992, 113155.0, 10418.583256669648, 10540.0, 10635.202359823044, 10673.146148308117, 11033.83449248262, 20079.096440660207, 21330.78669213319, 21658.458538536663, 21672.78327216739, 21699.132034718434, 7781.105172905189, 7827.373810095179, 7927.445078844541, 7931.0, 8132.430729848972, 4147.274227010261, 4266.466691663542, 4299.376590394438, 4328.567143285709, 4392.9896123891685, 3459.2562599041325, 3506.4915587239707, 3577.373959557067, 3582.802945837952, 3588.4796704478226, 568.8066057540456, 655.6688872119645, 665.8102440804445, 675.6081472745796, 689.055993289197, 588.3910152991718, 601.425638515217, 622.2191150106678, 693.3343989769777, 701.3442431326725, 8765.34259930495, 9350.392224505385, 9403.90596094044, 9726.36778609388, 9737.707868763948, 627.3694936588699, 660.4510445606761, 663.5587334422555, 677.3971165662466, 684.4421796236052, 3674.9710081177313, 4301.651846224851, 4690.5543973323165, 4761.762390249233, 4835.371401717754, 102363.46454803184, 106972.0, 107509.0, 108295.0, 111833.0, 92623.07376926279, 94365.0, 95618.5219073914, 95662.0, 96690.0, 63044.0, 81565.59217203876, 83472.16527834644, 84098.73851892227, 87590.56204718935, 7591.2043978011, 8085.070216925129, 9103.635854565744, 9224.389878350521, 9576.90423095788, 40023.799286021465, 42691.93270168271, 42938.1412371757, 43548.0, 43723.56276437195, 60543.69728151331, 61500.07749883845, 64014.0, 65056.69886602336, 73793.89309160474, 12335.75328493443, 12834.479032953512, 13217.339133043117, 13321.866781332063, 13567.321633918462, 14160.645983850487, 14534.93285871251, 14544.157568312017, 14726.35028958824, 15078.698426031198, 11708.47311870985, 12425.502979880703, 13404.061715679809, 13894.791578126538, 13975.231362275172, 12237.877621223673, 13678.794818077937, 13887.791683124558, 14105.365258563594, 14309.713805723619, 13206.009549284034, 13264.469421223042, 13624.978126640342, 13754.93122534381, 13961.022728408914, 10730.302530335503, 11234.662960111209, 11245.606403775828, 11306.773864522498, 11340.716482088013, 9075.364724469224, 11240.718982025515, 11331.263467874562, 11463.598774043203, 11534.192606517463], "value": 7446.775366812656, "unit": "score"}], "name": "dromaeo_css", "value": 7061.7860479330075, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 115.0, 114.0, 113.0, 114.0, 114.0, 114.0, 112.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 125.0, 139.0, 138.0, 141.0, 141.0, 146.0, 109.0, 131.0, 108.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 184.0, 185.0, 185.0, 182.0, 183.0, 179.0, 182.0, 184.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 58.0, 58.0, 86.0, 61.0, 58.0, 58.0, 58.0, 72.0, 58.0], "value": 64.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 85.0, 71.0, 68.0, 68.0, 84.0, 70.0, 68.0, 84.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 109.0, 110.0, 107.0, 111.0, 109.0, 112.0, 107.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 104.0, 149.0, 123.0, 93.0, 93.0, 94.0, 94.0, 98.0, 95.0], "value": 103.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 133.0, 115.0, 88.0, 89.0, 85.0, 87.0, 85.0, 85.0, 87.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 52.0, 54.0, 54.0, 54.0, 56.0, 57.0, 55.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 92.0, 113.0, 111.0, 80.0, 69.0, 69.0, 71.0, 71.0, 71.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 91.0, 86.0, 87.0, 86.0, 87.0, 86.0, 88.0, 88.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 139.0, 140.0, 137.0, 139.0, 142.0, 142.0, 206.0, 166.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 174.0, 169.0, 169.0, 169.0, 171.0, 170.0, 167.0, 169.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 65.0, 65.0, 68.0, 65.0, 82.0, 66.0, 66.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1488.7000000000003, "alertThreshold": 2.0}]} 22:08:32 INFO - Return code: 0 22:08:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:08:32 INFO - # TBPL SUCCESS # 22:08:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:08:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:08:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:08:32 INFO - 2016-12-17 22:08:32.612 screenresolution[1667:11062] starting screenresolution argv=screenresolution get 22:08:32 INFO - 2016-12-17 22:08:32.615 screenresolution[1667:11062] Display 0: 1600x1200x32@60 22:08:32 INFO - 2016-12-17 22:08:32.621 screenresolution[1668:11065] starting screenresolution argv=screenresolution list 22:08:32 INFO - Available Modes on Display 0 22:08:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:08:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:08:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:08:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:08:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:08:32 INFO - Intel Iris: 22:08:32 INFO - Chipset Model: Intel Iris 22:08:32 INFO - Type: GPU 22:08:32 INFO - Bus: Built-In 22:08:32 INFO - VRAM (Dynamic, Max): 1536 MB 22:08:32 INFO - Vendor: Intel (0x8086) 22:08:32 INFO - Device ID: 0x0a2e 22:08:32 INFO - Revision ID: 0x0009 22:08:32 INFO - Displays: 22:08:32 INFO - Display: 22:08:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:08:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:08:32 INFO - Display Serial Number: 1600x1200 60 22:08:32 INFO - Main Display: Yes 22:08:32 INFO - Mirror: Off 22:08:32 INFO - Online: Yes 22:08:32 INFO - Rotation: Supported 22:08:32 INFO - Return code: 0 22:08:32 INFO - Running post-action listener: _resource_record_post_action 22:08:32 INFO - [mozharness: 2016-12-18 06:08:32.857328Z] Finished run-tests step (success) 22:08:32 INFO - Running post-run listener: _resource_record_post_run 22:08:32 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 32377856; Write bytes: 551073792; Read time: 205; Write time: 1658 22:08:32 INFO - TinderboxPrint: CPU usage
54.1% 22:08:32 INFO - TinderboxPrint: I/O read bytes / time
32,377,856 / 205 22:08:32 INFO - TinderboxPrint: I/O write bytes / time
551,073,792 / 1,658 22:08:32 INFO - TinderboxPrint: CPU idle
2,211.6 (45.9%) 22:08:32 INFO - TinderboxPrint: CPU system
969.3 (20.1%) 22:08:32 INFO - TinderboxPrint: CPU user
1,632.8 (33.9%) 22:08:32 INFO - TinderboxPrint: Swap in / out
278,339,584 / 0 22:08:32 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247628288; Write bytes: 239980544; Read time: 18437; Write time: 496 22:08:32 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 29117440; Write bytes: 299493376; Read time: 179; Write time: 1126 22:08:33 INFO - Running post-run listener: _upload_blobber_files 22:08:33 INFO - Blob upload gear active. 22:08:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:08:33 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 22:08:33 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'] 22:08:33 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 22:08:33 INFO - (blobuploader) - INFO - Open directory for files ... 22:08:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:08:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:08:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:34 INFO - (blobuploader) - INFO - Done attempting. 22:08:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:08:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:08:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:35 INFO - (blobuploader) - INFO - Done attempting. 22:08:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:08:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:08:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:37 INFO - (blobuploader) - INFO - Done attempting. 22:08:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:08:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:08:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:39 INFO - (blobuploader) - INFO - Done attempting. 22:08:39 INFO - (blobuploader) - INFO - Iteration through files over. 22:08:39 INFO - Return code: 0 22:08:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:08:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:08:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5417340abb36d98948df5a23b1119f90c605def5e014b710aef4cb587d1599c4d3d8649954e1007744078cf7eab7e432ddc8a072ac8e6b0399365cc2cded150", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fce68276e75a11af294d0a1db649213e3a6c0841475e6e38b020fad718e4ebe397c451e5daa8c7cc7485523e54a1b391a982617faa2de7e8d9e28b65f4d6a005", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5236f0c3c7d02dce9e45c2100dd3f315ad16063ce6defa2a4ab050156dbf44b7a9c053e5ee5f3958b03f1577e2c9a9d010aa823f3c40599cf0585e7aac2a6d58", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/262d95da6ccf37c7f411ee59159de8088e5c4b410b66a3a5d7466b4dd066525b2055ae5b2a2f89201533243d18234e92d1b7d334c71dc97a9688d901b461a99e"} 22:08:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:08:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:08:39 INFO - Contents: 22:08:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5417340abb36d98948df5a23b1119f90c605def5e014b710aef4cb587d1599c4d3d8649954e1007744078cf7eab7e432ddc8a072ac8e6b0399365cc2cded150", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fce68276e75a11af294d0a1db649213e3a6c0841475e6e38b020fad718e4ebe397c451e5daa8c7cc7485523e54a1b391a982617faa2de7e8d9e28b65f4d6a005", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5236f0c3c7d02dce9e45c2100dd3f315ad16063ce6defa2a4ab050156dbf44b7a9c053e5ee5f3958b03f1577e2c9a9d010aa823f3c40599cf0585e7aac2a6d58", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/262d95da6ccf37c7f411ee59159de8088e5c4b410b66a3a5d7466b4dd066525b2055ae5b2a2f89201533243d18234e92d1b7d334c71dc97a9688d901b461a99e"} 22:08:39 INFO - Running post-run listener: copy_logs_to_upload_dir 22:08:39 INFO - Copying logs to upload dir... 22:08:39 INFO - mkdir: /builds/slave/test/build/upload/logs 22:08:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.079689 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-12-17 22:08:39.591899) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-17 22:08:39.595737) ========= 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.3xSyFIP5MP/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.pP7H9xmCIQ/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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/f5417340abb36d98948df5a23b1119f90c605def5e014b710aef4cb587d1599c4d3d8649954e1007744078cf7eab7e432ddc8a072ac8e6b0399365cc2cded150", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fce68276e75a11af294d0a1db649213e3a6c0841475e6e38b020fad718e4ebe397c451e5daa8c7cc7485523e54a1b391a982617faa2de7e8d9e28b65f4d6a005", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5236f0c3c7d02dce9e45c2100dd3f315ad16063ce6defa2a4ab050156dbf44b7a9c053e5ee5f3958b03f1577e2c9a9d010aa823f3c40599cf0585e7aac2a6d58", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/262d95da6ccf37c7f411ee59159de8088e5c4b410b66a3a5d7466b4dd066525b2055ae5b2a2f89201533243d18234e92d1b7d334c71dc97a9688d901b461a99e"} build_url:https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011140 build_url: 'https://queue.taskcluster.net/v1/task/MjrPUE4PQKqGx7Ftc9KkIA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5417340abb36d98948df5a23b1119f90c605def5e014b710aef4cb587d1599c4d3d8649954e1007744078cf7eab7e432ddc8a072ac8e6b0399365cc2cded150", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fce68276e75a11af294d0a1db649213e3a6c0841475e6e38b020fad718e4ebe397c451e5daa8c7cc7485523e54a1b391a982617faa2de7e8d9e28b65f4d6a005", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5236f0c3c7d02dce9e45c2100dd3f315ad16063ce6defa2a4ab050156dbf44b7a9c053e5ee5f3958b03f1577e2c9a9d010aa823f3c40599cf0585e7aac2a6d58", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/262d95da6ccf37c7f411ee59159de8088e5c4b410b66a3a5d7466b4dd066525b2055ae5b2a2f89201533243d18234e92d1b7d334c71dc97a9688d901b461a99e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-17 22:08:39.631266) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 22:08:39.631650) ========= 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.3xSyFIP5MP/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.pP7H9xmCIQ/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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.005079 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 22:08:39.680205) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-17 22:08:39.680538) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-17 22:08:39.680865) ========= ========= Total master_lag: 0.27 =========