builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0134 starttime: 1488845546.37 results: success (0) buildid: 20170306145427 builduid: 92a0c30f47af4f87bbda6c07b0c5f4df revision: b7e42143bbbc9dc3e5c05bd1e93b6485ce1d0ad4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-06 16:12:26.371084) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-06 16:12:26.371451) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-06 16:12:26.371717) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-06 16:12:26.517519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 16:12:26.517769) ========= 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.a4zvYjiwre/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.HpLxblpaLH/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 --2017-03-06 16:12:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.5M=0.001s 2017-03-06 16:12:27 (13.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.518581 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 16:12:27.062972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 16:12:27.063285) ========= 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.a4zvYjiwre/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.HpLxblpaLH/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.027490 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 16:12:27.112740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-06 16:12:27.113120) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b7e42143bbbc9dc3e5c05bd1e93b6485ce1d0ad4 --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 b7e42143bbbc9dc3e5c05bd1e93b6485ce1d0ad4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.a4zvYjiwre/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.HpLxblpaLH/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 2017-03-06 16:12:27,215 truncating revision to first 12 chars 2017-03-06 16:12:27,216 Setting DEBUG logging. 2017-03-06 16:12:27,216 attempt 1/10 2017-03-06 16:12:27,216 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b7e42143bbbc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-06 16:12:28,329 unpacking tar archive at: mozilla-central-b7e42143bbbc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.405523 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-06 16:12:28.542024) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-06 16:12:28.542326) ========= script_repo_revision: b7e42143bbbc9dc3e5c05bd1e93b6485ce1d0ad4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-06 16:12:28.542739) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-06 16:12:28.543017) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-06 16:12:28.563059) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-03-06 16:12:28.563475) ========= /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.a4zvYjiwre/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.HpLxblpaLH/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 16:12:28 INFO - MultiFileLogger online at 20170306 16:12:28 in /builds/slave/test 16:12:28 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 16:12:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:12:28 INFO - {'append_to_log': False, 16:12:28 INFO - 'base_work_dir': '/builds/slave/test', 16:12:28 INFO - 'blob_upload_branch': 'Firefox', 16:12:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:12:28 INFO - 'branch': 'Firefox', 16:12:28 INFO - 'buildbot_json_path': 'buildprops.json', 16:12:28 INFO - 'config_files': ('talos/mac_config.py',), 16:12:28 INFO - 'default_actions': ('clobber', 16:12:28 INFO - 'read-buildbot-config', 16:12:28 INFO - 'download-and-extract', 16:12:28 INFO - 'populate-webroot', 16:12:28 INFO - 'create-virtualenv', 16:12:28 INFO - 'install', 16:12:28 INFO - 'run-tests'), 16:12:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:12:28 INFO - 'download_minidump_stackwalk': True, 16:12:28 INFO - 'download_symbols': 'ondemand', 16:12:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:12:28 INFO - 'tooltool.py': '/tools/tooltool.py', 16:12:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:12:28 INFO - '/tools/misc-python/virtualenv.py')}, 16:12:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:12:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:12:28 INFO - 'gecko_profile': False, 16:12:28 INFO - 'gecko_profile_interval': 0, 16:12:28 INFO - 'installer_path': 'installer.exe', 16:12:28 INFO - 'log_level': 'info', 16:12:28 INFO - 'log_name': 'talos', 16:12:28 INFO - 'log_to_console': True, 16:12:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:12:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:12:28 INFO - 'opt_config_files': (), 16:12:28 INFO - 'pip_index': False, 16:12:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:12:28 INFO - 'cmd': ('bash', 16:12:28 INFO - '-c', 16:12:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:12:28 INFO - 'enabled': True, 16:12:28 INFO - 'halt_on_failure': False, 16:12:28 INFO - 'name': 'check_screen_resolution'},), 16:12:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:12:28 INFO - 'cmd': ('bash', 16:12:28 INFO - '-c', 16:12:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:12:28 INFO - 'enabled': True, 16:12:28 INFO - 'halt_on_failure': False, 16:12:28 INFO - 'name': 'check_screen_resolution'},), 16:12:28 INFO - 'run_cmd_checks_enabled': True, 16:12:28 INFO - 'suite': 'dromaeojs', 16:12:28 INFO - 'system_bits': '32', 16:12:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:12:28 INFO - 'title': 't-yosemite-r7-0134', 16:12:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:12:28 INFO - 'use_talos_json': True, 16:12:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:12:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:12:28 INFO - 'work_dir': 'build'} 16:12:28 INFO - [mozharness: 2017-03-07 00:12:28.782957Z] Running clobber step. 16:12:28 INFO - Running pre-action listener: _resource_record_pre_action 16:12:28 INFO - Running main action method: clobber 16:12:28 INFO - rmtree: /builds/slave/test/build 16:12:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:12:31 INFO - Running post-action listener: _resource_record_post_action 16:12:31 INFO - [mozharness: 2017-03-07 00:12:31.224379Z] Finished clobber step (success) 16:12:31 INFO - [mozharness: 2017-03-07 00:12:31.224512Z] Running read-buildbot-config step. 16:12:31 INFO - Running pre-action listener: _resource_record_pre_action 16:12:31 INFO - Running main action method: read_buildbot_config 16:12:31 INFO - Using buildbot properties: 16:12:31 INFO - { 16:12:31 INFO - "project": "", 16:12:31 INFO - "product": "firefox", 16:12:31 INFO - "script_repo_revision": "production", 16:12:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 16:12:31 INFO - "repository": "", 16:12:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 16:12:31 INFO - "buildid": "20170306145427", 16:12:31 INFO - "pgo_build": "False", 16:12:31 INFO - "basedir": "/builds/slave/test", 16:12:31 INFO - "buildnumber": 7, 16:12:31 INFO - "slavename": "t-yosemite-r7-0134", 16:12:31 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 16:12:31 INFO - "platform": "yosemite_r7", 16:12:31 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:12:31 INFO - "branch": "mozilla-central", 16:12:31 INFO - "repo_path": "mozilla-central", 16:12:31 INFO - "revision": "b7e42143bbbc9dc3e5c05bd1e93b6485ce1d0ad4", 16:12:31 INFO - "stage_platform": "macosx64", 16:12:31 INFO - "builduid": "92a0c30f47af4f87bbda6c07b0c5f4df", 16:12:31 INFO - "slavebuilddir": "test" 16:12:31 INFO - } 16:12:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 16:12:31 INFO - Running post-action listener: _resource_record_post_action 16:12:31 INFO - [mozharness: 2017-03-07 00:12:31.227872Z] Finished read-buildbot-config step (success) 16:12:31 INFO - [mozharness: 2017-03-07 00:12:31.227978Z] Running download-and-extract step. 16:12:31 INFO - Running pre-action listener: _resource_record_pre_action 16:12:31 INFO - Running main action method: download_and_extract 16:12:31 INFO - mkdir: /builds/slave/test/build/tests 16:12: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')]} 16:12:31 INFO - trying https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 16:12:31 INFO - Downloading https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:12:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 16:12:32 INFO - Downloaded 1199 bytes. 16:12:32 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:12:32 INFO - Using the following test package requirements: 16:12:32 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:12:32 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:12:32 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 16:12:32 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:12:32 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 16:12:32 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:12:32 INFO - u'jsshell-mac.zip'], 16:12:32 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:12:32 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 16:12:32 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:12:32 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:12:32 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 16:12:32 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:12:32 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 16:12:32 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:12:32 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 16:12:32 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:12:32 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 16:12:32 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:12:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:12:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:12:32 INFO - Fetch https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:12:33 INFO - Expected file size: 51781058 16:12:33 INFO - Obtained file size: 51781058 16:12:49 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:12:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:12:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:12:49 INFO - Fetch https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:12:51 INFO - Expected file size: 51781058 16:12:51 INFO - Obtained file size: 51781058 16:13:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 16:13:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:13:07 INFO - Fetch https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 16:13:07 INFO - Expected file size: 14404424 16:13:07 INFO - Obtained file size: 14404424 16:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:08 INFO - trying https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:13:08 INFO - Downloading https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 16:13:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 16:13:10 INFO - Downloaded 74952866 bytes. 16:13:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:13:10 INFO - mkdir: /builds/slave/test/properties 16:13:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:13:10 INFO - Writing to file /builds/slave/test/properties/build_url 16:13:10 INFO - Contents: 16:13:10 INFO - build_url:https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:13:10 INFO - Running post-action listener: _resource_record_post_action 16:13:10 INFO - Running post-action listener: set_extra_try_arguments 16:13:10 INFO - [mozharness: 2017-03-07 00:13:10.994141Z] Finished download-and-extract step (success) 16:13:10 INFO - [mozharness: 2017-03-07 00:13:10.994302Z] Running populate-webroot step. 16:13:10 INFO - Running pre-action listener: _resource_record_pre_action 16:13:10 INFO - Running main action method: populate_webroot 16:13:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:13:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:13:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:13:11 INFO - '--tppagecycles', 16:13:11 INFO - '7'], 16:13:11 INFO - 'tests': ['tsvgm']}}, 16:13:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:13:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:13:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:13:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:13:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:13:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:13:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:13:11 INFO - 'talos_options': ['--disable-e10s'], 16:13:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:13:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:13:11 INFO - 'talos_options': ['--disable-e10s'], 16:13:11 INFO - 'tests': ['damp', 'tps']}, 16:13:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:13:11 INFO - 'tests': ['damp', 'tps']}, 16:13:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:13:11 INFO - 'tests': ['dromaeo_dom']}, 16:13:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:13:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:13:11 INFO - 'tests': ['basic_compositor_video']}, 16:13:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:13:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:13:11 INFO - 'tests': ['a11yr', 16:13:11 INFO - 'ts_paint', 16:13:11 INFO - 'tpaint', 16:13:11 INFO - 'sessionrestore', 16:13:11 INFO - 'sessionrestore_no_auto_restore', 16:13:11 INFO - 'tabpaint']}, 16:13:11 INFO - 'other-e10s': {'tests': ['a11yr', 16:13:11 INFO - 'ts_paint', 16:13:11 INFO - 'tpaint', 16:13:11 INFO - 'sessionrestore', 16:13:11 INFO - 'sessionrestore_no_auto_restore', 16:13:11 INFO - 'tabpaint']}, 16:13:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:13:11 INFO - 'ts_paint', 16:13:11 INFO - 'tpaint', 16:13:11 INFO - 'sessionrestore', 16:13:11 INFO - 'sessionrestore_no_auto_restore', 16:13:11 INFO - 'tabpaint']}, 16:13:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:13:11 INFO - 'ts_paint', 16:13:11 INFO - 'tpaint', 16:13:11 INFO - 'sessionrestore', 16:13:11 INFO - 'sessionrestore_no_auto_restore', 16:13:11 INFO - 'tabpaint']}, 16:13:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:13:11 INFO - 'tests': ['a11yr', 16:13:11 INFO - 'ts_paint', 16:13:11 INFO - 'tpaint', 16:13:11 INFO - 'sessionrestore', 16:13:11 INFO - 'sessionrestore_no_auto_restore', 16:13:11 INFO - 'tabpaint']}, 16:13:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:13:11 INFO - 'tests': ['a11yr', 16:13:11 INFO - 'ts_paint', 16:13:11 INFO - 'tpaint', 16:13:11 INFO - 'sessionrestore', 16:13:11 INFO - 'sessionrestore_no_auto_restore', 16:13:11 INFO - 'tabpaint']}, 16:13:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:13:11 INFO - 'tests': ['tsvgx', 16:13:11 INFO - 'tsvgr_opacity', 16:13:11 INFO - 'tart', 16:13:11 INFO - 'tscrollx', 16:13:11 INFO - 'cart', 16:13:11 INFO - 'tsvg_static']}, 16:13:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:13:11 INFO - 'tsvgr_opacity', 16:13:11 INFO - 'tart', 16:13:11 INFO - 'tscrollx', 16:13:11 INFO - 'cart', 16:13:11 INFO - 'tsvg_static']}, 16:13:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:13:11 INFO - 'talos_options': ['--disable-e10s'], 16:13:11 INFO - 'tests': ['tp5o']}, 16:13:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:13:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:13:11 INFO - 'talos_options': ['--disable-e10s', 16:13:11 INFO - '--xperf_path', 16:13:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:11 INFO - 'tests': ['tp5n']}, 16:13:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:13:11 INFO - 'talos_options': ['--xperf_path', 16:13:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:11 INFO - 'tests': ['tp5n']}}, 16:13:11 INFO - 'talos.zip': {'path': '', 16:13:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:13:11 INFO - Running post-action listener: _resource_record_post_action 16:13:11 INFO - [mozharness: 2017-03-07 00:13:11.011367Z] Finished populate-webroot step (success) 16:13:11 INFO - [mozharness: 2017-03-07 00:13:11.011468Z] Running create-virtualenv step. 16:13:11 INFO - Running pre-action listener: _resource_record_pre_action 16:13:11 INFO - Running main action method: create_virtualenv 16:13:11 INFO - Creating virtualenv /builds/slave/test/build/venv 16:13:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:13:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:13:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:13:11 INFO - Using real prefix '/tools/python27' 16:13:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:13:11 INFO - Installing distribute.............................................................................................................................................................................................done. 16:13:14 INFO - Installing pip.................done. 16:13:14 INFO - Return code: 0 16:13:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:13:14 INFO - Reading from file tmpfile_stdout 16:13:14 INFO - Output received: 16:13:14 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) 16:13:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7e84659b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de2ed30>, '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 0x10dd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de23be8>, '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.a4zvYjiwre/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.HpLxblpaLH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 16:13:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:13:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4zvYjiwre/Render', 16:13:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:14 INFO - 'HOME': '/Users/cltbld', 16:13:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:14 INFO - 'LOGNAME': 'cltbld', 16:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:14 INFO - 'MOZ_NO_REMOTE': '1', 16:13:14 INFO - 'NO_EM_RESTART': '1', 16:13:14 INFO - 'PAGER': '/bin/cat', 16:13:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:14 INFO - 'PWD': '/builds/slave/test', 16:13:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:14 INFO - 'SHELL': '/bin/bash', 16:13:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpLxblpaLH/Listeners', 16:13:14 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 16:13:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:14 INFO - 'USER': 'cltbld', 16:13:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:14 INFO - 'XPC_FLAGS': '0x0', 16:13:14 INFO - 'XPC_SERVICE_NAME': '0', 16:13:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:13:15 INFO - Cleaning up... 16:13:15 INFO - Return code: 0 16:13:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:15 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 0x10e050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7e84659b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de2ed30>, '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 0x10dd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de23be8>, '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.a4zvYjiwre/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.HpLxblpaLH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 16:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:13:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4zvYjiwre/Render', 16:13:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:15 INFO - 'HOME': '/Users/cltbld', 16:13:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:15 INFO - 'LOGNAME': 'cltbld', 16:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:15 INFO - 'MOZ_NO_REMOTE': '1', 16:13:15 INFO - 'NO_EM_RESTART': '1', 16:13:15 INFO - 'PAGER': '/bin/cat', 16:13:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:15 INFO - 'PWD': '/builds/slave/test', 16:13:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:15 INFO - 'SHELL': '/bin/bash', 16:13:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpLxblpaLH/Listeners', 16:13:15 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 16:13:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:15 INFO - 'USER': 'cltbld', 16:13:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:15 INFO - 'XPC_FLAGS': '0x0', 16:13:15 INFO - 'XPC_SERVICE_NAME': '0', 16:13:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:15 INFO - Downloading/unpacking psutil>=3.1.1 16:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:13:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:13:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:13:19 INFO - Installing collected packages: psutil 16:13:19 INFO - Running setup.py install for psutil 16:13:19 INFO - building 'psutil._psutil_osx' extension 16:13:19 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 16:13:20 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 16:13:20 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 16:13:20 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 16:13:20 INFO - building 'psutil._psutil_posix' extension 16:13:20 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 16:13:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:13:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:13:20 INFO - ^ 16:13:20 INFO - 1 warning generated. 16:13:20 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 16:13:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:13:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:13:20 INFO - Successfully installed psutil 16:13:20 INFO - Cleaning up... 16:13:20 INFO - Return code: 0 16:13:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:20 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 0x10e050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7e84659b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de2ed30>, '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 0x10dd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de23be8>, '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.a4zvYjiwre/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.HpLxblpaLH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 16:13:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:13:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4zvYjiwre/Render', 16:13:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:20 INFO - 'HOME': '/Users/cltbld', 16:13:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:20 INFO - 'LOGNAME': 'cltbld', 16:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:20 INFO - 'MOZ_NO_REMOTE': '1', 16:13:20 INFO - 'NO_EM_RESTART': '1', 16:13:20 INFO - 'PAGER': '/bin/cat', 16:13:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:20 INFO - 'PWD': '/builds/slave/test', 16:13:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:20 INFO - 'SHELL': '/bin/bash', 16:13:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpLxblpaLH/Listeners', 16:13:20 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 16:13:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:20 INFO - 'USER': 'cltbld', 16:13:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:20 INFO - 'XPC_FLAGS': '0x0', 16:13:20 INFO - 'XPC_SERVICE_NAME': '0', 16:13:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:13:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:13:23 INFO - Installing collected packages: mozsystemmonitor 16:13:23 INFO - Running setup.py install for mozsystemmonitor 16:13:24 INFO - Successfully installed mozsystemmonitor 16:13:24 INFO - Cleaning up... 16:13:24 INFO - Return code: 0 16:13:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:24 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 0x10e050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7e84659b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de2ed30>, '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 0x10dd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de23be8>, '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.a4zvYjiwre/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.HpLxblpaLH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 16:13:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:13:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:13:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4zvYjiwre/Render', 16:13:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:24 INFO - 'HOME': '/Users/cltbld', 16:13:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:24 INFO - 'LOGNAME': 'cltbld', 16:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:24 INFO - 'MOZ_NO_REMOTE': '1', 16:13:24 INFO - 'NO_EM_RESTART': '1', 16:13:24 INFO - 'PAGER': '/bin/cat', 16:13:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:24 INFO - 'PWD': '/builds/slave/test', 16:13:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:24 INFO - 'SHELL': '/bin/bash', 16:13:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpLxblpaLH/Listeners', 16:13:24 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 16:13:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:24 INFO - 'USER': 'cltbld', 16:13:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:24 INFO - 'XPC_FLAGS': '0x0', 16:13:24 INFO - 'XPC_SERVICE_NAME': '0', 16:13:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:24 INFO - Downloading/unpacking jsonschema==2.5.1 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:13:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:27 INFO - Downloading functools32-3.2.3-2.tar.gz 16:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:13:27 INFO - warning: no files found matching '*.txt' 16:13:27 INFO - no previously-included directories found matching 'build' 16:13:27 INFO - no previously-included directories found matching 'dist' 16:13:27 INFO - no previously-included directories found matching '.git*' 16:13:27 INFO - Installing collected packages: jsonschema, functools32 16:13:27 INFO - Running setup.py install for functools32 16:13:27 INFO - warning: no files found matching '*.txt' 16:13:27 INFO - no previously-included directories found matching 'build' 16:13:27 INFO - no previously-included directories found matching 'dist' 16:13:27 INFO - no previously-included directories found matching '.git*' 16:13:27 INFO - Successfully installed jsonschema functools32 16:13:27 INFO - Cleaning up... 16:13:27 INFO - Return code: 0 16:13:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:13: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')]} 16:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13: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')]} 16:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7e84659b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de2ed30>, '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 0x10dd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de23be8>, '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.a4zvYjiwre/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.HpLxblpaLH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 16:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:13:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4zvYjiwre/Render', 16:13:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:27 INFO - 'HOME': '/Users/cltbld', 16:13:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:27 INFO - 'LOGNAME': 'cltbld', 16:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:27 INFO - 'MOZ_NO_REMOTE': '1', 16:13:27 INFO - 'NO_EM_RESTART': '1', 16:13:27 INFO - 'PAGER': '/bin/cat', 16:13:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:27 INFO - 'PWD': '/builds/slave/test', 16:13:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:27 INFO - 'SHELL': '/bin/bash', 16:13:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpLxblpaLH/Listeners', 16:13:27 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 16:13:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:27 INFO - 'USER': 'cltbld', 16:13:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:27 INFO - 'XPC_FLAGS': '0x0', 16:13:27 INFO - 'XPC_SERVICE_NAME': '0', 16:13:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:13:28 INFO - Cleaning up... 16:13:28 INFO - Return code: 0 16:13:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:13: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')]} 16:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13: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')]} 16:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13: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', '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 0x10e050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7e84659b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de2ed30>, '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 0x10dd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de23be8>, '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.a4zvYjiwre/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.HpLxblpaLH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 16:13: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:13: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 blobuploader==1.2.4 16:13:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4zvYjiwre/Render', 16:13:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:28 INFO - 'HOME': '/Users/cltbld', 16:13:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:28 INFO - 'LOGNAME': 'cltbld', 16:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:28 INFO - 'MOZ_NO_REMOTE': '1', 16:13:28 INFO - 'NO_EM_RESTART': '1', 16:13:28 INFO - 'PAGER': '/bin/cat', 16:13:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:28 INFO - 'PWD': '/builds/slave/test', 16:13:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:28 INFO - 'SHELL': '/bin/bash', 16:13:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpLxblpaLH/Listeners', 16:13:28 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 16:13:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:28 INFO - 'USER': 'cltbld', 16:13:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:28 INFO - 'XPC_FLAGS': '0x0', 16:13:28 INFO - 'XPC_SERVICE_NAME': '0', 16:13:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:28 INFO - Downloading/unpacking blobuploader==1.2.4 16:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:30 INFO - Downloading blobuploader-1.2.4.tar.gz 16:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:13:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:13:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:32 INFO - Downloading docopt-0.6.1.tar.gz 16:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:13:32 INFO - Installing collected packages: blobuploader, requests, docopt 16:13:32 INFO - Running setup.py install for blobuploader 16:13:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:13:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:13:32 INFO - Running setup.py install for requests 16:13:32 INFO - Running setup.py install for docopt 16:13:32 INFO - Successfully installed blobuploader requests docopt 16:13:32 INFO - Cleaning up... 16:13:33 INFO - Return code: 0 16:13:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:33 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 0x10e050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7e84659b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de2ed30>, '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 0x10dd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de23be8>, '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.a4zvYjiwre/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.HpLxblpaLH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 16:13:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:13:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4zvYjiwre/Render', 16:13:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:33 INFO - 'HOME': '/Users/cltbld', 16:13:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:33 INFO - 'LOGNAME': 'cltbld', 16:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:33 INFO - 'MOZ_NO_REMOTE': '1', 16:13:33 INFO - 'NO_EM_RESTART': '1', 16:13:33 INFO - 'PAGER': '/bin/cat', 16:13:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:33 INFO - 'PWD': '/builds/slave/test', 16:13:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:33 INFO - 'SHELL': '/bin/bash', 16:13:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpLxblpaLH/Listeners', 16:13:33 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 16:13:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:33 INFO - 'USER': 'cltbld', 16:13:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:33 INFO - 'XPC_FLAGS': '0x0', 16:13:33 INFO - 'XPC_SERVICE_NAME': '0', 16:13:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:33 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-45N8LQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:33 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-MSxajY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:33 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-ot3THq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:33 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-zhChkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:33 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-LHBRMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:33 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-SUoswR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:33 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-5VGynr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:34 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-_Yhkfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:34 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-WOtZsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:34 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-XoCwvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:34 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-50IwV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:34 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-aXL47d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:34 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-MorGrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:34 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-kPRzk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:34 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-7pw4Ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:34 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-K4F7j9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:35 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Vzlair-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:13:35 INFO - Running setup.py install for manifestparser 16:13:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:13:35 INFO - Running setup.py install for mozcrash 16:13:35 INFO - Running setup.py install for mozdebug 16:13:35 INFO - Running setup.py install for mozdevice 16:13:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:13:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:13:35 INFO - Running setup.py install for mozfile 16:13:35 INFO - Running setup.py install for mozhttpd 16:13:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:13:35 INFO - Running setup.py install for mozinfo 16:13:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:13:36 INFO - Running setup.py install for mozInstall 16:13:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:13:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:13:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:13:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:13:36 INFO - Running setup.py install for mozleak 16:13:36 INFO - Running setup.py install for mozlog 16:13:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:13:36 INFO - Running setup.py install for moznetwork 16:13:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:13:36 INFO - Running setup.py install for mozprocess 16:13:36 INFO - Running setup.py install for mozprofile 16:13:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:13:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:13:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:13:37 INFO - Running setup.py install for mozrunner 16:13:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:13:37 INFO - Running setup.py install for mozscreenshot 16:13:37 INFO - Running setup.py install for moztest 16:13:37 INFO - Running setup.py install for mozversion 16:13:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:13:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:13:37 INFO - Cleaning up... 16:13:37 INFO - Return code: 0 16:13:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:37 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')]} 16:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:37 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')]} 16:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:37 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 0x10e050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7e84659b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de2ed30>, '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 0x10dd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de23be8>, '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.a4zvYjiwre/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.HpLxblpaLH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 16:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:13:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4zvYjiwre/Render', 16:13:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:37 INFO - 'HOME': '/Users/cltbld', 16:13:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:37 INFO - 'LOGNAME': 'cltbld', 16:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:37 INFO - 'MOZ_NO_REMOTE': '1', 16:13:37 INFO - 'NO_EM_RESTART': '1', 16:13:37 INFO - 'PAGER': '/bin/cat', 16:13:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:37 INFO - 'PWD': '/builds/slave/test', 16:13:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:37 INFO - 'SHELL': '/bin/bash', 16:13:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpLxblpaLH/Listeners', 16:13:37 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 16:13:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:37 INFO - 'USER': 'cltbld', 16:13:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:37 INFO - 'XPC_FLAGS': '0x0', 16:13:37 INFO - 'XPC_SERVICE_NAME': '0', 16:13:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:37 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-jHI_UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:38 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-voszpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:38 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)) 16:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:38 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-h7a8st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:38 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-USuX9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:38 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)) 16:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:38 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-OFfpTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:38 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-_2Pxml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:38 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-DMk5kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:38 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-qjOwV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:38 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-BOm9ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:38 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-DzLrLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:39 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)) 16:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:39 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-jH1v2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:39 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-IKVO0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:39 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-qLYhFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:39 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-g9ulkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:39 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)) 16:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:39 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-hTDia4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:39 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-yEHhAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:39 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-VqhDRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:13:39 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)) 16:13:39 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)) 16:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:13:39 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)) 16:13:39 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)) 16:13:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:42 INFO - Downloading blessings-1.6.tar.gz 16:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:13:42 INFO - Installing collected packages: blessings 16:13:42 INFO - Running setup.py install for blessings 16:13:42 INFO - Successfully installed blessings 16:13:42 INFO - Cleaning up... 16:13:42 INFO - Return code: 0 16:13:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:13:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:43 INFO - Reading from file tmpfile_stdout 16:13:43 INFO - Current package versions: 16:13:43 INFO - blessings == 1.6 16:13:43 INFO - blobuploader == 1.2.4 16:13:43 INFO - docopt == 0.6.1 16:13:43 INFO - functools32 == 3.2.3-2 16:13:43 INFO - jsonschema == 2.5.1 16:13:43 INFO - manifestparser == 1.1 16:13:43 INFO - mozInstall == 1.12 16:13:43 INFO - mozcrash == 1.0 16:13:43 INFO - mozdebug == 0.1 16:13:43 INFO - mozdevice == 0.49 16:13:43 INFO - mozfile == 1.2 16:13:43 INFO - mozhttpd == 0.7 16:13:43 INFO - mozinfo == 0.9 16:13:43 INFO - mozleak == 0.1 16:13:43 INFO - mozlog == 3.4 16:13:43 INFO - moznetwork == 0.27 16:13:43 INFO - mozprocess == 0.25 16:13:43 INFO - mozprofile == 0.28 16:13:43 INFO - mozrunner == 6.13 16:13:43 INFO - mozscreenshot == 0.1 16:13:43 INFO - mozsystemmonitor == 0.3 16:13:43 INFO - moztest == 0.8 16:13:43 INFO - mozversion == 1.4 16:13:43 INFO - psutil == 3.1.1 16:13:43 INFO - requests == 1.2.3 16:13:43 INFO - wsgiref == 0.1.2 16:13:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:43 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 0x10e050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7e84659b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de2ed30>, '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 0x10dd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de23be8>, '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.a4zvYjiwre/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.HpLxblpaLH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 16:13:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:13:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4zvYjiwre/Render', 16:13:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:43 INFO - 'HOME': '/Users/cltbld', 16:13:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:43 INFO - 'LOGNAME': 'cltbld', 16:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:43 INFO - 'MOZ_NO_REMOTE': '1', 16:13:43 INFO - 'NO_EM_RESTART': '1', 16:13:43 INFO - 'PAGER': '/bin/cat', 16:13:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:43 INFO - 'PWD': '/builds/slave/test', 16:13:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:43 INFO - 'SHELL': '/bin/bash', 16:13:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpLxblpaLH/Listeners', 16:13:43 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 16:13:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:43 INFO - 'USER': 'cltbld', 16:13:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:43 INFO - 'XPC_FLAGS': '0x0', 16:13:43 INFO - 'XPC_SERVICE_NAME': '0', 16:13:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:13:43 INFO - Cleaning up... 16:13:43 INFO - Return code: 0 16:13:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:43 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 0x10e050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7e84659b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de2ed30>, '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 0x10dd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de23be8>, '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.a4zvYjiwre/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.HpLxblpaLH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 16:13:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:13:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4zvYjiwre/Render', 16:13:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:43 INFO - 'HOME': '/Users/cltbld', 16:13:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:43 INFO - 'LOGNAME': 'cltbld', 16:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:43 INFO - 'MOZ_NO_REMOTE': '1', 16:13:43 INFO - 'NO_EM_RESTART': '1', 16:13:43 INFO - 'PAGER': '/bin/cat', 16:13:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:43 INFO - 'PWD': '/builds/slave/test', 16:13:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:43 INFO - 'SHELL': '/bin/bash', 16:13:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpLxblpaLH/Listeners', 16:13:43 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 16:13:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:43 INFO - 'USER': 'cltbld', 16:13:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:43 INFO - 'XPC_FLAGS': '0x0', 16:13:43 INFO - 'XPC_SERVICE_NAME': '0', 16:13:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:13:43 INFO - Cleaning up... 16:13:43 INFO - Return code: 0 16:13:43 INFO - Running post-action listener: _resource_record_post_action 16:13:43 INFO - Running post-action listener: _start_resource_monitoring 16:13:43 INFO - Starting resource monitoring. 16:13:43 INFO - [mozharness: 2017-03-07 00:13:43.675724Z] Finished create-virtualenv step (success) 16:13:43 INFO - [mozharness: 2017-03-07 00:13:43.676711Z] Running install step. 16:13:43 INFO - Running pre-action listener: _resource_record_pre_action 16:13:43 INFO - Running main action method: install 16:13:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:43 INFO - Reading from file tmpfile_stdout 16:13:43 INFO - Detecting whether we're running mozinstall >=1.0... 16:13:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:13:44 INFO - Reading from file tmpfile_stdout 16:13:44 INFO - Output received: 16:13:44 INFO - Usage: mozinstall [options] installer 16:13:44 INFO - Options: 16:13:44 INFO - -h, --help show this help message and exit 16:13:44 INFO - -d DEST, --destination=DEST 16:13:44 INFO - Directory to install application into. [default: 16:13:44 INFO - "/builds/slave/test"] 16:13:44 INFO - --app=APP Application being installed. [default: firefox] 16:13:44 INFO - mkdir: /builds/slave/test/build/application 16:13:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:13:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:14:04 INFO - Reading from file tmpfile_stdout 16:14:04 INFO - Output received: 16:14:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:14:04 INFO - Running post-action listener: _resource_record_post_action 16:14:04 INFO - [mozharness: 2017-03-07 00:14:04.167195Z] Finished install step (success) 16:14:04 INFO - [mozharness: 2017-03-07 00:14:04.167347Z] Running run-tests step. 16:14:04 INFO - Running pre-action listener: _resource_record_pre_action 16:14:04 INFO - Running main action method: run_tests 16:14:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:14:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:14:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:14:04 INFO - 2017-03-06 16:14:04.181 screenresolution[1626:8235] starting screenresolution argv=screenresolution get 16:14:04 INFO - 2017-03-06 16:14:04.184 screenresolution[1626:8235] Display 0: 1600x1200x32@60 16:14:04 INFO - 2017-03-06 16:14:04.190 screenresolution[1627:8238] starting screenresolution argv=screenresolution list 16:14:04 INFO - Available Modes on Display 0 16:14:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:14:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:14:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:14:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:14:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:14:04 INFO - Intel Iris: 16:14:04 INFO - Chipset Model: Intel Iris 16:14:04 INFO - Type: GPU 16:14:04 INFO - Bus: Built-In 16:14:04 INFO - VRAM (Dynamic, Max): 1536 MB 16:14:04 INFO - Vendor: Intel (0x8086) 16:14:04 INFO - Device ID: 0x0a2e 16:14:04 INFO - Revision ID: 0x0009 16:14:04 INFO - Displays: 16:14:04 INFO - Display: 16:14:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:14:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:14:04 INFO - Display Serial Number: 1600x1200 60 16:14:04 INFO - Main Display: Yes 16:14:04 INFO - Mirror: Off 16:14:04 INFO - Online: Yes 16:14:04 INFO - Rotation: Supported 16:14:04 INFO - Return code: 0 16:14:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:14:04 INFO - Python 2.7.3 16:14:04 INFO - Return code: 0 16:14:04 INFO - grabbing minidump binary from tooltool 16:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:04 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 0x10de2ed30>, '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 0x10dd55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de23be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:14:04 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 16:14:04 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 16:14:04 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 16:14:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:14:04 INFO - Return code: 0 16:14:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:14:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:14:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:14:04 INFO - ENV: RUST_BACKTRACE is now 1 16:14:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:14:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:14:04 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/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:14:04 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/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0134 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:14:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4zvYjiwre/Render', 16:14:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:04 INFO - 'HOME': '/Users/cltbld', 16:14:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:04 INFO - 'LOGNAME': 'cltbld', 16:14:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:14:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:04 INFO - 'MOZ_NO_REMOTE': '1', 16:14:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:14:04 INFO - 'NO_EM_RESTART': '1', 16:14:04 INFO - 'PAGER': '/bin/cat', 16:14:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:04 INFO - 'PWD': '/builds/slave/test', 16:14:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:14:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:04 INFO - 'RUST_BACKTRACE': '1', 16:14:04 INFO - 'SHELL': '/bin/bash', 16:14:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HpLxblpaLH/Listeners', 16:14:04 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 16:14:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:04 INFO - 'USER': 'cltbld', 16:14:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:04 INFO - 'XPC_FLAGS': '0x0', 16:14:04 INFO - 'XPC_SERVICE_NAME': '0', 16:14:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:04 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/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:14:04 INFO - mozversion application_buildid: 20170306145427 16:14:04 INFO - mozversion application_changeset: b7e42143bbbc9dc3e5c05bd1e93b6485ce1d0ad4 16:14:04 INFO - mozversion application_display_name: Nightly 16:14:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:14:04 INFO - mozversion application_name: Firefox 16:14:04 INFO - mozversion application_remotingname: firefox 16:14:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:14:04 INFO - mozversion application_vendor: Mozilla 16:14:04 INFO - mozversion application_version: 55.0a1 16:14:04 INFO - mozversion platform_buildid: 20170306145427 16:14:04 INFO - mozversion platform_changeset: b7e42143bbbc9dc3e5c05bd1e93b6485ce1d0ad4 16:14:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:14:04 INFO - mozversion platform_version: 55.0a1 16:14:04 INFO - using testdate: 1488845644 16:14:04 INFO - actual date: 1488845644 16:14:04 INFO - starting webserver on 'localhost:49236' 16:14:04 INFO - SUITE-START | Running 2 tests 16:14:04 INFO - TEST-START | dromaeo_css 16:14:04 INFO - operating with platform_type : mac_ 16:14:04 INFO - Initialising browser for dromaeo_css test... 16:14:04 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmp7mkOsU/profile http://localhost:49236/getInfo.html) 16:14:07 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 16:14:07 INFO - PROCESS | 1637 | colorDepth:24 16:14:07 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 16:14:07 INFO - PROCESS | 1637 | __metrics 16:14:07 INFO - PROCESS | 1637 | 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" 16:14:07 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:14:08 INFO - TEST-INFO | 1637: exit 0 16:14:08 INFO - Browser initialized. 16:14:08 INFO - Running cycle 1/1 for dromaeo_css test... 16:14:08 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmp7mkOsU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:20 INFO - PROCESS | 1640 | RSS: Main: 255082496 16:14:20 INFO - PROCESS | 1640 | 16:17:24 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 16:17:27 INFO - PROCESS | 1640 | RSS: Main: 479936512 16:17:27 INFO - PROCESS | 1640 | 16:19:10 INFO - PROCESS | 1640 | ************************* 16:19:10 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 16:19:10 INFO - PROCESS | 1640 | 16:19:10 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:19:10 INFO - PROCESS | 1640 | Full stack: 16:19:10 INFO - PROCESS | 1640 | ************************* 16:20:30 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 16:20:31 INFO - PROCESS | 1640 | RSS: Main: 379707392 16:20:31 INFO - PROCESS | 1640 | 16:23:33 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 16:23:34 INFO - PROCESS | 1640 | RSS: Main: 353959936 16:23:34 INFO - PROCESS | 1640 | 16:26:36 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 16:26:37 INFO - PROCESS | 1640 | RSS: Main: 365277184 16:26:37 INFO - PROCESS | 1640 | 16:29:41 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 16:29:42 INFO - PROCESS | 1640 | RSS: Main: 360206336 16:29:42 INFO - PROCESS | 1640 | 16:32:45 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 16:32:45 INFO - PROCESS | 1640 | RSS: Main: 561627136 16:32:45 INFO - PROCESS | 1640 | 16:32:45 INFO - PROCESS | 1640 | __start_tp_report 16:32:45 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 16:32:45 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 16:32:45 INFO - PROCESS | 1640 | |i|pagename|runs| 16:32:45 INFO - PROCESS | 1640 | |0;dojo.html;3334.399808034556;3336.0825772912444;3337.532745415641;3352.3127758809446;3395.9320813583727;5561.249231353766;5643.4074422185695;5709;5714.514266287365;5730.369659337474;5680.517156041731;5705.686187259699;5754.74103665335;5800.680962547058;5802.187693722883;5090;5147.073526765181;5191.922121168176;5194.610404219679;5195.220716892459;5240.502152295545;5250.894982100355;5254.605904557155;5288.841334759944;5331.413544510101;5081.339425874631;5160.767765450526;5200.635955483118;5206.505381988705;5209.557187639055;5216.895662086737;5242.947570524284;5247.396549396792;5264.052470555299;5309.4955979182305;5158.200478925773;5177.19753438214;5183.533481986601;5209.270702101709;5234.607404444682;5551.333839939192;5592.384837667853;5663.971680141614;5701.25883635129;5721.227634269362;6182.010878259457;6184.010558310693;6194.194754681863;6204.193454850841;6208.037754148114;6195.659238741868;6218.720157592919;6287.245530536365;6287.276963149205;6289.842753931189;5808.680522571257;5816.563757718188;5853.326867410217;5893.410658934115;5897.49871260939;5350.250964864922;6355.682215889187;6356.491480681534;6381.234251889803;6399.616023038632;6032.517398608101;6118.969405152946;6126.663033533109;6199.845003874849;6238.220222472191;5090.898182036339;6115.483736156635;6188.44304012641;6191.25704915413;6247.156633854372;6276.403741644536;6291.1192433059405;6297.716602752887;6298.464630506458;6312.400321969406;6333.556651034475;6342.04869269604;6345.016522439029;6351.936480635227;6357.586756860882;4917;5014.84955451337;5015.3229314042865;5015.673981191211;5065.468125846806;4419.9779001105435;4440.888977775581;4442.555744425532;4443.266860967904;4483.058557702919;5693.572982026281;5696.51579615729;5710.914336284959;5712.228849105318;5717.371089180187;5594.769150786902;5837.241158649348;6231.844203894848;6241.656708881055;6251.218597675291;5555.805546805843;5713.342965559014;5714.085746280658;5715.199872017921;5733.140028995684;5377.300950876361;5420.403755586883;5422.295101636841;5446.1558458439;5455.781768729206;6199.411055949768;6350.079238510482;6372.458341041063;6403;6404.7117879695525;6372.776952806815;6392.456641185366;6402.10370548133;6411.96794016027;6421.7110230038825;6367.840803979938;6382.5532212744665;6386.9361306386345;6390.48876089921;6393.2647745508;6033.849153771191;6100.938990610037;6111.287884814121;6126.945200426759;6283.3402492737605;6214.067889816563;6220.471259942956;6233.563650544418;6235.844103897258;6249.96875015622;5686.914696279477;5917.497012753792;5926.585139040226;5964.373740757332;6125.47933425646;4979.551840334388;5112.437631860418;6115.357887421935;6122.112293717475;6146.293176284606;4946.35697359341;5966.075258334965;5991.161237426851;5996.490298324691;6009.549283803644;5899.734511946886;5965.403459654;6021.488173505301;6030.849228769316;6031.155638210566;5759.884802304015;5809.767609295581;5850.12248162779;5859.707014649336;5860.882782344244 16:32:45 INFO - PROCESS | 1640 | |1;ext.html;639.5874660843756;779.9571023593702;850.4897061762942;864.4510735682843;867.535868310454;27246.86376568117;28475.85762071192;28490.145295641138;28540.001099961504;38248.61751382485;39412.80293598528;39774.8067557973;39873.40189897154;39963.00092497689;39989.80030599079;8765.34259930503;8958.955205223965;8959.37284390093;8965.551722413886;8980.910190898072;6702.966485167567;7232.493725439222;8939.597718102701;9084.409513381643;9085.727428177166;7392.7042918283205;7415.851682966364;7424.517406368595;10478.790424191511;10686.038256556909;10624.415657138854;10634.680959571186;10663.200259980455;10668.30656007357;10685.893141068567;10522.47387630623;10591.993760592732;10596.258261921668;10600.522976466078;10606.363618182933;27040.05359812397;27283.727162728515;28349.291267718265;37612;37929.431058534145;2997.925051873721;3689.1883785567134;3707.7775333480076;3746.606606306326;3767.7362584619086;21755.564888702138;26970.865145674146;27331.316717082034;27354.316142096406;28023.579646305323;3034.4689679306034;3048.679888611708;3075.3541756230993;3134.106779567835;3143.4341818472667;338833;344304;344429;344471.2776436102;345376;40608.79695601503;50448.243276350884;50459.74770126199;50533.74733126311;50704;42782.14435711268;43425.565744342784;45770.31344529835;52339.73830130825;54795.726021369635;13834.792478112837;13875.861241387456;13986.580402587939;14204.928975355057;14238.786418203736;12040.036797056215;12068.517259309529;12071.973882219934;12075;12084.093692973061;12701.87298127007;12706.428210730539;12722.936385318015;12760.617181484384;12867.678308042374;5820.912686309709;5835.328937172279;5858.355580886099;5875;5882.970585147047;905.3210092430677;933.8140561486873;1002.4486532407293;1003.3929472669076;1018.1040684197859;23361;24837.751622483906;25105.24684259475;27048;27062.729372706413;907.2877790934085;1055.4617145255975;1080.6487891435158;1081.9891801082047;1106.9335839849634;11851.170418070653;13388.93305533466;13724.862751372559;14061.086029408056;14086.943479239098;476994;478504;479188.6040569775;479585.6020719874;480143;53562.98277629194;53601.65995850135;53751.73124134354;53767.462325377026;53873;1370.3353873371407;1406.859314068585;1415.5894790510636;1417.6810217700934;1418.8864890808711;25379.6193057108;26531.86734066317;26545;26682.19953401401;26718.320419895026;45922.77038614786;45964;46100.7694961523;46164.845878853295;46174;440270;441069;441249;441582;441845;27522.17433476999;27968.825767233127;27990;33652.831735841166;35506;42135.15729685451;43054;45182.54817451915;45286.547134528235;45450;34089.931906128564;35432;36243.81878090592;36635.81682091572;37602.811985939894;35769.1057723559;35947.82026089853;36944.81527592345;37088;37715;36040.63959360373;36855.81572092122;37157.628423716495;37162.814185928895;37193.81403093076;31212.843935780176;32169.517457238628;32783.67216327806;32877.50683739794;32951.67048329582;24398.634020489353;24399.878000609882;24689.382765431008;25200.951771575055;25443 16:32:45 INFO - PROCESS | 1640 | |2;jquery.html;378.4417983474374;393.9310620641388;395.2371922190175;405.7139716499868;424.5627004185688;13445.126066805664;17234.48296551104;20169;21969.121235150575;22154.22460213893;21913.671294930587;22017.33947981559;22446.32661020172;22595.209167679135;22725.54548909025;6507.414332710079;6655.700493477805;6703.9329606703795;6813.523053386265;6883.105196324471;6669.633170175638;6698.062271282024;6723.798286051427;6729.7308107675635;6744.898826517606;6469.4500967417825;6677.432418244455;6721.361470660304;6725.865482690343;6746.932530674704;6463.83840403989;6578.506612004071;6640.833979150511;6714.731410743564;6737.494687898403;6485.6704375602885;6486.67566621667;6501.187351581052;6502.057201705727;6514.088027676129;26175.083872064577;26587.867060664765;26600.6699665016;26607.73392266072;26928.46143077147;2887.9278018049718;2906.3315437449505;2906.956395654067;2915.7521610662907;2918;15739.213039347987;16229.350825966947;16287.674246515122;16708.08105554194;16889.49331520044;1938.4378530226218;1948.4544327588299;1982.2764690887866;2003.1486618187357;2014.4661664658877;121937;124468.37765811113;125203.37398313041;125736;128113;13493.949324153475;19806.405807825788;20622.431943375206;20911.47721306949;21047;30501.389972200875;32527.34945301128;32557.02328930136;33957.830210848784;34133.58664133567;8762.474251544927;8768.824623507495;10418;10663.093637040784;10684.25210235276;6800.387965083166;8679.956600216958;8713.390062695677;8801;8812.691555795645;10549.314294570828;10633.5214915329;10705.1435885129;10773;10831.458427078614;3463.5843698755807;3624;3827.6363745444137;4075;4084.8366065357054;890.8084761776249;990.7417579673773;1021.2085633633993;1028.9897101029044;1076.0638244726981;17385.82614173842;21527.56944861125;22047.22834700778;22394.776052239595;22482.550348993256;911.9908800912038;980.0836218136066;1023.3961962442195;1054.7204990677476;1059.9099076578423;11098.944505277583;11239;11405.600803971822;11490.54037838477;11508.654740357802;364196;695734;708092;711702;715226;115921.5223543295;117870.8212917877;119123;124726;132781;1204.1691233049169;1232.1375037473804;1260.4580030586935;1263.33674820718;1267.448659832994;18498.722519162493;18963.43109706711;19192.94438805879;19213.807861921203;19304.420867374;57233.71383143058;57318.713406432704;57642.7117864408;58203.70898145652;58475.415245847;73447.26552734405;79312;80982.59508702655;84370.57814710887;87238.127618723;11245.152092202366;11949.820752688544;12126.454309556268;12127.272363658209;12177.452014659184;12927.353632318534;13524.18854868711;13530.932345338604;13992.790108148589;14002.789958150432;11488.655340339803;11543.711407214887;11813.054955603702;11820.468078936641;11997.700057498632;5890.14592884038;9573.760655983657;11538.711532211762;11775.116866235237;11947.76104477923;11673.708157296136;11685.941570292094;11989.22070065443;12038.518459261531;12075.637730868088;11537.826932596186;11617.145276580974;11678.24091434054;11807;11874.76250475003;11408.657740267805;11629.59296424621;11771.117166212398;11792.938635522843;11827.881721182677 16:32:45 INFO - PROCESS | 1640 | |3;mootools.html;1310.4103153580886;1359.9999999999998;1522.9314680839361;1542.6760380320125;1561.72669782788;9609.519524023806;10175.592976280948;10686.305390149635;10730.409827459505;10745.301555398893;10113.595456181762;10510.99999999998;10611.363318200913;10615.734606634818;10617.203709721764;2308.0190918859457;2352.3413444235557;2353.4351755578623;2355.882205889707;2355.9175428859994;2283.4405570635217;2317.884105794712;2320.187934223017;2321.3268152235833;2323.186884590397;2282.9657555136687;2298.7586303438147;2300.8734519601417;2305.3199306204624;2308.284431826131;2250.932472025842;2268.206127855254;2272.0230300970575;2275.3628983884537;2276.863388196697;2230.60964331243;2286.371247906822;2299.5171014087064;2300.769923007703;2309.711286089239;9149.764781754444;10552.208584356127;10633.893661063368;10640.46797660114;10644.840327395095;5267.631265811395;5432.2123292122815;5442.319710036246;5445.564354851603;5455.345358556999;3198.584184056081;3220.243242837931;3476.7566270361085;3486.686198242145;3488.5988111367265;1052.6421016854306;1163.906887449002;1173.1846366775094;1177.0587390919163;1219.1405059433166;13026.739465210738;13418.396172172275;13684.110532815335;13880.861191388058;14414.279286035657;4115.8765237042935;4233.597808208277;4239.342901850218;4239.766812825263;4415.580519850609;10950.671479855617;10952.890471095347;10960.397178155119;10970.232083754061;10984.231103822816;4661.790219440133;5472.890542189213;5497.175423686479;5498.285222921075;5498.835034948958;4828.444728856227;5055.848324550269;5128.3333166688835;5135.589152867761;5147.0735267651435;3507.719382449398;3585.175409655794;3675.3751862183494;3724.5530536335814;3761.5486141663177;855.2815634866618;1009.4750729620556;1017.018577073128;1022.9693109206736;1029.4286670897723;784.4704824243613;787.6809891993752;800.5676934455445;811.7240138352988;811.7767613906105;5552.472515111058;5623.409541998113;5680.715964201773;5698.917205730898;5736.397678243808;925.2551695884742;943.3820847345;944.3436811416137;968.6125549780004;987.9012098790064;3125.312431265118;3805.7441044455263;4060.7360521566593;4063.654589359878;4114.115465175002;11249;11771.234869733611;12825.038122140877;12969.41637626309;12998.155119917175;12245.265284082805;12862.807057894139;12887.613371598867;12913.548025819051;12927.095103342865;9527.761805954768;9818.901810981799;9819;9826.361286516354;9872.60509579623;5290.365156181283;6242.65782856688;6457.7094030767785;6591.110200122922;6642.535022548375;11988.100892432927;11995.280283183038;12036.398180090786;12093.697657558632;12096.213746106476;10734.677959661223;10900.236983411402;11467.025302849017;11850.407479626158;12205.572804951784;8489.151084891708;8855.114488551093;8979.371443999118;8980.595873185592;9008.63965441375;9587.856182157413;9634.470104144058;9845.507724613884;9846.261530385107;9963.003699629979;8600.440971336842;8605.870911936452;8711.782205444915;8807.779805504913;8897.466152030898;8445.498813834436;8494.150584941704;8661.956690216508;8669.523176225368;8748.081451447506;7549.924500755142;7613.695452182073;7677.654505547152;7723.420743444377;7748.65131069092;4972.204447288416;5616.915746263891;5692;5763.221965034834;5831.446012628793;5349.2778474906945;5719.28508936383;5738.1679656450415;5926.288845338587;5959.28488581373 16:32:45 INFO - PROCESS | 1640 | |4;prototype.html;319.38358967193307;369.0588998054961;370.51277569995455;375.36563208178194;381.755676367125;3826.9808650956707;4553.133215381694;4866.391701037371;4917.65576409651;4957.652964292496;3980.323345031344;4428.8671339859775;4730.0303437795255;4748.035390448979;4783.6890602110925;3564.180238545136;4020.256252593265;4113.794310284474;4138.710290279689;4149.294619914606;3860.7414662422516;4136.503619565657;4156.355764856437;4169.854055108071;4182.6235638792505;3343;3480.7041401480906;3967.9801600991955;3987.5613682494904;4010.6791456683395;3159.6524382317925;3498.915336245772;4008.959910400888;4026.7181297309053;4089.427480152781;3191.138392633976;3635.2002559436883;3673;3685.262947410529;3698.85204591816;3602.9551430085244;3982.6216509431556;4632.444106707183;4649.907001859978;4686.835960741358;4185.560516145792;4252.638525725286;4458.710183838072;4511.887202819923;4627.398438203046;4350.499692535335;4490.395570569062;4701.365315682373;5106.451016543504;5185.403678576974;3566.821658917044;4034.930743353014;4071.552129265808;4095.9795201024103;4136.772477513736;5266.526012658841;5270.972160428718;5408.459154084639;5478.274343581759;5478.397376288565;3521.9119522011642;3881;4172.873324202509;4227.356479100374;4296.205202037633;3809.8095095245126;3894.0264933766557;4332.328489084197;4335.436393268855;4410.691251612357;4424.33634954753;4529.252673308933;4771.9522804772205;4782.760861956888;4807.855764327006;3927.0953587510035;4307.784610769449;5310.946890531045;5337;5340.599455040888;1284.344984058137;1294.3916359311108;1391.422559637739;1391.5268808605124;1400.565824594379;914.7210100919284;1017.7481697512102;1029.738570251451;1038.0035166240343;1042.4735508568124;4303.526612072669;4520.773961301922;4777.8088876445245;4809.855704328876;4909.428982725565;4516.638668906479;4825.010872771073;4974.353334066548;5287.735613219324;5333.639921819989;4257.914231870853;4575.542445755398;4814.662973591885;4829.830955916596;4904.239842824368;2497.126005897921;2586.719573810976;2597.4545345477663;2683.9597406038924;2754.380264440485;5048.192289233705;5448.618596698193;5594.580406469531;5596.86007849807;5623.493885550321;4931.506849315111;5149.922751158736;5415.918761218585;5524.177021582868;5526.551126343332;5116.539511443988;5591.63654362457;5594.748236329294;5670.53331800668;5747.597668163188;4580.564846339593;4591.770411479346;4849.660523763303;5079.009593129452;5320.9467905322;5237.554807841376;5240.973795131;5244.632875698664;5291.788328466972;5315.681059136464;4864.562189402971;5562.276904002454;5573.498385145356;5579;5659.9151012735665;3799.6580307772433;3866.6326698963553;3926.469926559878;4141.937870931878;4178.603032712009;5054;5266.420693723764;5283.471652834686;5382.3541175059245;5385.980257403474;4511.390962220058;5161.638685291993;5162.664426812245;5224;5286.471352864836;4495.370648109202;4542.159700455426;4720.693154944917;5156.303898973591;5175.92236116451;4533.413305343103;4667.033021931331;4954;5053.343065401475;5105.7702403391195;4669.369635099218;4684.906301873875;4847.903041939212;4895.020995800925;5368.919466208088;4556.635469162393;4680.882977925579;4725.36207611968;5023.4725353838785;5053.595712343077 16:32:45 INFO - PROCESS | 1640 | |5;yui.html;752.2815710995995;758.7344429449694;818.9140140285269;823.4606332851984;830.207152169678;14935.925320373397;15726.685466290668;15745.370185192578;15749.212539373015;15817.446389376375;14173.92913035436;14290.285485725699;14291.285435728223;14304.927130465205;14312.499062532814;933.3606479561488;953.8378475659155;954.4988880837547;955.106974978394;961.2454223434605;936.7845395559026;948.2271948362097;966.6858271061898;967.5017366056486;988.7132731507854;1016.2124353625962;1020.1634659579148;1020.4183615339259;1021.8416145497459;1024.4263212600931;1008.1128606825946;1013.7313611892818;1014.1177175857015;1014.3964341216964;1016.7915577306709;759.3279947246726;761.5202422473861;764.5412752348602;764.6062277926873;770.6339488742858;14206.934479914047;14573.70852582953;15240.618984525365;15867.730581553447;15874.761878571831;13661.590152295446;13952.930235348758;14140.787888181685;14176.50382236627;14248.928755356157;11660.708482287926;11728.003119734833;11848.644540663794;12018.759624807455;12125.818112728317;3591.856325746967;3645.343838109139;3679.1537946272238;3776.6412190841825;3788.4317352397084;102468;102551;104596;104799;105046.47476762644;10134.391936483687;10457;10585.470726463645;10586.52360643773;10853.945730271298;21941.890290548763;22215;22217;22436.887815560818;22487.437814054778;7314.305141011595;7405.44459165554;7416.814579635445;7455.4408419368765;7541.321281084729;3956.8812935611977;4104.343305071234;4104.753714777123;4110.280700877334;4113.876583702434;3042.5243756777945;3258.315753691704;3271.525628783813;3336;3368.9663103368653;525.5427777833233;608.8082254089948;614.618936259522;615.5383462403198;626.9341719119518;638.4636904999729;664.9700763465655;666.167290886392;704.9506534542635;711.2673945835797;8565.357598180162;9677.37097088701;9851.655192068243;10017.499125043718;10183.065217608631;586.9791925311581;593.7981086430634;627.3318915355223;628.6636649392644;640.2445114764622;3904.4533765272886;4865.805367785249;4898.926516102261;4904.901901961941;4924.285978533093;94536;96866;97590;97793.51103244438;98143;55095.449045509835;61221.77556448846;63593;66418.66790666113;79193.20806791974;57753.18195906622;70333;71985;75477.62261188659;76490.85263721048;8718.476891386537;10207.489625518843;10629.468526573486;10720.892791071989;10732.570697172338;45590.77204613956;46017.76991115023;46426;47037.58887233389;47141;59239;59555.404445956716;60374;60668.69665651643;61016.08475872777;11784.882151178379;11955.880441195477;11996.340201289013;12115.273083615011;12123.211991220542;13783.862161378258;13875.028747987544;13916.26046744157;13981.161130332213;13992.440302388197;13020.934895325463;13142.671433214246;13147.737045259233;13198.20810751358;13240.337983100613;12872.270677289209;13069.869301306866;13175.47298108065;13219.867801322249;13479.460821567027;12275.324857132944;12632.810507842574;12636.747265054464;12830.29433381173;13002.934985325013;10574.84137737919;10665.36007839532;10780.137588993019;10803.621873234713;11352.318860868374;8716.518191907264;10283.331583447052;10787;10853.25562680874;10966.342019478856 16:32:45 INFO - PROCESS | 1640 | __end_tp_report 16:32:45 INFO - PROCESS | 1640 | __start_cc_report 16:32:45 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,2874 16:32:45 INFO - PROCESS | 1640 | __end_cc_report 16:32:45 INFO - PROCESS | 1640 | __startTimestamp1488846765873__endTimestamp 16:32:45 INFO - PROCESS | 1640 | 16:32:45 INFO - PROCESS | 1640 | ------- Summary: start ------- 16:32:45 INFO - PROCESS | 1640 | Number of tests: 6 16:32:45 INFO - PROCESS | 1640 | 16:32:45 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5718.50 Median:5850.12 stddev:647.56 (11.1%) stddev-sans-first:621.95 16:32:45 INFO - PROCESS | 1640 | Values: 3334.4 3336.1 3337.5 3352.3 3395.9 5561.2 5643.4 5709.0 5714.5 5730.4 5680.5 5705.7 5754.7 5800.7 5802.2 5090.0 5147.1 5191.9 5194.6 5195.2 5240.5 5250.9 5254.6 5288.8 5331.4 5081.3 5160.8 5200.6 5206.5 5209.6 5216.9 5242.9 5247.4 5264.1 5309.5 5158.2 5177.2 5183.5 5209.3 5234.6 5551.3 5592.4 5664.0 5701.3 5721.2 6182.0 6184.0 6194.2 6204.2 6208.0 6195.7 6218.7 6287.2 6287.3 6289.8 5808.7 5816.6 5853.3 5893.4 5897.5 5350.3 6355.7 6356.5 6381.2 6399.6 6032.5 6119.0 6126.7 6199.8 6238.2 5090.9 6115.5 6188.4 6191.3 6247.2 6276.4 6291.1 6297.7 6298.5 6312.4 6333.6 6342.0 6345.0 6351.9 6357.6 4917.0 5014.8 5015.3 5015.7 5065.5 4420.0 4440.9 4442.6 4443.3 4483.1 5693.6 5696.5 5710.9 5712.2 5717.4 5594.8 5837.2 6231.8 6241.7 6251.2 5555.8 5713.3 5714.1 5715.2 5733.1 5377.3 5420.4 5422.3 5446.2 5455.8 6199.4 6350.1 6372.5 6403.0 6404.7 6372.8 6392.5 6402.1 6412.0 6421.7 6367.8 6382.6 6386.9 6390.5 6393.3 6033.8 6100.9 6111.3 6126.9 6283.3 6214.1 6220.5 6233.6 6235.8 6250.0 5686.9 5917.5 5926.6 5964.4 6125.5 4979.6 5112.4 6115.4 6122.1 6146.3 4946.4 5966.1 5991.2 5996.5 6009.5 5899.7 5965.4 6021.5 6030.8 6031.2 5759.9 5809.8 5850.1 5859.7 5860.9 16:32:45 INFO - PROCESS | 1640 | 16:32:45 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:55475.84 Median:344923.64 stddev:112888.44 (32.7%) stddev-sans-first:113130.04 16:32:45 INFO - PROCESS | 1640 | Values: 639.6 780.0 850.5 864.5 867.5 27246.9 28475.9 28490.1 28540.0 38248.6 39412.8 39774.8 39873.4 39963.0 39989.8 8765.3 8959.0 8959.4 8965.6 8980.9 6703.0 7232.5 8939.6 9084.4 9085.7 7392.7 7415.9 7424.5 10478.8 10686.0 10624.4 10634.7 10663.2 10668.3 10685.9 10522.5 10592.0 10596.3 10600.5 10606.4 27040.1 27283.7 28349.3 37612.0 37929.4 2997.9 3689.2 3707.8 3746.6 3767.7 21755.6 26970.9 27331.3 27354.3 28023.6 3034.5 3048.7 3075.4 3134.1 3143.4 338833.0 344304.0 344429.0 344471.3 345376.0 40608.8 50448.2 50459.7 50533.7 50704.0 42782.1 43425.6 45770.3 52339.7 54795.7 13834.8 13875.9 13986.6 14204.9 14238.8 12040.0 12068.5 12072.0 12075.0 12084.1 12701.9 12706.4 12722.9 12760.6 12867.7 5820.9 5835.3 5858.4 5875.0 5883.0 905.3 933.8 1002.4 1003.4 1018.1 23361.0 24837.8 25105.2 27048.0 27062.7 907.3 1055.5 1080.6 1082.0 1106.9 11851.2 13388.9 13724.9 14061.1 14086.9 476994.0 478504.0 479188.6 479585.6 480143.0 53563.0 53601.7 53751.7 53767.5 53873.0 1370.3 1406.9 1415.6 1417.7 1418.9 25379.6 26531.9 26545.0 26682.2 26718.3 45922.8 45964.0 46100.8 46164.8 46174.0 440270.0 441069.0 441249.0 441582.0 441845.0 27522.2 27968.8 27990.0 33652.8 35506.0 42135.2 43054.0 45182.5 45286.5 45450.0 34089.9 35432.0 36243.8 36635.8 37602.8 35769.1 35947.8 36944.8 37088.0 37715.0 36040.6 36855.8 37157.6 37162.8 37193.8 31212.8 32169.5 32783.7 32877.5 32951.7 24398.6 24399.9 24689.4 25201.0 25443.0 16:32:45 INFO - PROCESS | 1640 | 16:32:45 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:38053.58 Median:21287.28 stddev:108492.12 (509.7%) stddev-sans-first:108759.59 16:32:45 INFO - PROCESS | 1640 | Values: 378.4 393.9 395.2 405.7 424.6 13445.1 17234.5 20169.0 21969.1 22154.2 21913.7 22017.3 22446.3 22595.2 22725.5 6507.4 6655.7 6703.9 6813.5 6883.1 6669.6 6698.1 6723.8 6729.7 6744.9 6469.5 6677.4 6721.4 6725.9 6746.9 6463.8 6578.5 6640.8 6714.7 6737.5 6485.7 6486.7 6501.2 6502.1 6514.1 26175.1 26587.9 26600.7 26607.7 26928.5 2887.9 2906.3 2907.0 2915.8 2918.0 15739.2 16229.4 16287.7 16708.1 16889.5 1938.4 1948.5 1982.3 2003.1 2014.5 121937.0 124468.4 125203.4 125736.0 128113.0 13493.9 19806.4 20622.4 20911.5 21047.0 30501.4 32527.3 32557.0 33957.8 34133.6 8762.5 8768.8 10418.0 10663.1 10684.3 6800.4 8680.0 8713.4 8801.0 8812.7 10549.3 10633.5 10705.1 10773.0 10831.5 3463.6 3624.0 3827.6 4075.0 4084.8 890.8 990.7 1021.2 1029.0 1076.1 17385.8 21527.6 22047.2 22394.8 22482.6 912.0 980.1 1023.4 1054.7 1059.9 11098.9 11239.0 11405.6 11490.5 11508.7 364196.0 695734.0 708092.0 711702.0 715226.0 115921.5 117870.8 119123.0 124726.0 132781.0 1204.2 1232.1 1260.5 1263.3 1267.4 18498.7 18963.4 19192.9 19213.8 19304.4 57233.7 57318.7 57642.7 58203.7 58475.4 73447.3 79312.0 80982.6 84370.6 87238.1 11245.2 11949.8 12126.5 12127.3 12177.5 12927.4 13524.2 13530.9 13992.8 14002.8 11488.7 11543.7 11813.1 11820.5 11997.7 5890.1 9573.8 11538.7 11775.1 11947.8 11673.7 11685.9 11989.2 12038.5 12075.6 11537.8 11617.1 11678.2 11807.0 11874.8 11408.7 11629.6 11771.1 11792.9 11827.9 16:32:45 INFO - PROCESS | 1640 | 16:32:45 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:6356.89 Median:3699.96 stddev:3948.29 (106.7%) stddev-sans-first:3941.15 16:32:45 INFO - PROCESS | 1640 | Values: 1310.4 1360.0 1522.9 1542.7 1561.7 9609.5 10175.6 10686.3 10730.4 10745.3 10113.6 10511.0 10611.4 10615.7 10617.2 2308.0 2352.3 2353.4 2355.9 2355.9 2283.4 2317.9 2320.2 2321.3 2323.2 2283.0 2298.8 2300.9 2305.3 2308.3 2250.9 2268.2 2272.0 2275.4 2276.9 2230.6 2286.4 2299.5 2300.8 2309.7 9149.8 10552.2 10633.9 10640.5 10644.8 5267.6 5432.2 5442.3 5445.6 5455.3 3198.6 3220.2 3476.8 3486.7 3488.6 1052.6 1163.9 1173.2 1177.1 1219.1 13026.7 13418.4 13684.1 13880.9 14414.3 4115.9 4233.6 4239.3 4239.8 4415.6 10950.7 10952.9 10960.4 10970.2 10984.2 4661.8 5472.9 5497.2 5498.3 5498.8 4828.4 5055.8 5128.3 5135.6 5147.1 3507.7 3585.2 3675.4 3724.6 3761.5 855.3 1009.5 1017.0 1023.0 1029.4 784.5 787.7 800.6 811.7 811.8 5552.5 5623.4 5680.7 5698.9 5736.4 925.3 943.4 944.3 968.6 987.9 3125.3 3805.7 4060.7 4063.7 4114.1 11249.0 11771.2 12825.0 12969.4 12998.2 12245.3 12862.8 12887.6 12913.5 12927.1 9527.8 9818.9 9819.0 9826.4 9872.6 5290.4 6242.7 6457.7 6591.1 6642.5 11988.1 11995.3 12036.4 12093.7 12096.2 10734.7 10900.2 11467.0 11850.4 12205.6 8489.2 8855.1 8979.4 8980.6 9008.6 9587.9 9634.5 9845.5 9846.3 9963.0 8600.4 8605.9 8711.8 8807.8 8897.5 8445.5 8494.2 8662.0 8669.5 8748.1 7549.9 7613.7 7677.7 7723.4 7748.7 4972.2 5616.9 5692.0 5763.2 5831.4 5349.3 5719.3 5738.2 5926.3 5959.3 16:32:45 INFO - PROCESS | 1640 | 16:32:45 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4282.74 Median:4586.17 stddev:1225.18 (26.7%) stddev-sans-first:1191.95 16:32:45 INFO - PROCESS | 1640 | Values: 319.4 369.1 370.5 375.4 381.8 3827.0 4553.1 4866.4 4917.7 4957.7 3980.3 4428.9 4730.0 4748.0 4783.7 3564.2 4020.3 4113.8 4138.7 4149.3 3860.7 4136.5 4156.4 4169.9 4182.6 3343.0 3480.7 3968.0 3987.6 4010.7 3159.7 3498.9 4009.0 4026.7 4089.4 3191.1 3635.2 3673.0 3685.3 3698.9 3603.0 3982.6 4632.4 4649.9 4686.8 4185.6 4252.6 4458.7 4511.9 4627.4 4350.5 4490.4 4701.4 5106.5 5185.4 3566.8 4034.9 4071.6 4096.0 4136.8 5266.5 5271.0 5408.5 5478.3 5478.4 3521.9 3881.0 4172.9 4227.4 4296.2 3809.8 3894.0 4332.3 4335.4 4410.7 4424.3 4529.3 4772.0 4782.8 4807.9 3927.1 4307.8 5310.9 5337.0 5340.6 1284.3 1294.4 1391.4 1391.5 1400.6 914.7 1017.7 1029.7 1038.0 1042.5 4303.5 4520.8 4777.8 4809.9 4909.4 4516.6 4825.0 4974.4 5287.7 5333.6 4257.9 4575.5 4814.7 4829.8 4904.2 2497.1 2586.7 2597.5 2684.0 2754.4 5048.2 5448.6 5594.6 5596.9 5623.5 4931.5 5149.9 5415.9 5524.2 5526.6 5116.5 5591.6 5594.7 5670.5 5747.6 4580.6 4591.8 4849.7 5079.0 5320.9 5237.6 5241.0 5244.6 5291.8 5315.7 4864.6 5562.3 5573.5 5579.0 5659.9 3799.7 3866.6 3926.5 4141.9 4178.6 5054.0 5266.4 5283.5 5382.4 5386.0 4511.4 5161.6 5162.7 5224.0 5286.5 4495.4 4542.2 4720.7 5156.3 5175.9 4533.4 4667.0 4954.0 5053.3 5105.8 4669.4 4684.9 4847.9 4895.0 5368.9 4556.6 4680.9 4725.4 5023.5 5053.6 16:32:45 INFO - PROCESS | 1640 | 16:32:45 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:18977.43 Median:3150.42 stddev:26601.71 (844.4%) stddev-sans-first:26641.14 16:32:45 INFO - PROCESS | 1640 | Values: 752.3 758.7 818.9 823.5 830.2 14935.9 15726.7 15745.4 15749.2 15817.4 14173.9 14290.3 14291.3 14304.9 14312.5 933.4 953.8 954.5 955.1 961.2 936.8 948.2 966.7 967.5 988.7 1016.2 1020.2 1020.4 1021.8 1024.4 1008.1 1013.7 1014.1 1014.4 1016.8 759.3 761.5 764.5 764.6 770.6 14206.9 14573.7 15240.6 15867.7 15874.8 13661.6 13952.9 14140.8 14176.5 14248.9 11660.7 11728.0 11848.6 12018.8 12125.8 3591.9 3645.3 3679.2 3776.6 3788.4 102468.0 102551.0 104596.0 104799.0 105046.5 10134.4 10457.0 10585.5 10586.5 10853.9 21941.9 22215.0 22217.0 22436.9 22487.4 7314.3 7405.4 7416.8 7455.4 7541.3 3956.9 4104.3 4104.8 4110.3 4113.9 3042.5 3258.3 3271.5 3336.0 3369.0 525.5 608.8 614.6 615.5 626.9 638.5 665.0 666.2 705.0 711.3 8565.4 9677.4 9851.7 10017.5 10183.1 587.0 593.8 627.3 628.7 640.2 3904.5 4865.8 4898.9 4904.9 4924.3 94536.0 96866.0 97590.0 97793.5 98143.0 55095.4 61221.8 63593.0 66418.7 79193.2 57753.2 70333.0 71985.0 75477.6 76490.9 8718.5 10207.5 10629.5 10720.9 10732.6 45590.8 46017.8 46426.0 47037.6 47141.0 59239.0 59555.4 60374.0 60668.7 61016.1 11784.9 11955.9 11996.3 12115.3 12123.2 13783.9 13875.0 13916.3 13981.2 13992.4 13020.9 13142.7 13147.7 13198.2 13240.3 12872.3 13069.9 13175.5 13219.9 13479.5 12275.3 12632.8 12636.7 12830.3 13002.9 10574.8 10665.4 10780.1 10803.6 11352.3 8716.5 10283.3 10787.0 10853.3 10966.3 16:32:45 INFO - PROCESS | 1640 | -------- Summary: end -------- 16:32:45 INFO - PROCESS | 1640 | 16:32:46 INFO - TEST-INFO | 1640: exit 0 16:32:46 INFO - TEST-OK | dromaeo_css | took 1121805ms 16:32:46 INFO - TEST-START | kraken 16:32:46 INFO - operating with platform_type : mac_ 16:32:46 INFO - Initialising browser for kraken test... 16:32:46 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmphZYKZV/profile http://localhost:49236/getInfo.html) 16:32:49 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 16:32:49 INFO - PROCESS | 1649 | colorDepth:24 16:32:49 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 16:32:49 INFO - PROCESS | 1649 | __metrics 16:32:49 INFO - PROCESS | 1649 | 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" 16:32:49 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:32:50 INFO - TEST-INFO | 1649: exit 0 16:32:50 INFO - Browser initialized. 16:32:50 INFO - Running cycle 1/1 for kraken test... 16:32:50 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmphZYKZV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:02 INFO - PROCESS | 1650 | RSS: Main: 250757120 16:33:02 INFO - PROCESS | 1650 | 16:33:05 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 16:33:06 INFO - PROCESS | 1650 | RSS: Main: 299917312 16:33:06 INFO - PROCESS | 1650 | 16:33:08 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 16:33:09 INFO - PROCESS | 1650 | RSS: Main: 299683840 16:33:09 INFO - PROCESS | 1650 | 16:33:12 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 16:33:13 INFO - PROCESS | 1650 | RSS: Main: 387096576 16:33:13 INFO - PROCESS | 1650 | 16:33:15 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 16:33:15 INFO - PROCESS | 1650 | RSS: Main: 293355520 16:33:15 INFO - PROCESS | 1650 | 16:33:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:33:18 INFO - PROCESS | 1650 | RSS: Main: 295424000 16:33:18 INFO - PROCESS | 1650 | 16:33:21 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 16:33:22 INFO - PROCESS | 1650 | RSS: Main: 336850944 16:33:22 INFO - PROCESS | 1650 | 16:33:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 16:33:26 INFO - PROCESS | 1650 | RSS: Main: 339001344 16:33:26 INFO - PROCESS | 1650 | 16:33:29 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 16:33:29 INFO - PROCESS | 1650 | RSS: Main: 337104896 16:33:29 INFO - PROCESS | 1650 | 16:33:31 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:33:32 INFO - PROCESS | 1650 | RSS: Main: 314523648 16:33:32 INFO - PROCESS | 1650 | 16:33:33 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:33:34 INFO - PROCESS | 1650 | RSS: Main: 317014016 16:33:34 INFO - PROCESS | 1650 | 16:33:36 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:33:37 INFO - PROCESS | 1650 | RSS: Main: 319737856 16:33:37 INFO - PROCESS | 1650 | 16:33:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:33:41 INFO - PROCESS | 1650 | RSS: Main: 336965632 16:33:41 INFO - PROCESS | 1650 | 16:33:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:33:44 INFO - PROCESS | 1650 | RSS: Main: 330637312 16:33:44 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 16:33:46 INFO - PROCESS | 1650 | RSS: Main: 375021568 16:33:46 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | __start_tp_report 16:33:46 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 16:33:46 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 16:33:46 INFO - PROCESS | 1650 | |i|pagename|runs| 16:33:46 INFO - PROCESS | 1650 | |0;ai-astar;163;173;115;116;116;115;116;115;114;116 16:33:46 INFO - PROCESS | 1650 | |1;audio-beat-detection;142;113;110;147;113;111;119;103;157;138 16:33:46 INFO - PROCESS | 1650 | |2;audio-dft;184;185;185;184;178;181;192;184;184;182 16:33:46 INFO - PROCESS | 1650 | |3;audio-fft;80;60;61;91;64;63;59;60;78;61 16:33:46 INFO - PROCESS | 1650 | |4;audio-oscillator;84;71;88;73;71;70;85;69;69;86 16:33:46 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;88;87;88;87;87;87;87;87;87;88 16:33:46 INFO - PROCESS | 1650 | |6;imaging-darkroom;94;95;94;135;150;94;95;97;96;93 16:33:46 INFO - PROCESS | 1650 | |7;imaging-desaturate;86;84;84;86;86;86;85;86;83;86 16:33:46 INFO - PROCESS | 1650 | |8;json-parse-financial;63;60;60;60;62;62;63;59;60;60 16:33:46 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;56;65;56;64;60;57;58;62;59;58 16:33:46 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;89;89;88;87;86;87;93;104;103;89 16:33:46 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;146;150;148;143;141;129;139;140;184;157 16:33:46 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;171;230;176;171;183;170;170;170;172;171 16:33:46 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;68;71;79;82;83;84;68;65;67;66 16:33:46 INFO - PROCESS | 1650 | __end_tp_report 16:33:46 INFO - PROCESS | 1650 | __start_cc_report 16:33:46 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2132 16:33:46 INFO - PROCESS | 1650 | __end_cc_report 16:33:46 INFO - PROCESS | 1650 | __startTimestamp1488846826914__endTimestamp 16:33:46 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | ------- Summary: start ------- 16:33:46 INFO - PROCESS | 1650 | Number of tests: 14 16:33:46 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:125.90 Median:116.00 stddev:22.32 (19.2%) stddev-sans-first:19.22 16:33:46 INFO - PROCESS | 1650 | Values: 163.0 173.0 115.0 116.0 116.0 115.0 116.0 115.0 114.0 116.0 16:33:46 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:125.30 Median:128.50 stddev:18.84 (14.7%) stddev-sans-first:18.99 16:33:46 INFO - PROCESS | 1650 | Values: 142.0 113.0 110.0 147.0 113.0 111.0 119.0 103.0 157.0 138.0 16:33:46 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:3.57 (1.9%) stddev-sans-first:3.79 16:33:46 INFO - PROCESS | 1650 | Values: 184.0 185.0 185.0 184.0 178.0 181.0 192.0 184.0 184.0 182.0 16:33:46 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:67.70 Median:63.50 stddev:11.16 (17.6%) stddev-sans-first:10.91 16:33:46 INFO - PROCESS | 1650 | Values: 80.0 60.0 61.0 91.0 64.0 63.0 59.0 60.0 78.0 61.0 16:33:46 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:78.50 stddev:8.02 (10.2%) stddev-sans-first:8.04 16:33:46 INFO - PROCESS | 1650 | Values: 84.0 71.0 88.0 73.0 71.0 70.0 85.0 69.0 69.0 86.0 16:33:46 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:87.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 16:33:46 INFO - PROCESS | 1650 | Values: 88.0 87.0 88.0 87.0 87.0 87.0 87.0 87.0 87.0 88.0 16:33:46 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:104.30 Median:94.50 stddev:20.47 (21.7%) stddev-sans-first:21.37 16:33:46 INFO - PROCESS | 1650 | Values: 94.0 95.0 94.0 135.0 150.0 94.0 95.0 97.0 96.0 93.0 16:33:46 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:86.00 stddev:1.14 (1.3%) stddev-sans-first:1.17 16:33:46 INFO - PROCESS | 1650 | Values: 86.0 84.0 84.0 86.0 86.0 86.0 85.0 86.0 83.0 86.0 16:33:46 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:1.45 (2.4%) stddev-sans-first:1.32 16:33:46 INFO - PROCESS | 1650 | Values: 63.0 60.0 60.0 60.0 62.0 62.0 63.0 59.0 60.0 60.0 16:33:46 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.50 stddev:3.21 (5.4%) stddev-sans-first:3.14 16:33:46 INFO - PROCESS | 1650 | Values: 56.0 65.0 56.0 64.0 60.0 57.0 58.0 62.0 59.0 58.0 16:33:46 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:88.50 stddev:6.60 (7.5%) stddev-sans-first:6.94 16:33:46 INFO - PROCESS | 1650 | Values: 89.0 89.0 88.0 87.0 86.0 87.0 93.0 104.0 103.0 89.0 16:33:46 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:147.00 stddev:14.77 (10.0%) stddev-sans-first:15.66 16:33:46 INFO - PROCESS | 1650 | Values: 146.0 150.0 148.0 143.0 141.0 129.0 139.0 140.0 184.0 157.0 16:33:46 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.40 Median:171.50 stddev:18.58 (10.8%) stddev-sans-first:19.51 16:33:46 INFO - PROCESS | 1650 | Values: 171.0 230.0 176.0 171.0 183.0 170.0 170.0 170.0 172.0 171.0 16:33:46 INFO - PROCESS | 1650 | 16:33:46 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:75.00 stddev:7.75 (10.3%) stddev-sans-first:7.98 16:33:46 INFO - PROCESS | 1650 | Values: 68.0 71.0 79.0 82.0 83.0 84.0 68.0 65.0 67.0 66.0 16:33:46 INFO - PROCESS | 1650 | -------- Summary: end -------- 16:33:46 INFO - PROCESS | 1650 | 16:33:47 INFO - TEST-INFO | 1650: exit 0 16:33:47 INFO - TEST-OK | kraken | took 61306ms 16:33:47 INFO - SUITE-END | took 1183s 16:33:48 INFO - Completed test suite (00:19:43) 16:33:48 INFO - javascript benchmark 16:33:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7402.971552846662, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3334.399808034556, 3336.0825772912444, 3337.532745415641, 3352.3127758809446, 3395.9320813583727, 5561.249231353766, 5643.4074422185695, 5709.0, 5714.514266287365, 5730.369659337474, 5680.517156041731, 5705.686187259699, 5754.74103665335, 5800.680962547058, 5802.187693722883, 5090.0, 5147.073526765181, 5191.922121168176, 5194.610404219679, 5195.220716892459, 5240.502152295545, 5250.894982100355, 5254.605904557155, 5288.841334759944, 5331.413544510101, 5081.339425874631, 5160.767765450526, 5200.635955483118, 5206.505381988705, 5209.557187639055, 5216.895662086737, 5242.947570524284, 5247.396549396792, 5264.052470555299, 5309.4955979182305, 5158.200478925773, 5177.19753438214, 5183.533481986601, 5209.270702101709, 5234.607404444682, 5551.333839939192, 5592.384837667853, 5663.971680141614, 5701.25883635129, 5721.227634269362, 6182.010878259457, 6184.010558310693, 6194.194754681863, 6204.193454850841, 6208.037754148114, 6195.659238741868, 6218.720157592919, 6287.245530536365, 6287.276963149205, 6289.842753931189, 5808.680522571257, 5816.563757718188, 5853.326867410217, 5893.410658934115, 5897.49871260939, 5350.250964864922, 6355.682215889187, 6356.491480681534, 6381.234251889803, 6399.616023038632, 6032.517398608101, 6118.969405152946, 6126.663033533109, 6199.845003874849, 6238.220222472191, 5090.898182036339, 6115.483736156635, 6188.44304012641, 6191.25704915413, 6247.156633854372, 6276.403741644536, 6291.1192433059405, 6297.716602752887, 6298.464630506458, 6312.400321969406, 6333.556651034475, 6342.04869269604, 6345.016522439029, 6351.936480635227, 6357.586756860882, 4917.0, 5014.84955451337, 5015.3229314042865, 5015.673981191211, 5065.468125846806, 4419.9779001105435, 4440.888977775581, 4442.555744425532, 4443.266860967904, 4483.058557702919, 5693.572982026281, 5696.51579615729, 5710.914336284959, 5712.228849105318, 5717.371089180187, 5594.769150786902, 5837.241158649348, 6231.844203894848, 6241.656708881055, 6251.218597675291, 5555.805546805843, 5713.342965559014, 5714.085746280658, 5715.199872017921, 5733.140028995684, 5377.300950876361, 5420.403755586883, 5422.295101636841, 5446.1558458439, 5455.781768729206, 6199.411055949768, 6350.079238510482, 6372.458341041063, 6403.0, 6404.7117879695525, 6372.776952806815, 6392.456641185366, 6402.10370548133, 6411.96794016027, 6421.7110230038825, 6367.840803979938, 6382.5532212744665, 6386.9361306386345, 6390.48876089921, 6393.2647745508, 6033.849153771191, 6100.938990610037, 6111.287884814121, 6126.945200426759, 6283.3402492737605, 6214.067889816563, 6220.471259942956, 6233.563650544418, 6235.844103897258, 6249.96875015622, 5686.914696279477, 5917.497012753792, 5926.585139040226, 5964.373740757332, 6125.47933425646, 4979.551840334388, 5112.437631860418, 6115.357887421935, 6122.112293717475, 6146.293176284606, 4946.35697359341, 5966.075258334965, 5991.161237426851, 5996.490298324691, 6009.549283803644, 5899.734511946886, 5965.403459654, 6021.488173505301, 6030.849228769316, 6031.155638210566, 5759.884802304015, 5809.767609295581, 5850.12248162779, 5859.707014649336, 5860.882782344244], "value": 5678.197386915943, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.5874660843756, 779.9571023593702, 850.4897061762942, 864.4510735682843, 867.535868310454, 27246.86376568117, 28475.85762071192, 28490.145295641138, 28540.001099961504, 38248.61751382485, 39412.80293598528, 39774.8067557973, 39873.40189897154, 39963.00092497689, 39989.80030599079, 8765.34259930503, 8958.955205223965, 8959.37284390093, 8965.551722413886, 8980.910190898072, 6702.966485167567, 7232.493725439222, 8939.597718102701, 9084.409513381643, 9085.727428177166, 7392.7042918283205, 7415.851682966364, 7424.517406368595, 10478.790424191511, 10686.038256556909, 10624.415657138854, 10634.680959571186, 10663.200259980455, 10668.30656007357, 10685.893141068567, 10522.47387630623, 10591.993760592732, 10596.258261921668, 10600.522976466078, 10606.363618182933, 27040.05359812397, 27283.727162728515, 28349.291267718265, 37612.0, 37929.431058534145, 2997.925051873721, 3689.1883785567134, 3707.7775333480076, 3746.606606306326, 3767.7362584619086, 21755.564888702138, 26970.865145674146, 27331.316717082034, 27354.316142096406, 28023.579646305323, 3034.4689679306034, 3048.679888611708, 3075.3541756230993, 3134.106779567835, 3143.4341818472667, 338833.0, 344304.0, 344429.0, 344471.2776436102, 345376.0, 40608.79695601503, 50448.243276350884, 50459.74770126199, 50533.74733126311, 50704.0, 42782.14435711268, 43425.565744342784, 45770.31344529835, 52339.73830130825, 54795.726021369635, 13834.792478112837, 13875.861241387456, 13986.580402587939, 14204.928975355057, 14238.786418203736, 12040.036797056215, 12068.517259309529, 12071.973882219934, 12075.0, 12084.093692973061, 12701.87298127007, 12706.428210730539, 12722.936385318015, 12760.617181484384, 12867.678308042374, 5820.912686309709, 5835.328937172279, 5858.355580886099, 5875.0, 5882.970585147047, 905.3210092430677, 933.8140561486873, 1002.4486532407293, 1003.3929472669076, 1018.1040684197859, 23361.0, 24837.751622483906, 25105.24684259475, 27048.0, 27062.729372706413, 907.2877790934085, 1055.4617145255975, 1080.6487891435158, 1081.9891801082047, 1106.9335839849634, 11851.170418070653, 13388.93305533466, 13724.862751372559, 14061.086029408056, 14086.943479239098, 476994.0, 478504.0, 479188.6040569775, 479585.6020719874, 480143.0, 53562.98277629194, 53601.65995850135, 53751.73124134354, 53767.462325377026, 53873.0, 1370.3353873371407, 1406.859314068585, 1415.5894790510636, 1417.6810217700934, 1418.8864890808711, 25379.6193057108, 26531.86734066317, 26545.0, 26682.19953401401, 26718.320419895026, 45922.77038614786, 45964.0, 46100.7694961523, 46164.845878853295, 46174.0, 440270.0, 441069.0, 441249.0, 441582.0, 441845.0, 27522.17433476999, 27968.825767233127, 27990.0, 33652.831735841166, 35506.0, 42135.15729685451, 43054.0, 45182.54817451915, 45286.547134528235, 45450.0, 34089.931906128564, 35432.0, 36243.81878090592, 36635.81682091572, 37602.811985939894, 35769.1057723559, 35947.82026089853, 36944.81527592345, 37088.0, 37715.0, 36040.63959360373, 36855.81572092122, 37157.628423716495, 37162.814185928895, 37193.81403093076, 31212.843935780176, 32169.517457238628, 32783.67216327806, 32877.50683739794, 32951.67048329582, 24398.634020489353, 24399.878000609882, 24689.382765431008, 25200.951771575055, 25443.0], "value": 18197.486181475037, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.4417983474374, 393.9310620641388, 395.2371922190175, 405.7139716499868, 424.5627004185688, 13445.126066805664, 17234.48296551104, 20169.0, 21969.121235150575, 22154.22460213893, 21913.671294930587, 22017.33947981559, 22446.32661020172, 22595.209167679135, 22725.54548909025, 6507.414332710079, 6655.700493477805, 6703.9329606703795, 6813.523053386265, 6883.105196324471, 6669.633170175638, 6698.062271282024, 6723.798286051427, 6729.7308107675635, 6744.898826517606, 6469.4500967417825, 6677.432418244455, 6721.361470660304, 6725.865482690343, 6746.932530674704, 6463.83840403989, 6578.506612004071, 6640.833979150511, 6714.731410743564, 6737.494687898403, 6485.6704375602885, 6486.67566621667, 6501.187351581052, 6502.057201705727, 6514.088027676129, 26175.083872064577, 26587.867060664765, 26600.6699665016, 26607.73392266072, 26928.46143077147, 2887.9278018049718, 2906.3315437449505, 2906.956395654067, 2915.7521610662907, 2918.0, 15739.213039347987, 16229.350825966947, 16287.674246515122, 16708.08105554194, 16889.49331520044, 1938.4378530226218, 1948.4544327588299, 1982.2764690887866, 2003.1486618187357, 2014.4661664658877, 121937.0, 124468.37765811113, 125203.37398313041, 125736.0, 128113.0, 13493.949324153475, 19806.405807825788, 20622.431943375206, 20911.47721306949, 21047.0, 30501.389972200875, 32527.34945301128, 32557.02328930136, 33957.830210848784, 34133.58664133567, 8762.474251544927, 8768.824623507495, 10418.0, 10663.093637040784, 10684.25210235276, 6800.387965083166, 8679.956600216958, 8713.390062695677, 8801.0, 8812.691555795645, 10549.314294570828, 10633.5214915329, 10705.1435885129, 10773.0, 10831.458427078614, 3463.5843698755807, 3624.0, 3827.6363745444137, 4075.0, 4084.8366065357054, 890.8084761776249, 990.7417579673773, 1021.2085633633993, 1028.9897101029044, 1076.0638244726981, 17385.82614173842, 21527.56944861125, 22047.22834700778, 22394.776052239595, 22482.550348993256, 911.9908800912038, 980.0836218136066, 1023.3961962442195, 1054.7204990677476, 1059.9099076578423, 11098.944505277583, 11239.0, 11405.600803971822, 11490.54037838477, 11508.654740357802, 364196.0, 695734.0, 708092.0, 711702.0, 715226.0, 115921.5223543295, 117870.8212917877, 119123.0, 124726.0, 132781.0, 1204.1691233049169, 1232.1375037473804, 1260.4580030586935, 1263.33674820718, 1267.448659832994, 18498.722519162493, 18963.43109706711, 19192.94438805879, 19213.807861921203, 19304.420867374, 57233.71383143058, 57318.713406432704, 57642.7117864408, 58203.70898145652, 58475.415245847, 73447.26552734405, 79312.0, 80982.59508702655, 84370.57814710887, 87238.127618723, 11245.152092202366, 11949.820752688544, 12126.454309556268, 12127.272363658209, 12177.452014659184, 12927.353632318534, 13524.18854868711, 13530.932345338604, 13992.790108148589, 14002.789958150432, 11488.655340339803, 11543.711407214887, 11813.054955603702, 11820.468078936641, 11997.700057498632, 5890.14592884038, 9573.760655983657, 11538.711532211762, 11775.116866235237, 11947.76104477923, 11673.708157296136, 11685.941570292094, 11989.22070065443, 12038.518459261531, 12075.637730868088, 11537.826932596186, 11617.145276580974, 11678.24091434054, 11807.0, 11874.76250475003, 11408.657740267805, 11629.59296424621, 11771.117166212398, 11792.938635522843, 11827.881721182677], "value": 11351.564325362908, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.4103153580886, 1359.9999999999998, 1522.9314680839361, 1542.6760380320125, 1561.72669782788, 9609.519524023806, 10175.592976280948, 10686.305390149635, 10730.409827459505, 10745.301555398893, 10113.595456181762, 10510.99999999998, 10611.363318200913, 10615.734606634818, 10617.203709721764, 2308.0190918859457, 2352.3413444235557, 2353.4351755578623, 2355.882205889707, 2355.9175428859994, 2283.4405570635217, 2317.884105794712, 2320.187934223017, 2321.3268152235833, 2323.186884590397, 2282.9657555136687, 2298.7586303438147, 2300.8734519601417, 2305.3199306204624, 2308.284431826131, 2250.932472025842, 2268.206127855254, 2272.0230300970575, 2275.3628983884537, 2276.863388196697, 2230.60964331243, 2286.371247906822, 2299.5171014087064, 2300.769923007703, 2309.711286089239, 9149.764781754444, 10552.208584356127, 10633.893661063368, 10640.46797660114, 10644.840327395095, 5267.631265811395, 5432.2123292122815, 5442.319710036246, 5445.564354851603, 5455.345358556999, 3198.584184056081, 3220.243242837931, 3476.7566270361085, 3486.686198242145, 3488.5988111367265, 1052.6421016854306, 1163.906887449002, 1173.1846366775094, 1177.0587390919163, 1219.1405059433166, 13026.739465210738, 13418.396172172275, 13684.110532815335, 13880.861191388058, 14414.279286035657, 4115.8765237042935, 4233.597808208277, 4239.342901850218, 4239.766812825263, 4415.580519850609, 10950.671479855617, 10952.890471095347, 10960.397178155119, 10970.232083754061, 10984.231103822816, 4661.790219440133, 5472.890542189213, 5497.175423686479, 5498.285222921075, 5498.835034948958, 4828.444728856227, 5055.848324550269, 5128.3333166688835, 5135.589152867761, 5147.0735267651435, 3507.719382449398, 3585.175409655794, 3675.3751862183494, 3724.5530536335814, 3761.5486141663177, 855.2815634866618, 1009.4750729620556, 1017.018577073128, 1022.9693109206736, 1029.4286670897723, 784.4704824243613, 787.6809891993752, 800.5676934455445, 811.7240138352988, 811.7767613906105, 5552.472515111058, 5623.409541998113, 5680.715964201773, 5698.917205730898, 5736.397678243808, 925.2551695884742, 943.3820847345, 944.3436811416137, 968.6125549780004, 987.9012098790064, 3125.312431265118, 3805.7441044455263, 4060.7360521566593, 4063.654589359878, 4114.115465175002, 11249.0, 11771.234869733611, 12825.038122140877, 12969.41637626309, 12998.155119917175, 12245.265284082805, 12862.807057894139, 12887.613371598867, 12913.548025819051, 12927.095103342865, 9527.761805954768, 9818.901810981799, 9819.0, 9826.361286516354, 9872.60509579623, 5290.365156181283, 6242.65782856688, 6457.7094030767785, 6591.110200122922, 6642.535022548375, 11988.100892432927, 11995.280283183038, 12036.398180090786, 12093.697657558632, 12096.213746106476, 10734.677959661223, 10900.236983411402, 11467.025302849017, 11850.407479626158, 12205.572804951784, 8489.151084891708, 8855.114488551093, 8979.371443999118, 8980.595873185592, 9008.63965441375, 9587.856182157413, 9634.470104144058, 9845.507724613884, 9846.261530385107, 9963.003699629979, 8600.440971336842, 8605.870911936452, 8711.782205444915, 8807.779805504913, 8897.466152030898, 8445.498813834436, 8494.150584941704, 8661.956690216508, 8669.523176225368, 8748.081451447506, 7549.924500755142, 7613.695452182073, 7677.654505547152, 7723.420743444377, 7748.65131069092, 4972.204447288416, 5616.915746263891, 5692.0, 5763.221965034834, 5831.446012628793, 5349.2778474906945, 5719.28508936383, 5738.1679656450415, 5926.288845338587, 5959.28488581373], "value": 4850.289603707013, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.38358967193307, 369.0588998054961, 370.51277569995455, 375.36563208178194, 381.755676367125, 3826.9808650956707, 4553.133215381694, 4866.391701037371, 4917.65576409651, 4957.652964292496, 3980.323345031344, 4428.8671339859775, 4730.0303437795255, 4748.035390448979, 4783.6890602110925, 3564.180238545136, 4020.256252593265, 4113.794310284474, 4138.710290279689, 4149.294619914606, 3860.7414662422516, 4136.503619565657, 4156.355764856437, 4169.854055108071, 4182.6235638792505, 3343.0, 3480.7041401480906, 3967.9801600991955, 3987.5613682494904, 4010.6791456683395, 3159.6524382317925, 3498.915336245772, 4008.959910400888, 4026.7181297309053, 4089.427480152781, 3191.138392633976, 3635.2002559436883, 3673.0, 3685.262947410529, 3698.85204591816, 3602.9551430085244, 3982.6216509431556, 4632.444106707183, 4649.907001859978, 4686.835960741358, 4185.560516145792, 4252.638525725286, 4458.710183838072, 4511.887202819923, 4627.398438203046, 4350.499692535335, 4490.395570569062, 4701.365315682373, 5106.451016543504, 5185.403678576974, 3566.821658917044, 4034.930743353014, 4071.552129265808, 4095.9795201024103, 4136.772477513736, 5266.526012658841, 5270.972160428718, 5408.459154084639, 5478.274343581759, 5478.397376288565, 3521.9119522011642, 3881.0, 4172.873324202509, 4227.356479100374, 4296.205202037633, 3809.8095095245126, 3894.0264933766557, 4332.328489084197, 4335.436393268855, 4410.691251612357, 4424.33634954753, 4529.252673308933, 4771.9522804772205, 4782.760861956888, 4807.855764327006, 3927.0953587510035, 4307.784610769449, 5310.946890531045, 5337.0, 5340.599455040888, 1284.344984058137, 1294.3916359311108, 1391.422559637739, 1391.5268808605124, 1400.565824594379, 914.7210100919284, 1017.7481697512102, 1029.738570251451, 1038.0035166240343, 1042.4735508568124, 4303.526612072669, 4520.773961301922, 4777.8088876445245, 4809.855704328876, 4909.428982725565, 4516.638668906479, 4825.010872771073, 4974.353334066548, 5287.735613219324, 5333.639921819989, 4257.914231870853, 4575.542445755398, 4814.662973591885, 4829.830955916596, 4904.239842824368, 2497.126005897921, 2586.719573810976, 2597.4545345477663, 2683.9597406038924, 2754.380264440485, 5048.192289233705, 5448.618596698193, 5594.580406469531, 5596.86007849807, 5623.493885550321, 4931.506849315111, 5149.922751158736, 5415.918761218585, 5524.177021582868, 5526.551126343332, 5116.539511443988, 5591.63654362457, 5594.748236329294, 5670.53331800668, 5747.597668163188, 4580.564846339593, 4591.770411479346, 4849.660523763303, 5079.009593129452, 5320.9467905322, 5237.554807841376, 5240.973795131, 5244.632875698664, 5291.788328466972, 5315.681059136464, 4864.562189402971, 5562.276904002454, 5573.498385145356, 5579.0, 5659.9151012735665, 3799.6580307772433, 3866.6326698963553, 3926.469926559878, 4141.937870931878, 4178.603032712009, 5054.0, 5266.420693723764, 5283.471652834686, 5382.3541175059245, 5385.980257403474, 4511.390962220058, 5161.638685291993, 5162.664426812245, 5224.0, 5286.471352864836, 4495.370648109202, 4542.159700455426, 4720.693154944917, 5156.303898973591, 5175.92236116451, 4533.413305343103, 4667.033021931331, 4954.0, 5053.343065401475, 5105.7702403391195, 4669.369635099218, 4684.906301873875, 4847.903041939212, 4895.020995800925, 5368.919466208088, 4556.635469162393, 4680.882977925579, 4725.36207611968, 5023.4725353838785, 5053.595712343077], "value": 3924.75485630741, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.2815710995995, 758.7344429449694, 818.9140140285269, 823.4606332851984, 830.207152169678, 14935.925320373397, 15726.685466290668, 15745.370185192578, 15749.212539373015, 15817.446389376375, 14173.92913035436, 14290.285485725699, 14291.285435728223, 14304.927130465205, 14312.499062532814, 933.3606479561488, 953.8378475659155, 954.4988880837547, 955.106974978394, 961.2454223434605, 936.7845395559026, 948.2271948362097, 966.6858271061898, 967.5017366056486, 988.7132731507854, 1016.2124353625962, 1020.1634659579148, 1020.4183615339259, 1021.8416145497459, 1024.4263212600931, 1008.1128606825946, 1013.7313611892818, 1014.1177175857015, 1014.3964341216964, 1016.7915577306709, 759.3279947246726, 761.5202422473861, 764.5412752348602, 764.6062277926873, 770.6339488742858, 14206.934479914047, 14573.70852582953, 15240.618984525365, 15867.730581553447, 15874.761878571831, 13661.590152295446, 13952.930235348758, 14140.787888181685, 14176.50382236627, 14248.928755356157, 11660.708482287926, 11728.003119734833, 11848.644540663794, 12018.759624807455, 12125.818112728317, 3591.856325746967, 3645.343838109139, 3679.1537946272238, 3776.6412190841825, 3788.4317352397084, 102468.0, 102551.0, 104596.0, 104799.0, 105046.47476762644, 10134.391936483687, 10457.0, 10585.470726463645, 10586.52360643773, 10853.945730271298, 21941.890290548763, 22215.0, 22217.0, 22436.887815560818, 22487.437814054778, 7314.305141011595, 7405.44459165554, 7416.814579635445, 7455.4408419368765, 7541.321281084729, 3956.8812935611977, 4104.343305071234, 4104.753714777123, 4110.280700877334, 4113.876583702434, 3042.5243756777945, 3258.315753691704, 3271.525628783813, 3336.0, 3368.9663103368653, 525.5427777833233, 608.8082254089948, 614.618936259522, 615.5383462403198, 626.9341719119518, 638.4636904999729, 664.9700763465655, 666.167290886392, 704.9506534542635, 711.2673945835797, 8565.357598180162, 9677.37097088701, 9851.655192068243, 10017.499125043718, 10183.065217608631, 586.9791925311581, 593.7981086430634, 627.3318915355223, 628.6636649392644, 640.2445114764622, 3904.4533765272886, 4865.805367785249, 4898.926516102261, 4904.901901961941, 4924.285978533093, 94536.0, 96866.0, 97590.0, 97793.51103244438, 98143.0, 55095.449045509835, 61221.77556448846, 63593.0, 66418.66790666113, 79193.20806791974, 57753.18195906622, 70333.0, 71985.0, 75477.62261188659, 76490.85263721048, 8718.476891386537, 10207.489625518843, 10629.468526573486, 10720.892791071989, 10732.570697172338, 45590.77204613956, 46017.76991115023, 46426.0, 47037.58887233389, 47141.0, 59239.0, 59555.404445956716, 60374.0, 60668.69665651643, 61016.08475872777, 11784.882151178379, 11955.880441195477, 11996.340201289013, 12115.273083615011, 12123.211991220542, 13783.862161378258, 13875.028747987544, 13916.26046744157, 13981.161130332213, 13992.440302388197, 13020.934895325463, 13142.671433214246, 13147.737045259233, 13198.20810751358, 13240.337983100613, 12872.270677289209, 13069.869301306866, 13175.47298108065, 13219.867801322249, 13479.460821567027, 12275.324857132944, 12632.810507842574, 12636.747265054464, 12830.29433381173, 13002.934985325013, 10574.84137737919, 10665.36007839532, 10780.137588993019, 10803.621873234713, 11352.318860868374, 8716.518191907264, 10283.331583447052, 10787.0, 10853.25562680874, 10966.342019478856], "value": 7371.111126004345, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1467.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 173.0, 115.0, 116.0, 116.0, 115.0, 116.0, 115.0, 114.0, 116.0], "value": 125.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 113.0, 110.0, 147.0, 113.0, 111.0, 119.0, 103.0, 157.0, 138.0], "value": 125.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 185.0, 184.0, 178.0, 181.0, 192.0, 184.0, 184.0, 182.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 61.0, 91.0, 64.0, 63.0, 59.0, 60.0, 78.0, 61.0], "value": 67.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 88.0, 73.0, 71.0, 70.0, 85.0, 69.0, 69.0, 86.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 87.0, 87.0, 87.0, 87.0, 87.0, 87.0, 88.0], "value": 87.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 135.0, 150.0, 94.0, 95.0, 97.0, 96.0, 93.0], "value": 104.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 86.0, 86.0, 86.0, 85.0, 86.0, 83.0, 86.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 60.0, 60.0, 62.0, 62.0, 63.0, 59.0, 60.0, 60.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 65.0, 56.0, 64.0, 60.0, 57.0, 58.0, 62.0, 59.0, 58.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 88.0, 87.0, 86.0, 87.0, 93.0, 104.0, 103.0, 89.0], "value": 91.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 150.0, 148.0, 143.0, 141.0, 129.0, 139.0, 140.0, 184.0, 157.0], "value": 147.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 230.0, 176.0, 171.0, 183.0, 170.0, 170.0, 170.0, 172.0, 171.0], "value": 178.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 79.0, 82.0, 83.0, 84.0, 68.0, 65.0, 67.0, 66.0], "value": 73.3, "unit": "score"}]}]} 16:33:48 INFO - Return code: 0 16:33:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:33:48 ERROR - # TBPL SUCCESS # 16:33:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:33:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:33:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:33:48 INFO - 2017-03-06 16:33:48.259 screenresolution[1654:10868] starting screenresolution argv=screenresolution get 16:33:48 INFO - 2017-03-06 16:33:48.262 screenresolution[1654:10868] Display 0: 1600x1200x32@60 16:33:48 INFO - 2017-03-06 16:33:48.268 screenresolution[1655:10871] starting screenresolution argv=screenresolution list 16:33:48 INFO - Available Modes on Display 0 16:33:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:33:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:33:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:33:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:33:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:33:48 INFO - Intel Iris: 16:33:48 INFO - Chipset Model: Intel Iris 16:33:48 INFO - Type: GPU 16:33:48 INFO - Bus: Built-In 16:33:48 INFO - VRAM (Dynamic, Max): 1536 MB 16:33:48 INFO - Vendor: Intel (0x8086) 16:33:48 INFO - Device ID: 0x0a2e 16:33:48 INFO - Revision ID: 0x0009 16:33:48 INFO - Displays: 16:33:48 INFO - Display: 16:33:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:33:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:33:48 INFO - Display Serial Number: 1600x1200 60 16:33:48 INFO - Main Display: Yes 16:33:48 INFO - Mirror: Off 16:33:48 INFO - Online: Yes 16:33:48 INFO - Rotation: Supported 16:33:48 INFO - Return code: 0 16:33:48 INFO - Running post-action listener: _resource_record_post_action 16:33:48 INFO - [mozharness: 2017-03-07 00:33:48.506241Z] Finished run-tests step (success) 16:33:48 INFO - Running post-run listener: _resource_record_post_run 16:33:48 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 6470656; Write bytes: 514443264; Read time: 61; Write time: 1604 16:33:48 INFO - TinderboxPrint: CPU usage
54.0% 16:33:48 INFO - TinderboxPrint: I/O read bytes / time
6,470,656 / 61 16:33:48 INFO - TinderboxPrint: I/O write bytes / time
514,443,264 / 1,604 16:33:48 INFO - TinderboxPrint: CPU idle
2,214.1 (46.0%) 16:33:48 INFO - TinderboxPrint: CPU system
962.7 (20.0%) 16:33:48 INFO - TinderboxPrint: CPU user
1,640.8 (34.1%) 16:33:48 INFO - TinderboxPrint: Swap in / out
239,706,112 / 0 16:33:48 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205584896; Write bytes: 201158656; Read time: 15543; Write time: 381 16:33:48 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 4496384; Write bytes: 302520320; Read time: 40; Write time: 1186 16:33:49 INFO - Running post-run listener: _upload_blobber_files 16:33:49 INFO - Blob upload gear active. 16:33:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:33:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:33:49 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'] 16:33:49 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 16:33:49 INFO - (blobuploader) - INFO - Open directory for files ... 16:33:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:33:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:33:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:50 INFO - (blobuploader) - INFO - Done attempting. 16:33:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:33:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:33:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:51 INFO - (blobuploader) - INFO - Done attempting. 16:33:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:33:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:33:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:52 INFO - (blobuploader) - INFO - Done attempting. 16:33:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:33:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:33:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:54 INFO - (blobuploader) - INFO - Done attempting. 16:33:54 INFO - (blobuploader) - INFO - Iteration through files over. 16:33:54 INFO - Return code: 0 16:33:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:33:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:33:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/832988d1cd945fce27e20ec163cf3679550265df3705d82fd6c28a4d46f6ce46f65dc38b7de429550cd7514a4145ada0cedb0bd9ce597029f91d7b46f60a2fae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a2f261c6cf0be26bf3f23d2b08a638bf4fb4d06aec8973d064d87dc632597f06632c9fde72de1f1ba791468b2f83bcc45734a95798e463d1b9470cfabfda545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6bd5c66a021b19b2aec8603a35ddbb421135e80ff6b678e35aa1d08094870e810e75363d50fa2882afb0fb8443b2f35892de2bc0840cfa0efa4e37b620666764", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/137f6aa27c29ea83cc70c1471f61216dddfa980d9761aa7cd87a53b3b842ac22d5f80817cedc315e9dfaa65f51fa5809fdfbbba30290269e2d55e4bcd03a4a40"} 16:33:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:33:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:33:54 INFO - Contents: 16:33:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/832988d1cd945fce27e20ec163cf3679550265df3705d82fd6c28a4d46f6ce46f65dc38b7de429550cd7514a4145ada0cedb0bd9ce597029f91d7b46f60a2fae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a2f261c6cf0be26bf3f23d2b08a638bf4fb4d06aec8973d064d87dc632597f06632c9fde72de1f1ba791468b2f83bcc45734a95798e463d1b9470cfabfda545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6bd5c66a021b19b2aec8603a35ddbb421135e80ff6b678e35aa1d08094870e810e75363d50fa2882afb0fb8443b2f35892de2bc0840cfa0efa4e37b620666764", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/137f6aa27c29ea83cc70c1471f61216dddfa980d9761aa7cd87a53b3b842ac22d5f80817cedc315e9dfaa65f51fa5809fdfbbba30290269e2d55e4bcd03a4a40"} 16:33:54 INFO - Running post-run listener: copy_logs_to_upload_dir 16:33:54 INFO - Copying logs to upload dir... 16:33:54 INFO - mkdir: /builds/slave/test/build/upload/logs 16:33:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.125194 ========= master_lag: 3.47 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-03-06 16:33:58.161595) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-06 16:33:58.165861) ========= 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.a4zvYjiwre/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.HpLxblpaLH/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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/832988d1cd945fce27e20ec163cf3679550265df3705d82fd6c28a4d46f6ce46f65dc38b7de429550cd7514a4145ada0cedb0bd9ce597029f91d7b46f60a2fae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a2f261c6cf0be26bf3f23d2b08a638bf4fb4d06aec8973d064d87dc632597f06632c9fde72de1f1ba791468b2f83bcc45734a95798e463d1b9470cfabfda545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6bd5c66a021b19b2aec8603a35ddbb421135e80ff6b678e35aa1d08094870e810e75363d50fa2882afb0fb8443b2f35892de2bc0840cfa0efa4e37b620666764", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/137f6aa27c29ea83cc70c1471f61216dddfa980d9761aa7cd87a53b3b842ac22d5f80817cedc315e9dfaa65f51fa5809fdfbbba30290269e2d55e4bcd03a4a40"} build_url:https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010989 build_url: 'https://queue.taskcluster.net/v1/task/LJCjTg4aSKueXDLXNYuA5A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/832988d1cd945fce27e20ec163cf3679550265df3705d82fd6c28a4d46f6ce46f65dc38b7de429550cd7514a4145ada0cedb0bd9ce597029f91d7b46f60a2fae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a2f261c6cf0be26bf3f23d2b08a638bf4fb4d06aec8973d064d87dc632597f06632c9fde72de1f1ba791468b2f83bcc45734a95798e463d1b9470cfabfda545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6bd5c66a021b19b2aec8603a35ddbb421135e80ff6b678e35aa1d08094870e810e75363d50fa2882afb0fb8443b2f35892de2bc0840cfa0efa4e37b620666764", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/137f6aa27c29ea83cc70c1471f61216dddfa980d9761aa7cd87a53b3b842ac22d5f80817cedc315e9dfaa65f51fa5809fdfbbba30290269e2d55e4bcd03a4a40"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-06 16:33:58.208432) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 16:33:58.314425) ========= 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.a4zvYjiwre/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.HpLxblpaLH/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.005196 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 16:33:58.341440) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-06 16:33:58.341751) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-06 16:33:58.342091) ========= ========= Total master_lag: 3.60 =========