builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0245 starttime: 1477459424.84 results: success (0) buildid: 20161025194124 builduid: 7d3c7cacde7b4713b03ee6cd96f233df revision: a16ab27e533088e1711a82ff380d3ebd262ca837 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 22:23:44.843478) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 22:23:44.844015) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 22:23:44.844358) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 22:23:44.868926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 22:23:44.869277) ========= 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.iXIXq8B3jz/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.CZRoQw0Nwr/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-25 22:23:44-- 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% 29.1M=0s 2016-10-25 22:23:44 (29.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089736 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 22:23:44.981472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 22:23:44.982018) ========= 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.iXIXq8B3jz/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.CZRoQw0Nwr/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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.028399 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 22:23:45.031495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 22:23:45.031913) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a16ab27e533088e1711a82ff380d3ebd262ca837 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a16ab27e533088e1711a82ff380d3ebd262ca837 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iXIXq8B3jz/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.CZRoQw0Nwr/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-25 22:23:45,115 truncating revision to first 12 chars 2016-10-25 22:23:45,116 Setting DEBUG logging. 2016-10-25 22:23:45,116 attempt 1/10 2016-10-25 22:23:45,116 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a16ab27e5330?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 22:23:46,479 unpacking tar archive at: mozilla-aurora-a16ab27e5330/testing/mozharness/ program finished with exit code 0 elapsedTime=1.635034 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 22:23:46.689770) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 22:23:46.690145) ========= script_repo_revision: a16ab27e533088e1711a82ff380d3ebd262ca837 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 22:23:46.690629) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 22:23:46.690935) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 22:23:46.710141) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-25 22:23:46.710614) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iXIXq8B3jz/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.CZRoQw0Nwr/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 22:23:46 INFO - MultiFileLogger online at 20161025 22:23:46 in /builds/slave/test 22:23:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 22:23:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:23:46 INFO - {'append_to_log': False, 22:23:46 INFO - 'base_work_dir': '/builds/slave/test', 22:23:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:23:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:23:46 INFO - 'branch': 'Mozilla-Aurora', 22:23:46 INFO - 'buildbot_json_path': 'buildprops.json', 22:23:46 INFO - 'config_files': ('talos/mac_config.py',), 22:23:46 INFO - 'default_actions': ('clobber', 22:23:46 INFO - 'read-buildbot-config', 22:23:46 INFO - 'download-and-extract', 22:23:46 INFO - 'populate-webroot', 22:23:46 INFO - 'create-virtualenv', 22:23:46 INFO - 'install', 22:23:46 INFO - 'run-tests'), 22:23:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:23:46 INFO - 'download_minidump_stackwalk': True, 22:23:46 INFO - 'download_symbols': 'ondemand', 22:23:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:23:46 INFO - 'tooltool.py': '/tools/tooltool.py', 22:23:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:23:46 INFO - '/tools/misc-python/virtualenv.py')}, 22:23:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:23:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:23:46 INFO - 'installer_path': 'installer.exe', 22:23:46 INFO - 'log_level': 'info', 22:23:46 INFO - 'log_name': 'talos', 22:23:46 INFO - 'log_to_console': True, 22:23:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:23:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:23:46 INFO - 'opt_config_files': (), 22:23:46 INFO - 'pip_index': False, 22:23:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:23:46 INFO - 'cmd': ('bash', 22:23:46 INFO - '-c', 22:23:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:23:46 INFO - 'enabled': True, 22:23:46 INFO - 'halt_on_failure': False, 22:23:46 INFO - 'name': 'check_screen_resolution'},), 22:23:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:23:46 INFO - 'cmd': ('bash', 22:23:46 INFO - '-c', 22:23:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:23:46 INFO - 'enabled': True, 22:23:46 INFO - 'halt_on_failure': False, 22:23:46 INFO - 'name': 'check_screen_resolution'},), 22:23:46 INFO - 'run_cmd_checks_enabled': True, 22:23:46 INFO - 'sps_profile': False, 22:23:46 INFO - 'sps_profile_interval': 0, 22:23:46 INFO - 'suite': 'dromaeojs', 22:23:46 INFO - 'system_bits': '32', 22:23:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:23:46 INFO - 'title': 't-yosemite-r7-0245', 22:23:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:23:46 INFO - 'use_talos_json': True, 22:23:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:23:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:23:46 INFO - 'work_dir': 'build'} 22:23:46 INFO - [mozharness: 2016-10-26 05:23:46.924524Z] Running clobber step. 22:23:46 INFO - Running pre-action listener: _resource_record_pre_action 22:23:46 INFO - Running main action method: clobber 22:23:46 INFO - rmtree: /builds/slave/test/build 22:23:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:23:49 INFO - Running post-action listener: _resource_record_post_action 22:23:49 INFO - [mozharness: 2016-10-26 05:23:49.352871Z] Finished clobber step (success) 22:23:49 INFO - [mozharness: 2016-10-26 05:23:49.352996Z] Running read-buildbot-config step. 22:23:49 INFO - Running pre-action listener: _resource_record_pre_action 22:23:49 INFO - Running main action method: read_buildbot_config 22:23:49 INFO - Using buildbot properties: 22:23:49 INFO - { 22:23:49 INFO - "project": "", 22:23:49 INFO - "product": "firefox", 22:23:49 INFO - "script_repo_revision": "production", 22:23:49 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 22:23:49 INFO - "repository": "", 22:23:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 22:23:49 INFO - "buildid": "20161025194124", 22:23:49 INFO - "pgo_build": "False", 22:23:49 INFO - "basedir": "/builds/slave/test", 22:23:49 INFO - "buildnumber": 66, 22:23:49 INFO - "slavename": "t-yosemite-r7-0245", 22:23:49 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 22:23:49 INFO - "platform": "yosemite_r7", 22:23:49 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 22:23:49 INFO - "branch": "mozilla-aurora", 22:23:49 INFO - "repo_path": "releases/mozilla-aurora", 22:23:49 INFO - "revision": "a16ab27e533088e1711a82ff380d3ebd262ca837", 22:23:49 INFO - "stage_platform": "macosx64", 22:23:49 INFO - "builduid": "7d3c7cacde7b4713b03ee6cd96f233df", 22:23:49 INFO - "slavebuilddir": "test" 22:23:49 INFO - } 22:23:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 22:23:49 INFO - Running post-action listener: _resource_record_post_action 22:23:49 INFO - [mozharness: 2016-10-26 05:23:49.356165Z] Finished read-buildbot-config step (success) 22:23:49 INFO - [mozharness: 2016-10-26 05:23:49.356282Z] Running download-and-extract step. 22:23:49 INFO - Running pre-action listener: _resource_record_pre_action 22:23:49 INFO - Running main action method: download_and_extract 22:23:49 INFO - mkdir: /builds/slave/test/build/tests 22:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:23:49 INFO - trying https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 22:23:49 INFO - Downloading https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 22:23:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 22:23:49 INFO - Downloaded 1199 bytes. 22:23:49 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 22:23:49 INFO - Using the following test package requirements: 22:23:49 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 22:23:49 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:23:49 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 22:23:49 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:23:49 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 22:23:49 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:23:49 INFO - u'jsshell-mac.zip'], 22:23:49 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:23:49 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 22:23:49 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 22:23:49 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:23:49 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 22:23:49 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:23:49 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 22:23:49 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:23:49 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 22:23:49 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 22:23:49 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 22:23:49 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 22:23:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 22:23:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 22:23:49 INFO - Fetch https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 22:23:50 INFO - Expected file size: 16420184 22:23:57 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 22:23:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 22:23:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 22:23:57 INFO - Fetch https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 22:23:57 INFO - Expected file size: 16420184 22:24:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 22:24:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 22:24:04 INFO - Fetch https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 22:24:05 INFO - Expected file size: 14414081 22:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:06 INFO - trying https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 22:24:06 INFO - Downloading https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 22:24:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 22:24:09 INFO - Downloaded 115426204 bytes. 22:24:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 22:24:09 INFO - mkdir: /builds/slave/test/properties 22:24:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:24:09 INFO - Writing to file /builds/slave/test/properties/build_url 22:24:09 INFO - Contents: 22:24:09 INFO - build_url:https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 22:24:10 INFO - Running post-action listener: _resource_record_post_action 22:24:10 INFO - Running post-action listener: set_extra_try_arguments 22:24:10 INFO - [mozharness: 2016-10-26 05:24:10.149496Z] Finished download-and-extract step (success) 22:24:10 INFO - [mozharness: 2016-10-26 05:24:10.149624Z] Running populate-webroot step. 22:24:10 INFO - Running pre-action listener: _resource_record_pre_action 22:24:10 INFO - Running main action method: populate_webroot 22:24:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:24:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:24:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:24:10 INFO - '--tppagecycles', 22:24:10 INFO - '7'], 22:24:10 INFO - 'tests': ['tsvgm']}}, 22:24:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:24:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:24:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:24:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:24:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:24:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:24:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:10 INFO - 'talos_options': ['--disable-e10s'], 22:24:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:24:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:24:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:10 INFO - 'talos_options': ['--disable-e10s'], 22:24:10 INFO - 'tests': ['damp', 'tps']}, 22:24:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:10 INFO - 'tests': ['damp', 'tps']}, 22:24:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:24:10 INFO - 'tests': ['dromaeo_dom']}, 22:24:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:24:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:24:10 INFO - 'tests': ['basic_compositor_video']}, 22:24:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:24:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:24:10 INFO - 'tests': ['a11yr', 22:24:10 INFO - 'ts_paint', 22:24:10 INFO - 'tpaint', 22:24:10 INFO - 'sessionrestore', 22:24:10 INFO - 'sessionrestore_no_auto_restore', 22:24:10 INFO - 'tabpaint']}, 22:24:10 INFO - 'other-e10s': {'tests': ['a11yr', 22:24:10 INFO - 'ts_paint', 22:24:10 INFO - 'tpaint', 22:24:10 INFO - 'sessionrestore', 22:24:10 INFO - 'sessionrestore_no_auto_restore', 22:24:10 INFO - 'tabpaint']}, 22:24:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:24:10 INFO - 'ts_paint', 22:24:10 INFO - 'tpaint', 22:24:10 INFO - 'sessionrestore', 22:24:10 INFO - 'sessionrestore_no_auto_restore', 22:24:10 INFO - 'tabpaint']}, 22:24:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:24:10 INFO - 'ts_paint', 22:24:10 INFO - 'tpaint', 22:24:10 INFO - 'sessionrestore', 22:24:10 INFO - 'sessionrestore_no_auto_restore', 22:24:10 INFO - 'tabpaint']}, 22:24:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:24:10 INFO - 'tests': ['a11yr', 22:24:10 INFO - 'ts_paint', 22:24:10 INFO - 'tpaint', 22:24:10 INFO - 'sessionrestore', 22:24:10 INFO - 'sessionrestore_no_auto_restore', 22:24:10 INFO - 'tabpaint']}, 22:24:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:24:10 INFO - 'tests': ['a11yr', 22:24:10 INFO - 'ts_paint', 22:24:10 INFO - 'tpaint', 22:24:10 INFO - 'sessionrestore', 22:24:10 INFO - 'sessionrestore_no_auto_restore', 22:24:10 INFO - 'tabpaint']}, 22:24:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:24:10 INFO - 'tests': ['tsvgx', 22:24:10 INFO - 'tsvgr_opacity', 22:24:10 INFO - 'tart', 22:24:10 INFO - 'tscrollx', 22:24:10 INFO - 'cart']}, 22:24:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:24:10 INFO - 'tsvgr_opacity', 22:24:10 INFO - 'tart', 22:24:10 INFO - 'tscrollx', 22:24:10 INFO - 'cart']}, 22:24:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:10 INFO - 'talos_options': ['--disable-e10s'], 22:24:10 INFO - 'tests': ['tp5o']}, 22:24:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:10 INFO - 'tests': ['tp5o']}, 22:24:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:10 INFO - 'talos_options': ['--disable-e10s', 22:24:10 INFO - '--xperf_path', 22:24:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:24:10 INFO - 'tests': ['tp5n']}, 22:24:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:10 INFO - 'talos_options': ['--xperf_path', 22:24:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:24:10 INFO - 'tests': ['tp5n']}}, 22:24:10 INFO - 'talos.zip': {'path': '', 22:24:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:24:10 INFO - Running post-action listener: _resource_record_post_action 22:24:10 INFO - [mozharness: 2016-10-26 05:24:10.168216Z] Finished populate-webroot step (success) 22:24:10 INFO - [mozharness: 2016-10-26 05:24:10.168303Z] Running create-virtualenv step. 22:24:10 INFO - Running pre-action listener: _resource_record_pre_action 22:24:10 INFO - Running main action method: create_virtualenv 22:24:10 INFO - Creating virtualenv /builds/slave/test/build/venv 22:24:10 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 22:24:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:24:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:24:10 INFO - Using real prefix '/tools/python27' 22:24:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:24:11 INFO - Installing distribute.............................................................................................................................................................................................done. 22:24:13 INFO - Installing pip.................done. 22:24:13 INFO - Return code: 0 22:24:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:24:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10caf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a949a500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c904d30>, '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 0x10c76adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fcb20>, '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.iXIXq8B3jz/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.CZRoQw0Nwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 22:24:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:24:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXIXq8B3jz/Render', 22:24:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:24:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:24:13 INFO - 'HOME': '/Users/cltbld', 22:24:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:24:13 INFO - 'LOGNAME': 'cltbld', 22:24:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:13 INFO - 'MOZ_NO_REMOTE': '1', 22:24:13 INFO - 'NO_EM_RESTART': '1', 22:24:13 INFO - 'PAGER': '/bin/cat', 22:24:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:24:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:13 INFO - 'PWD': '/builds/slave/test', 22:24:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:24:13 INFO - 'SHELL': '/bin/bash', 22:24:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CZRoQw0Nwr/Listeners', 22:24:13 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 22:24:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:24:13 INFO - 'USER': 'cltbld', 22:24:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:24:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:24:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:13 INFO - 'XPC_FLAGS': '0x0', 22:24:13 INFO - 'XPC_SERVICE_NAME': '0', 22:24:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:14 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 22:24:14 INFO - Cleaning up... 22:24:14 INFO - Return code: 0 22:24:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:24: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')]} 22:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24: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')]} 22:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24: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', '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 0x10caf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a949a500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c904d30>, '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 0x10c76adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fcb20>, '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.iXIXq8B3jz/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.CZRoQw0Nwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 22:24: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', 'psutil>=3.1.1'] in /builds/slave/test/build 22:24: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 psutil>=3.1.1 22:24:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXIXq8B3jz/Render', 22:24:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:24:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:24:14 INFO - 'HOME': '/Users/cltbld', 22:24:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:24:14 INFO - 'LOGNAME': 'cltbld', 22:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:14 INFO - 'MOZ_NO_REMOTE': '1', 22:24:14 INFO - 'NO_EM_RESTART': '1', 22:24:14 INFO - 'PAGER': '/bin/cat', 22:24:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:14 INFO - 'PWD': '/builds/slave/test', 22:24:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:24:14 INFO - 'SHELL': '/bin/bash', 22:24:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CZRoQw0Nwr/Listeners', 22:24:14 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 22:24:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:24:14 INFO - 'USER': 'cltbld', 22:24:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:24:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:14 INFO - 'XPC_FLAGS': '0x0', 22:24:14 INFO - 'XPC_SERVICE_NAME': '0', 22:24:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:14 INFO - Downloading/unpacking psutil>=3.1.1 22:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:24:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:24:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:24:17 INFO - Installing collected packages: psutil 22:24:17 INFO - Running setup.py install for psutil 22:24:18 INFO - building 'psutil._psutil_osx' extension 22:24:18 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 22:24:18 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 22:24:18 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 22:24:18 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 22:24:18 INFO - building 'psutil._psutil_posix' extension 22:24:18 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 22:24:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:24:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:24:18 INFO - ^ 22:24:18 INFO - 1 warning generated. 22:24:18 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 22:24:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:24:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:24:19 INFO - Successfully installed psutil 22:24:19 INFO - Cleaning up... 22:24:19 INFO - Return code: 0 22:24:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:24:19 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')]} 22:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:19 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')]} 22:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:19 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 0x10caf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a949a500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c904d30>, '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 0x10c76adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fcb20>, '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.iXIXq8B3jz/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.CZRoQw0Nwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 22:24:19 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 22:24:19 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 22:24:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXIXq8B3jz/Render', 22:24:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:24:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:24:19 INFO - 'HOME': '/Users/cltbld', 22:24:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:24:19 INFO - 'LOGNAME': 'cltbld', 22:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:19 INFO - 'MOZ_NO_REMOTE': '1', 22:24:19 INFO - 'NO_EM_RESTART': '1', 22:24:19 INFO - 'PAGER': '/bin/cat', 22:24:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:19 INFO - 'PWD': '/builds/slave/test', 22:24:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:24:19 INFO - 'SHELL': '/bin/bash', 22:24:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CZRoQw0Nwr/Listeners', 22:24:19 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 22:24:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:24:19 INFO - 'USER': 'cltbld', 22:24:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:24:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:19 INFO - 'XPC_FLAGS': '0x0', 22:24:19 INFO - 'XPC_SERVICE_NAME': '0', 22:24:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:24:19 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 22:24:19 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 22:24:19 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 22:24:19 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 22:24:19 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 22:24:19 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 22:24:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:24:22 INFO - Installing collected packages: mozsystemmonitor 22:24:22 INFO - Running setup.py install for mozsystemmonitor 22:24:22 INFO - Successfully installed mozsystemmonitor 22:24:22 INFO - Cleaning up... 22:24:22 INFO - Return code: 0 22:24:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:22 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 0x10caf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a949a500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c904d30>, '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 0x10c76adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fcb20>, '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.iXIXq8B3jz/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.CZRoQw0Nwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 22:24:22 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 22:24:22 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 22:24:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXIXq8B3jz/Render', 22:24:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:24:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:24:22 INFO - 'HOME': '/Users/cltbld', 22:24:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:24:22 INFO - 'LOGNAME': 'cltbld', 22:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:22 INFO - 'MOZ_NO_REMOTE': '1', 22:24:22 INFO - 'NO_EM_RESTART': '1', 22:24:22 INFO - 'PAGER': '/bin/cat', 22:24:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:22 INFO - 'PWD': '/builds/slave/test', 22:24:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:24:22 INFO - 'SHELL': '/bin/bash', 22:24:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CZRoQw0Nwr/Listeners', 22:24:22 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 22:24:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:24:22 INFO - 'USER': 'cltbld', 22:24:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:24:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:22 INFO - 'XPC_FLAGS': '0x0', 22:24:22 INFO - 'XPC_SERVICE_NAME': '0', 22:24:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:22 INFO - Downloading/unpacking jsonschema==2.5.1 22:24:22 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 22:24:22 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 22:24:22 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 22:24:22 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 22:24:22 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 22:24:22 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 22:24:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:24:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:24:25 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 22:24:25 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 22:24:25 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 22:24:25 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 22:24:25 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 22:24:25 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 22:24:25 INFO - Downloading functools32-3.2.3-2.tar.gz 22:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:24:25 INFO - warning: no files found matching '*.txt' 22:24:25 INFO - no previously-included directories found matching 'build' 22:24:25 INFO - no previously-included directories found matching 'dist' 22:24:25 INFO - no previously-included directories found matching '.git*' 22:24:25 INFO - Installing collected packages: jsonschema, functools32 22:24:25 INFO - Running setup.py install for functools32 22:24:25 INFO - warning: no files found matching '*.txt' 22:24:25 INFO - no previously-included directories found matching 'build' 22:24:25 INFO - no previously-included directories found matching 'dist' 22:24:25 INFO - no previously-included directories found matching '.git*' 22:24:25 INFO - Successfully installed jsonschema functools32 22:24:25 INFO - Cleaning up... 22:24:25 INFO - Return code: 0 22:24:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:24:25 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')]} 22:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:25 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')]} 22:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:25 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 0x10caf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a949a500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c904d30>, '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 0x10c76adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fcb20>, '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.iXIXq8B3jz/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.CZRoQw0Nwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 22:24:25 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 22:24:25 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 22:24:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXIXq8B3jz/Render', 22:24:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:24:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:24:25 INFO - 'HOME': '/Users/cltbld', 22:24:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:24:25 INFO - 'LOGNAME': 'cltbld', 22:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:25 INFO - 'MOZ_NO_REMOTE': '1', 22:24:25 INFO - 'NO_EM_RESTART': '1', 22:24:25 INFO - 'PAGER': '/bin/cat', 22:24:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:25 INFO - 'PWD': '/builds/slave/test', 22:24:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:24:25 INFO - 'SHELL': '/bin/bash', 22:24:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CZRoQw0Nwr/Listeners', 22:24:25 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 22:24:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:24:25 INFO - 'USER': 'cltbld', 22:24:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:24:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:25 INFO - 'XPC_FLAGS': '0x0', 22:24:25 INFO - 'XPC_SERVICE_NAME': '0', 22:24:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:24:26 INFO - Cleaning up... 22:24:26 INFO - Return code: 0 22:24:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:24:26 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')]} 22:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:26 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')]} 22:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:26 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 0x10caf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a949a500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c904d30>, '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 0x10c76adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fcb20>, '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.iXIXq8B3jz/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.CZRoQw0Nwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 22:24:26 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 22:24:26 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 22:24:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXIXq8B3jz/Render', 22:24:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:24:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:24:26 INFO - 'HOME': '/Users/cltbld', 22:24:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:24:26 INFO - 'LOGNAME': 'cltbld', 22:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:26 INFO - 'MOZ_NO_REMOTE': '1', 22:24:26 INFO - 'NO_EM_RESTART': '1', 22:24:26 INFO - 'PAGER': '/bin/cat', 22:24:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:26 INFO - 'PWD': '/builds/slave/test', 22:24:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:24:26 INFO - 'SHELL': '/bin/bash', 22:24:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CZRoQw0Nwr/Listeners', 22:24:26 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 22:24:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:24:26 INFO - 'USER': 'cltbld', 22:24:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:24:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:26 INFO - 'XPC_FLAGS': '0x0', 22:24:26 INFO - 'XPC_SERVICE_NAME': '0', 22:24:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:26 INFO - Downloading/unpacking blobuploader==1.2.4 22:24:26 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 22:24:26 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 22:24:26 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 22:24:26 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 22:24:26 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 22:24:26 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 22:24:28 INFO - Downloading blobuploader-1.2.4.tar.gz 22:24:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:24:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:24:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:30 INFO - Downloading docopt-0.6.1.tar.gz 22:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:24:30 INFO - Installing collected packages: blobuploader, requests, docopt 22:24:30 INFO - Running setup.py install for blobuploader 22:24:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:24:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:24:30 INFO - Running setup.py install for requests 22:24:30 INFO - Running setup.py install for docopt 22:24:31 INFO - Successfully installed blobuploader requests docopt 22:24:31 INFO - Cleaning up... 22:24:31 INFO - Return code: 0 22:24:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24: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')]} 22:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24: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')]} 22:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:31 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 0x10caf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a949a500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c904d30>, '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 0x10c76adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fcb20>, '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.iXIXq8B3jz/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.CZRoQw0Nwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 22:24:31 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 22:24:31 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 22:24:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXIXq8B3jz/Render', 22:24:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:24:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:24:31 INFO - 'HOME': '/Users/cltbld', 22:24:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:24:31 INFO - 'LOGNAME': 'cltbld', 22:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:31 INFO - 'MOZ_NO_REMOTE': '1', 22:24:31 INFO - 'NO_EM_RESTART': '1', 22:24:31 INFO - 'PAGER': '/bin/cat', 22:24:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:31 INFO - 'PWD': '/builds/slave/test', 22:24:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:24:31 INFO - 'SHELL': '/bin/bash', 22:24:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CZRoQw0Nwr/Listeners', 22:24:31 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 22:24:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:24:31 INFO - 'USER': 'cltbld', 22:24:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:24:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:31 INFO - 'XPC_FLAGS': '0x0', 22:24:31 INFO - 'XPC_SERVICE_NAME': '0', 22:24:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:24:31 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-0xZU7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:24:31 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-W53nEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:24:31 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-EJUQ93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:24:31 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-fxfHkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:24:31 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-_r1rzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:24:31 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-2Tgj8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:24:32 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-4cUl3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:24:32 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-tnxCNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:24:32 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-sAebI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:24:32 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-kxIT7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:24:32 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-cNUOeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:24:32 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-ZYY9AV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:24:32 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-UcrzrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:24:32 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-DHU6pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:32 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-9Fd6Ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:24:32 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-YoTe7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:24:33 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-oE4yiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:24:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:24:33 INFO - Running setup.py install for manifestparser 22:24:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:24:33 INFO - Running setup.py install for mozcrash 22:24:33 INFO - Running setup.py install for mozdebug 22:24:33 INFO - Running setup.py install for mozdevice 22:24:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:24:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:24:33 INFO - Running setup.py install for mozfile 22:24:33 INFO - Running setup.py install for mozhttpd 22:24:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:24:34 INFO - Running setup.py install for mozinfo 22:24:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:24:34 INFO - Running setup.py install for mozInstall 22:24:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:24:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:24:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:24:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:24:34 INFO - Running setup.py install for mozleak 22:24:34 INFO - Running setup.py install for mozlog 22:24:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:24:34 INFO - Running setup.py install for moznetwork 22:24:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:24:34 INFO - Running setup.py install for mozprocess 22:24:34 INFO - Running setup.py install for mozprofile 22:24:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:24:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:24:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:24:35 INFO - Running setup.py install for mozrunner 22:24:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:24:35 INFO - Running setup.py install for mozscreenshot 22:24:35 INFO - Running setup.py install for moztest 22:24:35 INFO - Running setup.py install for mozversion 22:24:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:24:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:24:35 INFO - Cleaning up... 22:24:35 INFO - Return code: 0 22:24:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24:35 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')]} 22:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:35 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')]} 22:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:35 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 0x10caf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a949a500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c904d30>, '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 0x10c76adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fcb20>, '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.iXIXq8B3jz/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.CZRoQw0Nwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 22:24:35 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 22:24:35 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 22:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXIXq8B3jz/Render', 22:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:24:35 INFO - 'HOME': '/Users/cltbld', 22:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:24:35 INFO - 'LOGNAME': 'cltbld', 22:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:35 INFO - 'MOZ_NO_REMOTE': '1', 22:24:35 INFO - 'NO_EM_RESTART': '1', 22:24:35 INFO - 'PAGER': '/bin/cat', 22:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:35 INFO - 'PWD': '/builds/slave/test', 22:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:24:35 INFO - 'SHELL': '/bin/bash', 22:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CZRoQw0Nwr/Listeners', 22:24:35 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 22:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:24:35 INFO - 'USER': 'cltbld', 22:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:35 INFO - 'XPC_FLAGS': '0x0', 22:24:35 INFO - 'XPC_SERVICE_NAME': '0', 22:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:24:35 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-50TA9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:24:36 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)) 22:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:24:36 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-OhynC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:24:36 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-p_0bfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:24:36 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)) 22:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:24:36 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-F86_IE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:24:36 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-FBJaTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:24:36 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)) 22:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:24:36 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-KUqbtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:24:36 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)) 22:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:24:36 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-lQzb8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:24:36 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)) 22:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:24:36 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-ozEqYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:24:36 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)) 22:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:24:36 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-S1XPUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:24:36 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)) 22:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:24:36 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-Vy1yJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:24:37 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)) 22:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:24:37 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-ek32HI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:24:37 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)) 22:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:24:37 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-EqHHwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:24:37 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-0UrEuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:24:37 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)) 22:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:24:37 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-hV58bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:37 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-RL39Zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:37 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)) 22:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:24:37 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-67Jn0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:24:37 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-ELhbjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:24:37 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)) 22:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:24:37 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)) 22:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:24:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:40 INFO - Downloading blessings-1.6.tar.gz 22:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:24:40 INFO - Installing collected packages: blessings 22:24:40 INFO - Running setup.py install for blessings 22:24:40 INFO - Successfully installed blessings 22:24:40 INFO - Cleaning up... 22:24:40 INFO - Return code: 0 22:24:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:24:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:24:40 INFO - Reading from file tmpfile_stdout 22:24:40 INFO - Current package versions: 22:24:40 INFO - blessings == 1.6 22:24:40 INFO - blobuploader == 1.2.4 22:24:40 INFO - docopt == 0.6.1 22:24:40 INFO - functools32 == 3.2.3-2 22:24:40 INFO - jsonschema == 2.5.1 22:24:40 INFO - manifestparser == 1.1 22:24:40 INFO - mozInstall == 1.12 22:24:40 INFO - mozcrash == 0.17 22:24:40 INFO - mozdebug == 0.1 22:24:40 INFO - mozdevice == 0.48 22:24:40 INFO - mozfile == 1.2 22:24:40 INFO - mozhttpd == 0.7 22:24:40 INFO - mozinfo == 0.9 22:24:40 INFO - mozleak == 0.1 22:24:40 INFO - mozlog == 3.4 22:24:40 INFO - moznetwork == 0.27 22:24:40 INFO - mozprocess == 0.23 22:24:40 INFO - mozprofile == 0.28 22:24:40 INFO - mozrunner == 6.12 22:24:40 INFO - mozscreenshot == 0.1 22:24:40 INFO - mozsystemmonitor == 0.3 22:24:40 INFO - moztest == 0.7 22:24:40 INFO - mozversion == 1.4 22:24:40 INFO - psutil == 3.1.1 22:24:40 INFO - requests == 1.2.3 22:24:40 INFO - wsgiref == 0.1.2 22:24:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24:40 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')]} 22:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:40 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')]} 22:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:40 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 0x10caf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a949a500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c904d30>, '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 0x10c76adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fcb20>, '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.iXIXq8B3jz/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.CZRoQw0Nwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 22:24:40 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 22:24:40 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 22:24:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXIXq8B3jz/Render', 22:24:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:24:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:24:40 INFO - 'HOME': '/Users/cltbld', 22:24:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:24:40 INFO - 'LOGNAME': 'cltbld', 22:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:40 INFO - 'MOZ_NO_REMOTE': '1', 22:24:40 INFO - 'NO_EM_RESTART': '1', 22:24:40 INFO - 'PAGER': '/bin/cat', 22:24:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:40 INFO - 'PWD': '/builds/slave/test', 22:24:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:24:40 INFO - 'SHELL': '/bin/bash', 22:24:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CZRoQw0Nwr/Listeners', 22:24:40 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 22:24:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:24:40 INFO - 'USER': 'cltbld', 22:24:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:24:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:40 INFO - 'XPC_FLAGS': '0x0', 22:24:40 INFO - 'XPC_SERVICE_NAME': '0', 22:24:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:41 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)) 22:24:41 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)) 22:24:41 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)) 22:24:41 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)) 22:24:41 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)) 22:24:41 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)) 22:24:41 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)) 22:24:41 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)) 22:24:41 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)) 22:24:41 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)) 22:24:41 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)) 22:24:41 INFO - Cleaning up... 22:24:41 INFO - Return code: 0 22:24:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:41 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 0x10caf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a949a500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c904d30>, '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 0x10c76adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fcb20>, '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.iXIXq8B3jz/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.CZRoQw0Nwr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 22:24:41 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 22:24:41 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 22:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXIXq8B3jz/Render', 22:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:24:41 INFO - 'HOME': '/Users/cltbld', 22:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:24:41 INFO - 'LOGNAME': 'cltbld', 22:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:41 INFO - 'MOZ_NO_REMOTE': '1', 22:24:41 INFO - 'NO_EM_RESTART': '1', 22:24:41 INFO - 'PAGER': '/bin/cat', 22:24:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:41 INFO - 'PWD': '/builds/slave/test', 22:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:24:41 INFO - 'SHELL': '/bin/bash', 22:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CZRoQw0Nwr/Listeners', 22:24:41 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 22:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:24:41 INFO - 'USER': 'cltbld', 22:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:41 INFO - 'XPC_FLAGS': '0x0', 22:24:41 INFO - 'XPC_SERVICE_NAME': '0', 22:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:24:41 INFO - Cleaning up... 22:24:41 INFO - Return code: 0 22:24:41 INFO - Running post-action listener: _resource_record_post_action 22:24:41 INFO - Running post-action listener: _start_resource_monitoring 22:24:41 INFO - Starting resource monitoring. 22:24:41 INFO - [mozharness: 2016-10-26 05:24:41.925180Z] Finished create-virtualenv step (success) 22:24:41 INFO - [mozharness: 2016-10-26 05:24:41.926159Z] Running install step. 22:24:41 INFO - Running pre-action listener: _resource_record_pre_action 22:24:41 INFO - Running main action method: install 22:24:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:24:42 INFO - Reading from file tmpfile_stdout 22:24:42 INFO - Detecting whether we're running mozinstall >=1.0... 22:24:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:24:42 INFO - Reading from file tmpfile_stdout 22:24:42 INFO - Output received: 22:24:42 INFO - Usage: mozinstall [options] installer 22:24:42 INFO - Options: 22:24:42 INFO - -h, --help show this help message and exit 22:24:42 INFO - -d DEST, --destination=DEST 22:24:42 INFO - Directory to install application into. [default: 22:24:42 INFO - "/builds/slave/test"] 22:24:42 INFO - --app=APP Application being installed. [default: firefox] 22:24:42 INFO - mkdir: /builds/slave/test/build/application 22:24:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 22:25:14 INFO - Reading from file tmpfile_stdout 22:25:14 INFO - Output received: 22:25:14 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 22:25:14 INFO - Running post-action listener: _resource_record_post_action 22:25:14 INFO - [mozharness: 2016-10-26 05:25:14.514502Z] Finished install step (success) 22:25:14 INFO - [mozharness: 2016-10-26 05:25:14.514631Z] Running run-tests step. 22:25:14 INFO - Running pre-action listener: _resource_record_pre_action 22:25:14 INFO - Running main action method: run_tests 22:25:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:25:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:25:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:25:14 INFO - 2016-10-25 22:25:14.527 screenresolution[1641:7454] starting screenresolution argv=screenresolution get 22:25:14 INFO - 2016-10-25 22:25:14.530 screenresolution[1641:7454] Display 0: 1600x1200x32@60 22:25:14 INFO - 2016-10-25 22:25:14.535 screenresolution[1642:7456] starting screenresolution argv=screenresolution list 22:25:14 INFO - Available Modes on Display 0 22:25:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:25:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:25:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:25:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:25:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:25:14 INFO - Intel Iris: 22:25:14 INFO - Chipset Model: Intel Iris 22:25:14 INFO - Type: GPU 22:25:14 INFO - Bus: Built-In 22:25:14 INFO - VRAM (Dynamic, Max): 1536 MB 22:25:14 INFO - Vendor: Intel (0x8086) 22:25:14 INFO - Device ID: 0x0a2e 22:25:14 INFO - Revision ID: 0x0009 22:25:14 INFO - Displays: 22:25:14 INFO - Display: 22:25:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:25:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:25:14 INFO - Display Serial Number: 1600x1200 60 22:25:14 INFO - Main Display: Yes 22:25:14 INFO - Mirror: Off 22:25:14 INFO - Online: Yes 22:25:14 INFO - Rotation: Supported 22:25:14 INFO - Return code: 0 22:25:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:25:14 INFO - Python 2.7.3 22:25:14 INFO - Return code: 0 22:25:14 INFO - grabbing minidump binary from tooltool 22:25: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')]} 22:25:14 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 0x10c904d30>, '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 0x10c76adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8fcb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:25:14 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 22:25:14 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 22:25:14 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 22:25:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:25:14 INFO - Return code: 0 22:25:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:25:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:25:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:25:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:25:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:25:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0245', '--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 22:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0245 --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 22:25:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXIXq8B3jz/Render', 22:25:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:25:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:25:14 INFO - 'HOME': '/Users/cltbld', 22:25:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:25:14 INFO - 'LOGNAME': 'cltbld', 22:25:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:25:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:14 INFO - 'MOZ_NO_REMOTE': '1', 22:25:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:25:14 INFO - 'NO_EM_RESTART': '1', 22:25:14 INFO - 'PAGER': '/bin/cat', 22:25:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:14 INFO - 'PWD': '/builds/slave/test', 22:25:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:25:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:25:14 INFO - 'SHELL': '/bin/bash', 22:25:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CZRoQw0Nwr/Listeners', 22:25:14 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 22:25:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:25:14 INFO - 'USER': 'cltbld', 22:25:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:25:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:14 INFO - 'XPC_FLAGS': '0x0', 22:25:14 INFO - 'XPC_SERVICE_NAME': '0', 22:25:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:25:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0245', '--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 22:25:15 INFO - mozversion application_buildid: 20161025194124 22:25:15 INFO - mozversion application_changeset: a16ab27e533088e1711a82ff380d3ebd262ca837 22:25:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:25:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:25:15 INFO - mozversion application_name: Firefox 22:25:15 INFO - mozversion application_remotingname: firefox-dev 22:25:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:25:15 INFO - mozversion application_vendor: Mozilla 22:25:15 INFO - mozversion application_version: 51.0a2 22:25:15 INFO - mozversion platform_buildid: 20161025194124 22:25:15 INFO - mozversion platform_changeset: a16ab27e533088e1711a82ff380d3ebd262ca837 22:25:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:25:15 INFO - mozversion platform_version: 51.0a2 22:25:15 INFO - using testdate: 1477459515 22:25:15 INFO - actual date: 1477459515 22:25:15 INFO - starting webserver on 'localhost:49272' 22:25:15 INFO - SUITE-START | Running 2 tests 22:25:15 INFO - TEST-START | dromaeo_css 22:25:15 INFO - operating with platform_type : mac_ 22:25:15 INFO - Initialising browser for dromaeo_css test... 22:25:15 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/tmpc3oTrg/profile http://localhost:49272/getInfo.html) 22:25:17 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 22:25:17 INFO - PROCESS | 1652 | colorDepth:24 22:25:17 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 22:25:17 INFO - PROCESS | 1652 | __metrics 22:25:17 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:25:17 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:25:18 INFO - TEST-INFO | 1652: exit 0 22:25:18 INFO - Browser initialized. 22:25:18 INFO - Running cycle 1/1 for dromaeo_css test... 22:25:18 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/tmpc3oTrg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:25:30 INFO - PROCESS | 1655 | RSS: Main: 219283456 22:25:30 INFO - PROCESS | 1655 | 22:26:21 INFO - PROCESS | 1655 | 1477459581293 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:28:33 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 22:28:34 INFO - PROCESS | 1655 | RSS: Main: 326647808 22:28:34 INFO - PROCESS | 1655 | 22:31:37 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 22:31:37 INFO - PROCESS | 1655 | RSS: Main: 350453760 22:31:37 INFO - PROCESS | 1655 | 22:34:40 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 22:34:40 INFO - PROCESS | 1655 | RSS: Main: 320577536 22:34:40 INFO - PROCESS | 1655 | 22:37:43 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 22:37:43 INFO - PROCESS | 1655 | RSS: Main: 342622208 22:37:43 INFO - PROCESS | 1655 | 22:40:47 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 22:40:47 INFO - PROCESS | 1655 | RSS: Main: 314044416 22:40:47 INFO - PROCESS | 1655 | 22:43:50 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 22:43:51 INFO - PROCESS | 1655 | RSS: Main: 358215680 22:43:51 INFO - PROCESS | 1655 | 22:43:51 INFO - PROCESS | 1655 | __start_tp_report 22:43:51 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 22:43:51 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 22:43:51 INFO - PROCESS | 1655 | |i|pagename|runs| 22:43:51 INFO - PROCESS | 1655 | |0;dojo.html;3345.180430794455;3345.548350972618;3390.4575267957116;3397.7791443556152;3430.3825311443948;5680.801171958977;5739.655620662763;5747.683877386748;5766;5775.047117225663;4752.7148371097755;5660.632058916168;5759.16492108644;5792.855178620536;5812.186293918855;5238.423773384925;5252.185911183773;5274.2879711238875;5311.521963023327;5331.413544510101;5210.062188806013;5221.503957124067;5355.678659280456;5357.544608708265;5412.269343638598;5220.347456567929;5255.605829562779;5263.499967503081;5296.25852380667;5302.522772950434;5288.101022826148;5322.33470816148;5361.624686271963;5362.490563396471;5379.1393377059485;5221.477852214786;5256.26412302278;5270.39390470097;5292.444293349181;5314.840554783363;5581.944180558183;5613.4386561343945;5634.85912852182;5639.2668953036255;5645.5483561314995;6116.457510225599;6212.782552610637;6221.564490485668;6229.813105606839;6239.563230573862;6263.968680156616;6306.590071645328;6353.872922541569;6365.045243213509;6373.203349581302;5685.829425117253;5732.828015159552;5752.9712351437975;5823.039198532279;5846.269216347957;6279.277883043417;6316.873662526816;6320.273168585672;6321.399467050623;6333.493320534439;6178.41305076026;6187.597806142587;6189.8452538686;6197;6197.25632924052;6103.0649381601115;6188.535859810532;6189.412005859436;6270;6304.05439184126;6204.441600255998;6260.624362538262;6290.182276304051;6292.874142517124;6307.4954003679595;6213.409726076015;6247.125402443661;6285.528585356116;6301;6305.274893387227;4865.172920603506;4896.4124305083615;4925.335079764186;4981.825636102792;5006.324146240211;4397.912041759147;4457.710248833815;4462.3306504024;4462.933056004163;4497.617702495325;5794.21778059965;5794.710264486759;5807.535397168301;5808.535317174616;5823.767049317979;6139.614800607318;6327.430531252117;6342.175517182736;6342.651154186472;6356.2054743157105;5080.517350851663;5633.380328163898;5702.54379649627;5782;5813.273340832396;5432.185172224198;5441.8095366662765;5450.645708028966;5457.508824205761;5472.179173124063;6347.143135676624;6351.17434733491;6358.1416508771645;6360.204974378203;6377.107204991212;6154.98442756958;6183;6192.876142477216;6245.344238854855;6255.71849266775;6304.590201636879;6321.589096708699;6324.2410910691015;6336.524760643062;6341;5119.769610367468;6185.628862268279;6190.907136393048;6203.100550420254;6204.751809927552;5018;5155.793768249228;6154.846128846635;6175.197224360984;6208.596441231305;5955.731992060454;6122.428649698624;6165;6177.938220617736;6182.041783523561;6145.10895920098;6166.229221347332;6167.290761562478;6169.84575385601;6169.907451388143;5712.143178523254;5869.090291004901;5900.881982360243;5907.2911250650195;5982.042873140276;6091.8523847348915;6158.753649853956;6167.907481387693;6174.351693072163;6198.318184999556;5790.073588225863;5943.494802941798;5956.880862382642;5995.160677505066;6011.87976240464 22:43:51 INFO - PROCESS | 1655 | |1;ext.html;510.7573902396362;514.9176131818905;515.1628603519281;544.3141641531671;545.7244091733673;31602.683973160263;41121.17757644849;42094;42174.367384489255;44661.55338446615;42523;42831.78584107083;43331.13337733252;43342.349864751974;43513.78243108788;8957.865632015524;9879.16027137694;10156.390616562992;10171.89828101717;10194.6941591752;8861.335399845037;10806.72983175419;11898.821517677241;12175;12617.936910315482;12402;12467.688307792332;12468.875311246862;12476.750464990695;12481;8925.375223734341;12412.317322547256;12509.749805003848;12528.436220370106;12529.624111276631;8734.388592798507;12000.57997970067;12305.323207223599;12307.56923507673;12569;39787.20425591501;41710.582894171275;42070.36894446586;42188.156236875395;42245.1550968982;3405.250844814137;3591.5690117185845;3672.57765356982;3964.385520244367;4020.9195816083516;30201.546976795365;30212.84893575518;30962.380752384826;31853.362932741446;32162.839185804154;3154.274516861135;3177.158053115903;3180.4275230458506;3327.2846338037198;3401.523786669868;439106.8044659788;516268;517633.82366176235;520848;521839;61397.38602614006;61716.382836171964;61917.07124393048;62014.37985620176;62017.68991155015;59067.40932590705;59087;59149;59150.816983660945;59338.70330648319;16609.335626575044;16875.324987000382;16875.746863797052;16876.240569174417;16921.49235522912;11760.529578816922;11975.700607484883;11977.401129943468;13028.153170043917;13073.673158171121;16951.830481695273;17163.056031918364;17306.394276200524;17483.388081417088;17765.289388424317;5438.972805136028;5881.470667639847;5979.252593425822;6016.42843929826;6131.846703832351;806.8144326804868;873.4148120759106;964.3056998960737;1002.0330381182195;1029.444100185906;29489.11532654024;30462.54306185409;30570.77716891344;30600.060950325413;31164.53253201204;1058.6294796821205;1060.8567843341204;1070.202698989258;1078.7087486378634;1161.848959635242;15757.68484630301;15769.605759855865;15895.284712187979;16225.432109876097;16575.585610359838;715305;717782;718936;719939;721141;59793;60062.699686501284;60181;60272.69863650654;60338.69830650819;1095.8684957805115;1222.5171057432265;1353.8510763816168;1379.7234562971178;1399.3772771116755;29569.408611828072;30439.175135199523;31115.68884311128;31628.683713162573;32117.197070073435;50850.74574627103;51387.48612513827;51546.22680659868;51579.74210128925;51605.741971289906;579545;585527;585972;586008;586738;26211.213663590122;27347;27349.179524614294;27947.860260698566;28071;47523;47712;48002.519974799805;48480.75759621179;48608.756956214995;39200.80399597984;39544.604553954094;39646.60353396429;39943;41292.79353603213;34932.126696831765;37802.810985945995;39270.607293926696;39826;40021;38598;39121.804390977864;39303.80348098241;39430.211395772494;39576.40635390414;33525.329493410485;34281.314373712885;34460.65539344575;35289.47065794066;35316.293674126886;23554.411139721644;25122.12072577451;25544.084193685176;25861.741382585933;25886.870565647052 22:43:51 INFO - PROCESS | 1655 | |2;jquery.html;352.8006676227931;354.58690625421383;379.05993137020204;383.73905744094014;407.4234957535088;14477.855221447782;14960.401583936644;15572;19694.916779577117;19954.600907981832;18672.346467873627;20112.59774804503;20219.39341819744;20727.274545390916;20921.9539023049;5616.213730077792;5654.547636189116;5860.736266868002;5865.442782935615;5870.471657550819;4401.427814384142;5706.1440783882545;5775.884482310351;5791.07342825148;5886.6468011919205;5431.2396264522995;5725.112607545816;5725.370209276976;5727.57043221758;5729.111987641902;5598.216249725042;5670.8015219467325;5704.543636509069;5715.514181294595;5722.769604535003;4759.762011899391;4942.110420124376;4984.800607975677;4990.8253211137435;5001.099802035632;23672.64491032636;24261.636075458882;24389.756102438925;24656.87671561631;24686.259412217663;2264.830137739676;2271.4434963434064;2317.9420514487106;2457.4839283750434;2509.4102885821817;9750.46372449515;9952.203823694088;10164.695059148238;10283.280170388076;10386.480675966171;1846.9353572624893;1921.5004098934237;1927.7975812539762;1930.6814375628005;1979.7525309336334;109285.45357273243;118393;121558;131707;132286.33856830752;11370.20408571392;11482.885171148182;11601.941990289995;11615.245009074382;11765;14517.274136293143;14529.636759080897;14542.418303267963;14560.563183104523;14600.634984125269;8482.787930301669;8602.526861022703;8612.784680382916;8636;8741.388102832869;6151.876962460815;6495.935040649628;8495.598226292592;8591.828163436696;8790.824183516293;4460.397846290774;4514.774261286988;4534.909301813946;4643.814247430132;4646.767661616906;1677.9077150756582;1746.9912650436665;1828.963420731578;1879.2670858365248;1939.660559402099;664.7108507799123;866.8049688820091;868.9739307820776;903.2999425445201;1026.7227848480868;19269.557916620754;19795.60408791816;20831.270905518235;20953.266635667984;21026.78973210279;792.3700657976922;907.3285768531372;939.281449690987;956.6221342569646;975.4683697384942;10336.17310615149;11001.339919604688;11010.559577616805;11054.502547385388;11087;612431;620000;623291.8835405794;623466;631080;128533.3573332146;129223;133906;134849.6515034837;135357.3232133833;950.4059962523423;998.2114129837493;1014.523174108168;1016.5323950982631;1017.0947856407803;18185.909070454563;18591.814081859007;18818.435446936615;18849.151788169293;18870.7169392462;52406.689832754484;52826.471735283696;53151;53687.19469207887;55427.33717988467;80640;80775.59612202136;81644.59177704074;81824;84540;7593.278638529331;7872.448928574945;7878.4485086045715;8045.517268963881;8158.673653053811;12133.575324863587;12368.072394570263;12402.937985310016;12670;12695.80956285675;10653.520591573553;10666.62666806689;10738.785224295314;10749.838752418564;11143.108551315712;10364.481775911023;10636.680899573024;10791.838122428013;10903.400312982862;10980.396078215455;10730.624428144978;10932.070773983982;10975.945120274348;11235.606753763579;11301;7799;7894.328982036591;7914.406419518675;8054.798630034296;8104.351651867719;8798.47209167452;10687.572497100029;10798.946005270238;10815.56737730482;11069.833952490559 22:43:51 INFO - PROCESS | 1655 | |3;mootools.html;1332.1673953778889;1533.0801519088548;1676.983230167698;1856.3409989453735;1865.384423140363;8372.53951032693;8942.865857012133;8952.955235223832;8958;8963.73108806736;7824.374050075994;8051.91948080519;8497.830043399128;8686.695965641204;8700.869486957685;2370.205980996364;2410.5419970205603;2412.4571971306405;2419.4798118404537;2419.7580241975747;2330.277613939684;2334.7665233476687;2354.352553047917;2409.4458274596855;2412.2280870121567;2393.47343584412;2402.5194961007783;2412.4813165169485;2416.903323867052;2427.9271621851285;2362.4212068043266;2369.206315884181;2372.9288121356385;2376.417777644488;2377.8811059447044;2339.6256598944256;2345.57779599672;2346.8005219556358;2346.9295921122225;2351.5532048910654;8789.340799440068;8883.777905552413;8927.955360223223;8936.821263574757;8944.776380590472;5241.187615919539;5421.593380496479;5422.213779002022;5422.91865622016;5433.510984011418;3468.3583537045474;3556.772913344892;3670.743047986642;3672.5042119313816;3682.4660424238605;971.621067783565;997.1673652500172;1006.9395836249776;1022.2128960700294;1024.4416792847917;9861.359011664219;11546.36494992775;11698.590549330818;11720.765584688344;11726.94136529312;4595.977020114945;4762.357081793983;4788.946431785002;4812.326274321597;4890.266460030953;10088.646897358558;10099.293049486465;10099.7475063124;10107.747306317255;10109.241806864515;5292.02097611943;5292.603054770831;5303.7348132593215;5306.814261500829;5330.493603107776;4000.9399859002137;4369.606735393766;4414.139242847614;4824.710517368969;4828.5412885776495;3426.4860270959557;3906.8632597858937;3956.1098752780395;4067.28822456069;4079.4492743479846;1115.2360632966445;1281.6027031620229;1304.6953046953047;1307.3920626908532;1324.344449497505;829.6059371798348;873.4890089297705;908.2688435809237;917.202034230224;932.8414169591185;5637.26715526987;5880.558958078162;5939.287285525678;5990.850228744229;6174.938250617436;448.44169009583277;461.1422753678156;461.73681001828635;920.5857364186143;1014.7818219082933;3389.847456864447;3937.3897045957924;3955.248502784462;3974.5627980922654;4126.649234815014;10504.684859454228;10598.576056957789;10757.30077544957;10796.730081747863;10835.945820270848;10189.949050254701;10457.372557646413;10462.529186186488;10610;10787.137029037658;8258.174182581693;8395.999999999878;8400.285975692135;8407.62165702545;8416.074231834493;5823.301203855564;5841.707914604168;5847.970760146172;5978.8206353809455;6007.309159446545;9605.327627066039;9962.651307204213;9967.950160249153;10128.493575321352;10177.084062434416;10313.27807053499;10330.845037324296;10370;10389.272750907667;10392.636257730943;6591.274959754327;6775.424088952297;7089.0784198053925;7200.747973820891;7213.927860721536;7678.5392876427595;8296.87554686668;8377.874331885148;8546.2308392245;8546.931633545806;7416.925830741624;7510.436717246338;7522.285382888836;7566.886496702664;7667.769966901002;7320.414366850746;7343.559386436831;7375.11498620169;7393.889091663522;7469.290417410337;7026.051483049723;7027.262137475696;7114.679839407343;7120.750773723102;7129.108861392326;4989.501049894981;5006.1739812930455;5008.373953255843;5055.292259083658;5124.231365295235;4881.755912204447;4939.480864758927;5059.494050594911;5087.567556757717;5160.767765450639 22:43:51 INFO - PROCESS | 1655 | |4;prototype.html;294.14990676943637;297.4155783884666;307.1936167560154;312.370573294811;314.2379729156794;5081.491850814926;5228.189630607252;5242.68543887367;5327.467253274675;5349.732513374331;4519.8418055368065;4620.2838560023165;4938.641873484785;5211.45279745627;5220.556252718524;3708.1841994761244;4006.6377431673227;4035.4955630546183;4048.3522636378184;4049.676025917934;3424.8801291954787;3827.7320587558884;4011.0173007613175;4060.8578699745517;4082.5100987881497;3820.04280911209;3821.636944490269;3942.8817135485983;3943.6253555912144;4044.3933409988445;3975.403689446577;4007.83968641254;4008.398740188966;4025.778582177979;4034.4553485279407;3511.8402182657483;3518.4546395308766;3528.347255757693;3538.168530395355;3555.6266592007983;4249.022724773288;4951.104492429883;5038.672486288379;5148.742562871841;5153.969206158783;3670.743047986642;4238.940264933766;4614.700044497097;4616.215243408628;4646.163690535702;4601.493835678073;4844.636652251095;5513.8345849624575;5539.944600554023;5562.249096371978;3150.7951983121025;3393.4570468725133;3591.44332628443;3863.9374172102616;3891.4746509221177;4881.536254055859;5311.857950540613;5591.329040515124;5794.913076303858;5808.6224395414165;3235.724963378092;3450.913727156841;3781.9432708509394;3795.658390744846;3916.2754890345377;3312.271300313927;3993.4009898515455;4003.4395184674167;4008.3586626139677;4023.75857448554;4617.307403889444;4632.3977882875015;4634.652401069933;4647.651426142985;4658.976705116453;5059.468755780664;5123.8462846113935;5550.58370622205;5590.496855283044;5592.692401917933;1330.2351148089888;1356.4709763192363;1359.8169592454628;1367.8153449284218;1369.3153423288356;682.2699711308951;757.2994979643807;833.5207255827924;840.260570697782;847.5804476784032;4095.9795201023803;4096.91806163875;4295.701799537233;4401.383806267125;4437.424714226468;3959.821808018646;4113.223574087479;4394.264265615128;4478.730526715516;4780.565830250911;3737.5423584801947;4348.086841789603;4371.366151907955;4385.276429389115;4396.0217901943615;2266.4560505478566;2708.7426694463993;3010.1571559963245;3010.1872494426384;3012.3372857971212;5024.949750502448;5208.765605547759;5648.293963254593;5978.491828194565;5998.310194327708;4725.787339569728;5057.721825299644;5668.319801623831;5863.589548731633;5921.322155497195;4956.702597844069;5016.774245158904;5077.1876499759865;5971.343152253248;5982.965791630866;5450.727463626882;5690.800821971211;5719.656820590778;5721.513671337816;5738.192469372301;4973.980334031443;5290.576753859605;5402.270693456333;5466.3713672928125;5693.829185124453;5350.759215835375;5399.649022813504;5489.1217405214975;5744.24276347364;5839.605761637708;3089.1041597937246;3585.8704508079873;3739.1773809761808;3886.9028274292236;3925.4288441071144;4809.739422471433;5347.224652425454;5364.30264065669;5507.779688812563;5824.9806283901;4500.617447516997;5348.919766203432;5628.971855140698;5652.434756524479;5665.915011274752;4879.463259041574;4961.776720047678;5620.330343087001;5646.491815736604;5652.689102099424;5181.248718935809;5238.476152384731;5525;5543.501084902378;5558.944410556004;5305.442928492453;5577.498025177591;5601.6358936668985;5630.380658127521;5637.238972738792;4792.544708252711;5487.286652735119;5514.145307477347;5527.39198688152;5564.749586268546 22:43:51 INFO - PROCESS | 1655 | |5;yui.html;694.801981435291;711.9216886142524;757.2238455583026;808.4179390838594;812.9675312353313;12759.489620415185;16550.7517387239;16553.25510352034;16563.17184140791;16576.917115414435;14939.253037348144;14961.551153465387;14968.700625987502;14977.850221497782;15041.77437338438;672.5561129654429;692.6052150274346;693.3967448319944;839.895013123358;840.6133178737788;853.9274161696263;858.5835869603237;865.9350548708873;867.3538214030556;870.4777133719749;925.1165137293868;925.6066171876959;927.8097989912052;930.060638754859;930.2604429478581;702.2100137345486;721.8772808622547;916.1067958740175;919.2875521470846;919.5953780336664;535.5715427657858;537.3551737914479;537.6666466790615;652.0414989964792;665.9567128136704;15238.695226095528;15299.235038248044;15307.693846123126;15311.846881531264;15334.539963800993;13781.242031688253;13923.164610123426;13950.302484875818;14053.859461405358;14216.715665686628;11951.462184201731;12423.813642795365;12446.81329780054;12663.620091397273;12941.417636206299;4204.810783514749;4228.894277643083;4352.36890650857;4352.412424322708;4353.346997950302;113948;116598;117176.41411792971;119746;122543.3872830639;10837.891621083689;10909.672709818718;11062.446877656084;11084.61203857861;11133.665990020312;21863.672044919338;21973.780262197175;21992.01035953386;22025.449363765714;22387.32838014862;7844.4901081429525;7845.8973514231375;7884.802879928047;7886.5662388568035;7937.523748575104;3668.4497325401403;4285.271503844354;4325.713687964752;4487.125010622897;4511.481179664315;3483.7387195959896;3591.317649646559;3592.820358982093;3604.1530240393486;3606.1345277133823;632.6393955445444;648.9902651460231;652.3672038123108;660.739008091801;666.6999850067489;601.711178634258;619.2568917299259;629.9181106456132;636.8917284061628;650.7364517370378;8446.662133514714;8966.237869781142;9005.504697241584;9008.234300084436;9200.769980750401;526.4025331248984;562.521856422038;626.4643729611117;643.6942452335197;644.2494493914537;4202.2646036944025;4388.100439409914;4433.578810013044;4454.888627784267;4488.865334039984;97606.02393976111;136913.3154334222;151824;164628.17685911493;165010;115831.42084289693;123846.38076809558;124592;132945;138474;117605;118069;120464.3976780128;122614;123170;8290.958545207235;8543.786405339917;8566.700165494427;8572.699955501528;8747.081556436482;66107.00839487508;66477;67405.64080257168;67843;70062;64350.71298574096;68542;97225;98009;101561;9866.85199722019;11385.089192864385;11495.885041149482;11699.824502632297;11942.449618567067;11884.286942783461;12161.87838121643;12341.75316493683;12847.357632118543;12899.871001289866;11036.779264414827;11037.83443248368;11569.537218511165;11716.882831171579;11939.925406713437;11268.211225214156;12153.392330383622;12216.816747748613;12252.509899603916;12551.121421500407;11338.319700817978;11348.60279890233;11539.596114135966;11616.833939104074;11878.168528203289;10048.196144308291;10091.19270458347;10102.314492897469;10596.258261921592;10599.841002385125;9799;10303.3817970922;10341.586336546454;10407.22854337679;10411 22:43:51 INFO - PROCESS | 1655 | __end_tp_report 22:43:51 INFO - PROCESS | 1655 | __start_cc_report 22:43:51 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1101 22:43:51 INFO - PROCESS | 1655 | __end_cc_report 22:43:51 INFO - PROCESS | 1655 | __startTimestamp1477460631001__endTimestamp 22:43:51 INFO - PROCESS | 1655 | 22:43:51 INFO - PROCESS | 1655 | ------- Summary: start ------- 22:43:51 INFO - PROCESS | 1655 | Number of tests: 6 22:43:51 INFO - PROCESS | 1655 | 22:43:51 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5750.30 Median:5907.29 stddev:642.41 (10.9%) stddev-sans-first:616.05 22:43:51 INFO - PROCESS | 1655 | Values: 3345.2 3345.5 3390.5 3397.8 3430.4 5680.8 5739.7 5747.7 5766.0 5775.0 4752.7 5660.6 5759.2 5792.9 5812.2 5238.4 5252.2 5274.3 5311.5 5331.4 5210.1 5221.5 5355.7 5357.5 5412.3 5220.3 5255.6 5263.5 5296.3 5302.5 5288.1 5322.3 5361.6 5362.5 5379.1 5221.5 5256.3 5270.4 5292.4 5314.8 5581.9 5613.4 5634.9 5639.3 5645.5 6116.5 6212.8 6221.6 6229.8 6239.6 6264.0 6306.6 6353.9 6365.0 6373.2 5685.8 5732.8 5753.0 5823.0 5846.3 6279.3 6316.9 6320.3 6321.4 6333.5 6178.4 6187.6 6189.8 6197.0 6197.3 6103.1 6188.5 6189.4 6270.0 6304.1 6204.4 6260.6 6290.2 6292.9 6307.5 6213.4 6247.1 6285.5 6301.0 6305.3 4865.2 4896.4 4925.3 4981.8 5006.3 4397.9 4457.7 4462.3 4462.9 4497.6 5794.2 5794.7 5807.5 5808.5 5823.8 6139.6 6327.4 6342.2 6342.7 6356.2 5080.5 5633.4 5702.5 5782.0 5813.3 5432.2 5441.8 5450.6 5457.5 5472.2 6347.1 6351.2 6358.1 6360.2 6377.1 6155.0 6183.0 6192.9 6245.3 6255.7 6304.6 6321.6 6324.2 6336.5 6341.0 5119.8 6185.6 6190.9 6203.1 6204.8 5018.0 5155.8 6154.8 6175.2 6208.6 5955.7 6122.4 6165.0 6177.9 6182.0 6145.1 6166.2 6167.3 6169.8 6169.9 5712.1 5869.1 5900.9 5907.3 5982.0 6091.9 6158.8 6167.9 6174.4 6198.3 5790.1 5943.5 5956.9 5995.2 6011.9 22:43:51 INFO - PROCESS | 1655 | 22:43:51 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:73486.96 Median:3632.07 stddev:162987.16 (4487.4%) stddev-sans-first:163352.28 22:43:51 INFO - PROCESS | 1655 | Values: 510.8 514.9 515.2 544.3 545.7 31602.7 41121.2 42094.0 42174.4 44661.6 42523.0 42831.8 43331.1 43342.3 43513.8 8957.9 9879.2 10156.4 10171.9 10194.7 8861.3 10806.7 11898.8 12175.0 12617.9 12402.0 12467.7 12468.9 12476.8 12481.0 8925.4 12412.3 12509.7 12528.4 12529.6 8734.4 12000.6 12305.3 12307.6 12569.0 39787.2 41710.6 42070.4 42188.2 42245.2 3405.3 3591.6 3672.6 3964.4 4020.9 30201.5 30212.8 30962.4 31853.4 32162.8 3154.3 3177.2 3180.4 3327.3 3401.5 439106.8 516268.0 517633.8 520848.0 521839.0 61397.4 61716.4 61917.1 62014.4 62017.7 59067.4 59087.0 59149.0 59150.8 59338.7 16609.3 16875.3 16875.7 16876.2 16921.5 11760.5 11975.7 11977.4 13028.2 13073.7 16951.8 17163.1 17306.4 17483.4 17765.3 5439.0 5881.5 5979.3 6016.4 6131.8 806.8 873.4 964.3 1002.0 1029.4 29489.1 30462.5 30570.8 30600.1 31164.5 1058.6 1060.9 1070.2 1078.7 1161.8 15757.7 15769.6 15895.3 16225.4 16575.6 715305.0 717782.0 718936.0 719939.0 721141.0 59793.0 60062.7 60181.0 60272.7 60338.7 1095.9 1222.5 1353.9 1379.7 1399.4 29569.4 30439.2 31115.7 31628.7 32117.2 50850.7 51387.5 51546.2 51579.7 51605.7 579545.0 585527.0 585972.0 586008.0 586738.0 26211.2 27347.0 27349.2 27947.9 28071.0 47523.0 47712.0 48002.5 48480.8 48608.8 39200.8 39544.6 39646.6 39943.0 41292.8 34932.1 37802.8 39270.6 39826.0 40021.0 38598.0 39121.8 39303.8 39430.2 39576.4 33525.3 34281.3 34460.7 35289.5 35316.3 23554.4 25122.1 25544.1 25861.7 25886.9 22:43:51 INFO - PROCESS | 1655 | 22:43:51 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:35806.51 Median:24325.70 stddev:103936.33 (427.3%) stddev-sans-first:104193.81 22:43:51 INFO - PROCESS | 1655 | Values: 352.8 354.6 379.1 383.7 407.4 14477.9 14960.4 15572.0 19694.9 19954.6 18672.3 20112.6 20219.4 20727.3 20922.0 5616.2 5654.5 5860.7 5865.4 5870.5 4401.4 5706.1 5775.9 5791.1 5886.6 5431.2 5725.1 5725.4 5727.6 5729.1 5598.2 5670.8 5704.5 5715.5 5722.8 4759.8 4942.1 4984.8 4990.8 5001.1 23672.6 24261.6 24389.8 24656.9 24686.3 2264.8 2271.4 2317.9 2457.5 2509.4 9750.5 9952.2 10164.7 10283.3 10386.5 1846.9 1921.5 1927.8 1930.7 1979.8 109285.5 118393.0 121558.0 131707.0 132286.3 11370.2 11482.9 11601.9 11615.2 11765.0 14517.3 14529.6 14542.4 14560.6 14600.6 8482.8 8602.5 8612.8 8636.0 8741.4 6151.9 6495.9 8495.6 8591.8 8790.8 4460.4 4514.8 4534.9 4643.8 4646.8 1677.9 1747.0 1829.0 1879.3 1939.7 664.7 866.8 869.0 903.3 1026.7 19269.6 19795.6 20831.3 20953.3 21026.8 792.4 907.3 939.3 956.6 975.5 10336.2 11001.3 11010.6 11054.5 11087.0 612431.0 620000.0 623291.9 623466.0 631080.0 128533.4 129223.0 133906.0 134849.7 135357.3 950.4 998.2 1014.5 1016.5 1017.1 18185.9 18591.8 18818.4 18849.2 18870.7 52406.7 52826.5 53151.0 53687.2 55427.3 80640.0 80775.6 81644.6 81824.0 84540.0 7593.3 7872.4 7878.4 8045.5 8158.7 12133.6 12368.1 12402.9 12670.0 12695.8 10653.5 10666.6 10738.8 10749.8 11143.1 10364.5 10636.7 10791.8 10903.4 10980.4 10730.6 10932.1 10975.9 11235.6 11301.0 7799.0 7894.3 7914.4 8054.8 8104.4 8798.5 10687.6 10798.9 10815.6 11069.8 22:43:51 INFO - PROCESS | 1655 | 22:43:51 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5701.64 Median:4826.63 stddev:3202.36 (66.3%) stddev-sans-first:3194.51 22:43:51 INFO - PROCESS | 1655 | Values: 1332.2 1533.1 1677.0 1856.3 1865.4 8372.5 8942.9 8953.0 8958.0 8963.7 7824.4 8051.9 8497.8 8686.7 8700.9 2370.2 2410.5 2412.5 2419.5 2419.8 2330.3 2334.8 2354.4 2409.4 2412.2 2393.5 2402.5 2412.5 2416.9 2427.9 2362.4 2369.2 2372.9 2376.4 2377.9 2339.6 2345.6 2346.8 2346.9 2351.6 8789.3 8883.8 8928.0 8936.8 8944.8 5241.2 5421.6 5422.2 5422.9 5433.5 3468.4 3556.8 3670.7 3672.5 3682.5 971.6 997.2 1006.9 1022.2 1024.4 9861.4 11546.4 11698.6 11720.8 11726.9 4596.0 4762.4 4788.9 4812.3 4890.3 10088.6 10099.3 10099.7 10107.7 10109.2 5292.0 5292.6 5303.7 5306.8 5330.5 4000.9 4369.6 4414.1 4824.7 4828.5 3426.5 3906.9 3956.1 4067.3 4079.4 1115.2 1281.6 1304.7 1307.4 1324.3 829.6 873.5 908.3 917.2 932.8 5637.3 5880.6 5939.3 5990.9 6174.9 448.4 461.1 461.7 920.6 1014.8 3389.8 3937.4 3955.2 3974.6 4126.6 10504.7 10598.6 10757.3 10796.7 10835.9 10189.9 10457.4 10462.5 10610.0 10787.1 8258.2 8396.0 8400.3 8407.6 8416.1 5823.3 5841.7 5848.0 5978.8 6007.3 9605.3 9962.7 9968.0 10128.5 10177.1 10313.3 10330.8 10370.0 10389.3 10392.6 6591.3 6775.4 7089.1 7200.7 7213.9 7678.5 8296.9 8377.9 8546.2 8546.9 7416.9 7510.4 7522.3 7566.9 7667.8 7320.4 7343.6 7375.1 7393.9 7469.3 7026.1 7027.3 7114.7 7120.8 7129.1 4989.5 5006.2 5008.4 5055.3 5124.2 4881.8 4939.5 5059.5 5087.6 5160.8 22:43:51 INFO - PROCESS | 1655 | 22:43:51 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4380.77 Median:4786.56 stddev:1352.18 (28.2%) stddev-sans-first:1320.73 22:43:51 INFO - PROCESS | 1655 | Values: 294.1 297.4 307.2 312.4 314.2 5081.5 5228.2 5242.7 5327.5 5349.7 4519.8 4620.3 4938.6 5211.5 5220.6 3708.2 4006.6 4035.5 4048.4 4049.7 3424.9 3827.7 4011.0 4060.9 4082.5 3820.0 3821.6 3942.9 3943.6 4044.4 3975.4 4007.8 4008.4 4025.8 4034.5 3511.8 3518.5 3528.3 3538.2 3555.6 4249.0 4951.1 5038.7 5148.7 5154.0 3670.7 4238.9 4614.7 4616.2 4646.2 4601.5 4844.6 5513.8 5539.9 5562.2 3150.8 3393.5 3591.4 3863.9 3891.5 4881.5 5311.9 5591.3 5794.9 5808.6 3235.7 3450.9 3781.9 3795.7 3916.3 3312.3 3993.4 4003.4 4008.4 4023.8 4617.3 4632.4 4634.7 4647.7 4659.0 5059.5 5123.8 5550.6 5590.5 5592.7 1330.2 1356.5 1359.8 1367.8 1369.3 682.3 757.3 833.5 840.3 847.6 4096.0 4096.9 4295.7 4401.4 4437.4 3959.8 4113.2 4394.3 4478.7 4780.6 3737.5 4348.1 4371.4 4385.3 4396.0 2266.5 2708.7 3010.2 3010.2 3012.3 5024.9 5208.8 5648.3 5978.5 5998.3 4725.8 5057.7 5668.3 5863.6 5921.3 4956.7 5016.8 5077.2 5971.3 5983.0 5450.7 5690.8 5719.7 5721.5 5738.2 4974.0 5290.6 5402.3 5466.4 5693.8 5350.8 5399.6 5489.1 5744.2 5839.6 3089.1 3585.9 3739.2 3886.9 3925.4 4809.7 5347.2 5364.3 5507.8 5825.0 4500.6 5348.9 5629.0 5652.4 5665.9 4879.5 4961.8 5620.3 5646.5 5652.7 5181.2 5238.5 5525.0 5543.5 5558.9 5305.4 5577.5 5601.6 5630.4 5637.2 4792.5 5487.3 5514.1 5527.4 5564.7 22:43:51 INFO - PROCESS | 1655 | 22:43:51 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:24879.10 Median:3598.49 stddev:40450.52 (1124.1%) stddev-sans-first:40523.24 22:43:51 INFO - PROCESS | 1655 | Values: 694.8 711.9 757.2 808.4 813.0 12759.5 16550.8 16553.3 16563.2 16576.9 14939.3 14961.6 14968.7 14977.9 15041.8 672.6 692.6 693.4 839.9 840.6 853.9 858.6 865.9 867.4 870.5 925.1 925.6 927.8 930.1 930.3 702.2 721.9 916.1 919.3 919.6 535.6 537.4 537.7 652.0 666.0 15238.7 15299.2 15307.7 15311.8 15334.5 13781.2 13923.2 13950.3 14053.9 14216.7 11951.5 12423.8 12446.8 12663.6 12941.4 4204.8 4228.9 4352.4 4352.4 4353.3 113948.0 116598.0 117176.4 119746.0 122543.4 10837.9 10909.7 11062.4 11084.6 11133.7 21863.7 21973.8 21992.0 22025.4 22387.3 7844.5 7845.9 7884.8 7886.6 7937.5 3668.4 4285.3 4325.7 4487.1 4511.5 3483.7 3591.3 3592.8 3604.2 3606.1 632.6 649.0 652.4 660.7 666.7 601.7 619.3 629.9 636.9 650.7 8446.7 8966.2 9005.5 9008.2 9200.8 526.4 562.5 626.5 643.7 644.2 4202.3 4388.1 4433.6 4454.9 4488.9 97606.0 136913.3 151824.0 164628.2 165010.0 115831.4 123846.4 124592.0 132945.0 138474.0 117605.0 118069.0 120464.4 122614.0 123170.0 8291.0 8543.8 8566.7 8572.7 8747.1 66107.0 66477.0 67405.6 67843.0 70062.0 64350.7 68542.0 97225.0 98009.0 101561.0 9866.9 11385.1 11495.9 11699.8 11942.4 11884.3 12161.9 12341.8 12847.4 12899.9 11036.8 11037.8 11569.5 11716.9 11939.9 11268.2 12153.4 12216.8 12252.5 12551.1 11338.3 11348.6 11539.6 11616.8 11878.2 10048.2 10091.2 10102.3 10596.3 10599.8 9799.0 10303.4 10341.6 10407.2 10411.0 22:43:51 INFO - PROCESS | 1655 | -------- Summary: end -------- 22:43:51 INFO - PROCESS | 1655 | 22:43:51 INFO - TEST-INFO | 1655: exit 0 22:43:51 INFO - TEST-OK | dromaeo_css | took 1116480ms 22:43:51 INFO - TEST-START | kraken 22:43:51 INFO - operating with platform_type : mac_ 22:43:51 INFO - Initialising browser for kraken test... 22:43:51 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/tmpjgeg6O/profile http://localhost:49272/getInfo.html) 22:43:53 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 22:43:53 INFO - PROCESS | 1668 | colorDepth:24 22:43:53 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 22:43:53 INFO - PROCESS | 1668 | __metrics 22:43:53 INFO - PROCESS | 1668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:43:53 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:43:54 INFO - TEST-INFO | 1668: exit 0 22:43:54 INFO - Browser initialized. 22:43:54 INFO - Running cycle 1/1 for kraken test... 22:43:54 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/tmpjgeg6O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:44:06 INFO - PROCESS | 1669 | RSS: Main: 219729920 22:44:06 INFO - PROCESS | 1669 | 22:44:09 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 22:44:10 INFO - PROCESS | 1669 | RSS: Main: 269172736 22:44:10 INFO - PROCESS | 1669 | 22:44:12 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 22:44:13 INFO - PROCESS | 1669 | RSS: Main: 280788992 22:44:13 INFO - PROCESS | 1669 | 22:44:16 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 22:44:17 INFO - PROCESS | 1669 | RSS: Main: 376614912 22:44:17 INFO - PROCESS | 1669 | 22:44:19 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 22:44:19 INFO - PROCESS | 1669 | RSS: Main: 278966272 22:44:19 INFO - PROCESS | 1669 | 22:44:22 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:44:22 INFO - PROCESS | 1669 | RSS: Main: 281010176 22:44:22 INFO - PROCESS | 1669 | 22:44:25 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 22:44:26 INFO - PROCESS | 1669 | RSS: Main: 318550016 22:44:26 INFO - PROCESS | 1669 | 22:44:28 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 22:44:29 INFO - PROCESS | 1669 | RSS: Main: 318476288 22:44:29 INFO - PROCESS | 1669 | 22:44:32 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 22:44:32 INFO - PROCESS | 1669 | RSS: Main: 317431808 22:44:32 INFO - PROCESS | 1669 | 22:44:34 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:44:35 INFO - PROCESS | 1669 | RSS: Main: 290144256 22:44:35 INFO - PROCESS | 1669 | 22:44:36 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:44:37 INFO - PROCESS | 1669 | RSS: Main: 297111552 22:44:37 INFO - PROCESS | 1669 | 22:44:39 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:44:40 INFO - PROCESS | 1669 | RSS: Main: 303267840 22:44:40 INFO - PROCESS | 1669 | 22:44:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:44:43 INFO - PROCESS | 1669 | RSS: Main: 307208192 22:44:43 INFO - PROCESS | 1669 | 22:44:46 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:44:47 INFO - PROCESS | 1669 | RSS: Main: 308465664 22:44:47 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 22:44:49 INFO - PROCESS | 1669 | RSS: Main: 351600640 22:44:49 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | __start_tp_report 22:44:49 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 22:44:49 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 22:44:49 INFO - PROCESS | 1669 | |i|pagename|runs| 22:44:49 INFO - PROCESS | 1669 | |0;ai-astar;156;168;167;113;113;113;115;113;119;129 22:44:49 INFO - PROCESS | 1669 | |1;audio-beat-detection;143;106;120;139;106;108;107;108;139;108 22:44:49 INFO - PROCESS | 1669 | |2;audio-dft;183;183;185;181;183;182;183;182;182;183 22:44:49 INFO - PROCESS | 1669 | |3;audio-fft;80;58;62;97;86;48;75;82;109;83 22:44:49 INFO - PROCESS | 1669 | |4;audio-oscillator;89;92;107;65;98;101;131;90;68;90 22:44:49 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;90;87;89;87;88;86;91;87;90;86 22:44:49 INFO - PROCESS | 1669 | |6;imaging-darkroom;96;96;96;96;95;106;96;97;95;94 22:44:49 INFO - PROCESS | 1669 | |7;imaging-desaturate;86;84;86;86;84;83;90;71;109;134 22:44:49 INFO - PROCESS | 1669 | |8;json-parse-financial;57;54;53;54;56;58;58;57;56;57 22:44:49 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;71;69;74;72;72;70;68;69;69;72 22:44:49 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;82;85;82;82;84;85;84;90;89;101 22:44:49 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;144;147;138;140;136;138;135;154;146;150 22:44:49 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;166;167;169;167;169;166;169;166;164;168 22:44:49 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;63;78;88;87;65;59;82;83;84;86 22:44:49 INFO - PROCESS | 1669 | __end_tp_report 22:44:49 INFO - PROCESS | 1669 | __start_cc_report 22:44:49 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1946 22:44:49 INFO - PROCESS | 1669 | __end_cc_report 22:44:49 INFO - PROCESS | 1669 | __startTimestamp1477460689544__endTimestamp 22:44:49 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | ------- Summary: start ------- 22:44:49 INFO - PROCESS | 1669 | Number of tests: 14 22:44:49 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:130.60 Median:124.00 stddev:23.54 (19.0%) stddev-sans-first:23.11 22:44:49 INFO - PROCESS | 1669 | Values: 156.0 168.0 167.0 113.0 113.0 113.0 115.0 113.0 119.0 129.0 22:44:49 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:118.40 Median:114.00 stddev:15.70 (13.8%) stddev-sans-first:13.90 22:44:49 INFO - PROCESS | 1669 | Values: 143.0 106.0 120.0 139.0 106.0 108.0 107.0 108.0 139.0 108.0 22:44:49 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.06 (0.6%) stddev-sans-first:1.12 22:44:49 INFO - PROCESS | 1669 | Values: 183.0 183.0 185.0 181.0 183.0 182.0 183.0 182.0 182.0 183.0 22:44:49 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:78.00 Median:81.00 stddev:18.25 (22.5%) stddev-sans-first:19.34 22:44:49 INFO - PROCESS | 1669 | Values: 80.0 58.0 62.0 97.0 86.0 48.0 75.0 82.0 109.0 83.0 22:44:49 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:89.50 stddev:18.78 (21.0%) stddev-sans-first:19.86 22:44:49 INFO - PROCESS | 1669 | Values: 89.0 92.0 107.0 65.0 98.0 101.0 131.0 90.0 68.0 90.0 22:44:49 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:88.10 Median:88.50 stddev:1.79 (2.0%) stddev-sans-first:1.76 22:44:49 INFO - PROCESS | 1669 | Values: 90.0 87.0 89.0 87.0 88.0 86.0 91.0 87.0 90.0 86.0 22:44:49 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:96.70 Median:96.00 stddev:3.37 (3.5%) stddev-sans-first:3.56 22:44:49 INFO - PROCESS | 1669 | Values: 96.0 96.0 96.0 96.0 95.0 106.0 96.0 97.0 95.0 94.0 22:44:49 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:91.30 Median:85.00 stddev:17.67 (20.8%) stddev-sans-first:18.64 22:44:49 INFO - PROCESS | 1669 | Values: 86.0 84.0 86.0 86.0 84.0 83.0 90.0 71.0 109.0 134.0 22:44:49 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:57.00 stddev:1.76 (3.1%) stddev-sans-first:1.83 22:44:49 INFO - PROCESS | 1669 | Values: 57.0 54.0 53.0 54.0 56.0 58.0 58.0 57.0 56.0 57.0 22:44:49 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.50 stddev:1.90 (2.7%) stddev-sans-first:2.01 22:44:49 INFO - PROCESS | 1669 | Values: 71.0 69.0 74.0 72.0 72.0 70.0 68.0 69.0 69.0 72.0 22:44:49 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:84.50 stddev:5.83 (6.9%) stddev-sans-first:5.97 22:44:49 INFO - PROCESS | 1669 | Values: 82.0 85.0 82.0 82.0 84.0 85.0 84.0 90.0 89.0 101.0 22:44:49 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:145.00 stddev:6.39 (4.4%) stddev-sans-first:6.76 22:44:49 INFO - PROCESS | 1669 | Values: 144.0 147.0 138.0 140.0 136.0 138.0 135.0 154.0 146.0 150.0 22:44:49 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:167.50 stddev:1.66 (1.0%) stddev-sans-first:1.72 22:44:49 INFO - PROCESS | 1669 | Values: 166.0 167.0 169.0 167.0 169.0 166.0 169.0 166.0 164.0 168.0 22:44:49 INFO - PROCESS | 1669 | 22:44:49 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.50 Median:83.50 stddev:10.93 (13.1%) stddev-sans-first:10.25 22:44:49 INFO - PROCESS | 1669 | Values: 63.0 78.0 88.0 87.0 65.0 59.0 82.0 83.0 84.0 86.0 22:44:49 INFO - PROCESS | 1669 | -------- Summary: end -------- 22:44:49 INFO - PROCESS | 1669 | 22:44:50 INFO - TEST-INFO | 1669: exit 0 22:44:50 INFO - TEST-OK | kraken | took 58775ms 22:44:50 INFO - SUITE-END | took 1175s 22:44:50 INFO - Completed test suite (00:19:35) 22:44:50 INFO - javascript benchmark 22:44:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3345.180430794455, 3345.548350972618, 3390.4575267957116, 3397.7791443556152, 3430.3825311443948, 5680.801171958977, 5739.655620662763, 5747.683877386748, 5766.0, 5775.047117225663, 4752.7148371097755, 5660.632058916168, 5759.16492108644, 5792.855178620536, 5812.186293918855, 5238.423773384925, 5252.185911183773, 5274.2879711238875, 5311.521963023327, 5331.413544510101, 5210.062188806013, 5221.503957124067, 5355.678659280456, 5357.544608708265, 5412.269343638598, 5220.347456567929, 5255.605829562779, 5263.499967503081, 5296.25852380667, 5302.522772950434, 5288.101022826148, 5322.33470816148, 5361.624686271963, 5362.490563396471, 5379.1393377059485, 5221.477852214786, 5256.26412302278, 5270.39390470097, 5292.444293349181, 5314.840554783363, 5581.944180558183, 5613.4386561343945, 5634.85912852182, 5639.2668953036255, 5645.5483561314995, 6116.457510225599, 6212.782552610637, 6221.564490485668, 6229.813105606839, 6239.563230573862, 6263.968680156616, 6306.590071645328, 6353.872922541569, 6365.045243213509, 6373.203349581302, 5685.829425117253, 5732.828015159552, 5752.9712351437975, 5823.039198532279, 5846.269216347957, 6279.277883043417, 6316.873662526816, 6320.273168585672, 6321.399467050623, 6333.493320534439, 6178.41305076026, 6187.597806142587, 6189.8452538686, 6197.0, 6197.25632924052, 6103.0649381601115, 6188.535859810532, 6189.412005859436, 6270.0, 6304.05439184126, 6204.441600255998, 6260.624362538262, 6290.182276304051, 6292.874142517124, 6307.4954003679595, 6213.409726076015, 6247.125402443661, 6285.528585356116, 6301.0, 6305.274893387227, 4865.172920603506, 4896.4124305083615, 4925.335079764186, 4981.825636102792, 5006.324146240211, 4397.912041759147, 4457.710248833815, 4462.3306504024, 4462.933056004163, 4497.617702495325, 5794.21778059965, 5794.710264486759, 5807.535397168301, 5808.535317174616, 5823.767049317979, 6139.614800607318, 6327.430531252117, 6342.175517182736, 6342.651154186472, 6356.2054743157105, 5080.517350851663, 5633.380328163898, 5702.54379649627, 5782.0, 5813.273340832396, 5432.185172224198, 5441.8095366662765, 5450.645708028966, 5457.508824205761, 5472.179173124063, 6347.143135676624, 6351.17434733491, 6358.1416508771645, 6360.204974378203, 6377.107204991212, 6154.98442756958, 6183.0, 6192.876142477216, 6245.344238854855, 6255.71849266775, 6304.590201636879, 6321.589096708699, 6324.2410910691015, 6336.524760643062, 6341.0, 5119.769610367468, 6185.628862268279, 6190.907136393048, 6203.100550420254, 6204.751809927552, 5018.0, 5155.793768249228, 6154.846128846635, 6175.197224360984, 6208.596441231305, 5955.731992060454, 6122.428649698624, 6165.0, 6177.938220617736, 6182.041783523561, 6145.10895920098, 6166.229221347332, 6167.290761562478, 6169.84575385601, 6169.907451388143, 5712.143178523254, 5869.090291004901, 5900.881982360243, 5907.2911250650195, 5982.042873140276, 6091.8523847348915, 6158.753649853956, 6167.907481387693, 6174.351693072163, 6198.318184999556, 5790.073588225863, 5943.494802941798, 5956.880862382642, 5995.160677505066, 6011.87976240464], "value": 5710.246465149148, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.7573902396362, 514.9176131818905, 515.1628603519281, 544.3141641531671, 545.7244091733673, 31602.683973160263, 41121.17757644849, 42094.0, 42174.367384489255, 44661.55338446615, 42523.0, 42831.78584107083, 43331.13337733252, 43342.349864751974, 43513.78243108788, 8957.865632015524, 9879.16027137694, 10156.390616562992, 10171.89828101717, 10194.6941591752, 8861.335399845037, 10806.72983175419, 11898.821517677241, 12175.0, 12617.936910315482, 12402.0, 12467.688307792332, 12468.875311246862, 12476.750464990695, 12481.0, 8925.375223734341, 12412.317322547256, 12509.749805003848, 12528.436220370106, 12529.624111276631, 8734.388592798507, 12000.57997970067, 12305.323207223599, 12307.56923507673, 12569.0, 39787.20425591501, 41710.582894171275, 42070.36894446586, 42188.156236875395, 42245.1550968982, 3405.250844814137, 3591.5690117185845, 3672.57765356982, 3964.385520244367, 4020.9195816083516, 30201.546976795365, 30212.84893575518, 30962.380752384826, 31853.362932741446, 32162.839185804154, 3154.274516861135, 3177.158053115903, 3180.4275230458506, 3327.2846338037198, 3401.523786669868, 439106.8044659788, 516268.0, 517633.82366176235, 520848.0, 521839.0, 61397.38602614006, 61716.382836171964, 61917.07124393048, 62014.37985620176, 62017.68991155015, 59067.40932590705, 59087.0, 59149.0, 59150.816983660945, 59338.70330648319, 16609.335626575044, 16875.324987000382, 16875.746863797052, 16876.240569174417, 16921.49235522912, 11760.529578816922, 11975.700607484883, 11977.401129943468, 13028.153170043917, 13073.673158171121, 16951.830481695273, 17163.056031918364, 17306.394276200524, 17483.388081417088, 17765.289388424317, 5438.972805136028, 5881.470667639847, 5979.252593425822, 6016.42843929826, 6131.846703832351, 806.8144326804868, 873.4148120759106, 964.3056998960737, 1002.0330381182195, 1029.444100185906, 29489.11532654024, 30462.54306185409, 30570.77716891344, 30600.060950325413, 31164.53253201204, 1058.6294796821205, 1060.8567843341204, 1070.202698989258, 1078.7087486378634, 1161.848959635242, 15757.68484630301, 15769.605759855865, 15895.284712187979, 16225.432109876097, 16575.585610359838, 715305.0, 717782.0, 718936.0, 719939.0, 721141.0, 59793.0, 60062.699686501284, 60181.0, 60272.69863650654, 60338.69830650819, 1095.8684957805115, 1222.5171057432265, 1353.8510763816168, 1379.7234562971178, 1399.3772771116755, 29569.408611828072, 30439.175135199523, 31115.68884311128, 31628.683713162573, 32117.197070073435, 50850.74574627103, 51387.48612513827, 51546.22680659868, 51579.74210128925, 51605.741971289906, 579545.0, 585527.0, 585972.0, 586008.0, 586738.0, 26211.213663590122, 27347.0, 27349.179524614294, 27947.860260698566, 28071.0, 47523.0, 47712.0, 48002.519974799805, 48480.75759621179, 48608.756956214995, 39200.80399597984, 39544.604553954094, 39646.60353396429, 39943.0, 41292.79353603213, 34932.126696831765, 37802.810985945995, 39270.607293926696, 39826.0, 40021.0, 38598.0, 39121.804390977864, 39303.80348098241, 39430.211395772494, 39576.40635390414, 33525.329493410485, 34281.314373712885, 34460.65539344575, 35289.47065794066, 35316.293674126886, 23554.411139721644, 25122.12072577451, 25544.084193685176, 25861.741382585933, 25886.870565647052], "value": 20569.824399673627, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.8006676227931, 354.58690625421383, 379.05993137020204, 383.73905744094014, 407.4234957535088, 14477.855221447782, 14960.401583936644, 15572.0, 19694.916779577117, 19954.600907981832, 18672.346467873627, 20112.59774804503, 20219.39341819744, 20727.274545390916, 20921.9539023049, 5616.213730077792, 5654.547636189116, 5860.736266868002, 5865.442782935615, 5870.471657550819, 4401.427814384142, 5706.1440783882545, 5775.884482310351, 5791.07342825148, 5886.6468011919205, 5431.2396264522995, 5725.112607545816, 5725.370209276976, 5727.57043221758, 5729.111987641902, 5598.216249725042, 5670.8015219467325, 5704.543636509069, 5715.514181294595, 5722.769604535003, 4759.762011899391, 4942.110420124376, 4984.800607975677, 4990.8253211137435, 5001.099802035632, 23672.64491032636, 24261.636075458882, 24389.756102438925, 24656.87671561631, 24686.259412217663, 2264.830137739676, 2271.4434963434064, 2317.9420514487106, 2457.4839283750434, 2509.4102885821817, 9750.46372449515, 9952.203823694088, 10164.695059148238, 10283.280170388076, 10386.480675966171, 1846.9353572624893, 1921.5004098934237, 1927.7975812539762, 1930.6814375628005, 1979.7525309336334, 109285.45357273243, 118393.0, 121558.0, 131707.0, 132286.33856830752, 11370.20408571392, 11482.885171148182, 11601.941990289995, 11615.245009074382, 11765.0, 14517.274136293143, 14529.636759080897, 14542.418303267963, 14560.563183104523, 14600.634984125269, 8482.787930301669, 8602.526861022703, 8612.784680382916, 8636.0, 8741.388102832869, 6151.876962460815, 6495.935040649628, 8495.598226292592, 8591.828163436696, 8790.824183516293, 4460.397846290774, 4514.774261286988, 4534.909301813946, 4643.814247430132, 4646.767661616906, 1677.9077150756582, 1746.9912650436665, 1828.963420731578, 1879.2670858365248, 1939.660559402099, 664.7108507799123, 866.8049688820091, 868.9739307820776, 903.2999425445201, 1026.7227848480868, 19269.557916620754, 19795.60408791816, 20831.270905518235, 20953.266635667984, 21026.78973210279, 792.3700657976922, 907.3285768531372, 939.281449690987, 956.6221342569646, 975.4683697384942, 10336.17310615149, 11001.339919604688, 11010.559577616805, 11054.502547385388, 11087.0, 612431.0, 620000.0, 623291.8835405794, 623466.0, 631080.0, 128533.3573332146, 129223.0, 133906.0, 134849.6515034837, 135357.3232133833, 950.4059962523423, 998.2114129837493, 1014.523174108168, 1016.5323950982631, 1017.0947856407803, 18185.909070454563, 18591.814081859007, 18818.435446936615, 18849.151788169293, 18870.7169392462, 52406.689832754484, 52826.471735283696, 53151.0, 53687.19469207887, 55427.33717988467, 80640.0, 80775.59612202136, 81644.59177704074, 81824.0, 84540.0, 7593.278638529331, 7872.448928574945, 7878.4485086045715, 8045.517268963881, 8158.673653053811, 12133.575324863587, 12368.072394570263, 12402.937985310016, 12670.0, 12695.80956285675, 10653.520591573553, 10666.62666806689, 10738.785224295314, 10749.838752418564, 11143.108551315712, 10364.481775911023, 10636.680899573024, 10791.838122428013, 10903.400312982862, 10980.396078215455, 10730.624428144978, 10932.070773983982, 10975.945120274348, 11235.606753763579, 11301.0, 7799.0, 7894.328982036591, 7914.406419518675, 8054.798630034296, 8104.351651867719, 8798.47209167452, 10687.572497100029, 10798.946005270238, 10815.56737730482, 11069.833952490559], "value": 9385.648208855811, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.1673953778889, 1533.0801519088548, 1676.983230167698, 1856.3409989453735, 1865.384423140363, 8372.53951032693, 8942.865857012133, 8952.955235223832, 8958.0, 8963.73108806736, 7824.374050075994, 8051.91948080519, 8497.830043399128, 8686.695965641204, 8700.869486957685, 2370.205980996364, 2410.5419970205603, 2412.4571971306405, 2419.4798118404537, 2419.7580241975747, 2330.277613939684, 2334.7665233476687, 2354.352553047917, 2409.4458274596855, 2412.2280870121567, 2393.47343584412, 2402.5194961007783, 2412.4813165169485, 2416.903323867052, 2427.9271621851285, 2362.4212068043266, 2369.206315884181, 2372.9288121356385, 2376.417777644488, 2377.8811059447044, 2339.6256598944256, 2345.57779599672, 2346.8005219556358, 2346.9295921122225, 2351.5532048910654, 8789.340799440068, 8883.777905552413, 8927.955360223223, 8936.821263574757, 8944.776380590472, 5241.187615919539, 5421.593380496479, 5422.213779002022, 5422.91865622016, 5433.510984011418, 3468.3583537045474, 3556.772913344892, 3670.743047986642, 3672.5042119313816, 3682.4660424238605, 971.621067783565, 997.1673652500172, 1006.9395836249776, 1022.2128960700294, 1024.4416792847917, 9861.359011664219, 11546.36494992775, 11698.590549330818, 11720.765584688344, 11726.94136529312, 4595.977020114945, 4762.357081793983, 4788.946431785002, 4812.326274321597, 4890.266460030953, 10088.646897358558, 10099.293049486465, 10099.7475063124, 10107.747306317255, 10109.241806864515, 5292.02097611943, 5292.603054770831, 5303.7348132593215, 5306.814261500829, 5330.493603107776, 4000.9399859002137, 4369.606735393766, 4414.139242847614, 4824.710517368969, 4828.5412885776495, 3426.4860270959557, 3906.8632597858937, 3956.1098752780395, 4067.28822456069, 4079.4492743479846, 1115.2360632966445, 1281.6027031620229, 1304.6953046953047, 1307.3920626908532, 1324.344449497505, 829.6059371798348, 873.4890089297705, 908.2688435809237, 917.202034230224, 932.8414169591185, 5637.26715526987, 5880.558958078162, 5939.287285525678, 5990.850228744229, 6174.938250617436, 448.44169009583277, 461.1422753678156, 461.73681001828635, 920.5857364186143, 1014.7818219082933, 3389.847456864447, 3937.3897045957924, 3955.248502784462, 3974.5627980922654, 4126.649234815014, 10504.684859454228, 10598.576056957789, 10757.30077544957, 10796.730081747863, 10835.945820270848, 10189.949050254701, 10457.372557646413, 10462.529186186488, 10610.0, 10787.137029037658, 8258.174182581693, 8395.999999999878, 8400.285975692135, 8407.62165702545, 8416.074231834493, 5823.301203855564, 5841.707914604168, 5847.970760146172, 5978.8206353809455, 6007.309159446545, 9605.327627066039, 9962.651307204213, 9967.950160249153, 10128.493575321352, 10177.084062434416, 10313.27807053499, 10330.845037324296, 10370.0, 10389.272750907667, 10392.636257730943, 6591.274959754327, 6775.424088952297, 7089.0784198053925, 7200.747973820891, 7213.927860721536, 7678.5392876427595, 8296.87554686668, 8377.874331885148, 8546.2308392245, 8546.931633545806, 7416.925830741624, 7510.436717246338, 7522.285382888836, 7566.886496702664, 7667.769966901002, 7320.414366850746, 7343.559386436831, 7375.11498620169, 7393.889091663522, 7469.290417410337, 7026.051483049723, 7027.262137475696, 7114.679839407343, 7120.750773723102, 7129.108861392326, 4989.501049894981, 5006.1739812930455, 5008.373953255843, 5055.292259083658, 5124.231365295235, 4881.755912204447, 4939.480864758927, 5059.494050594911, 5087.567556757717, 5160.767765450639], "value": 4544.058724497063, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.14990676943637, 297.4155783884666, 307.1936167560154, 312.370573294811, 314.2379729156794, 5081.491850814926, 5228.189630607252, 5242.68543887367, 5327.467253274675, 5349.732513374331, 4519.8418055368065, 4620.2838560023165, 4938.641873484785, 5211.45279745627, 5220.556252718524, 3708.1841994761244, 4006.6377431673227, 4035.4955630546183, 4048.3522636378184, 4049.676025917934, 3424.8801291954787, 3827.7320587558884, 4011.0173007613175, 4060.8578699745517, 4082.5100987881497, 3820.04280911209, 3821.636944490269, 3942.8817135485983, 3943.6253555912144, 4044.3933409988445, 3975.403689446577, 4007.83968641254, 4008.398740188966, 4025.778582177979, 4034.4553485279407, 3511.8402182657483, 3518.4546395308766, 3528.347255757693, 3538.168530395355, 3555.6266592007983, 4249.022724773288, 4951.104492429883, 5038.672486288379, 5148.742562871841, 5153.969206158783, 3670.743047986642, 4238.940264933766, 4614.700044497097, 4616.215243408628, 4646.163690535702, 4601.493835678073, 4844.636652251095, 5513.8345849624575, 5539.944600554023, 5562.249096371978, 3150.7951983121025, 3393.4570468725133, 3591.44332628443, 3863.9374172102616, 3891.4746509221177, 4881.536254055859, 5311.857950540613, 5591.329040515124, 5794.913076303858, 5808.6224395414165, 3235.724963378092, 3450.913727156841, 3781.9432708509394, 3795.658390744846, 3916.2754890345377, 3312.271300313927, 3993.4009898515455, 4003.4395184674167, 4008.3586626139677, 4023.75857448554, 4617.307403889444, 4632.3977882875015, 4634.652401069933, 4647.651426142985, 4658.976705116453, 5059.468755780664, 5123.8462846113935, 5550.58370622205, 5590.496855283044, 5592.692401917933, 1330.2351148089888, 1356.4709763192363, 1359.8169592454628, 1367.8153449284218, 1369.3153423288356, 682.2699711308951, 757.2994979643807, 833.5207255827924, 840.260570697782, 847.5804476784032, 4095.9795201023803, 4096.91806163875, 4295.701799537233, 4401.383806267125, 4437.424714226468, 3959.821808018646, 4113.223574087479, 4394.264265615128, 4478.730526715516, 4780.565830250911, 3737.5423584801947, 4348.086841789603, 4371.366151907955, 4385.276429389115, 4396.0217901943615, 2266.4560505478566, 2708.7426694463993, 3010.1571559963245, 3010.1872494426384, 3012.3372857971212, 5024.949750502448, 5208.765605547759, 5648.293963254593, 5978.491828194565, 5998.310194327708, 4725.787339569728, 5057.721825299644, 5668.319801623831, 5863.589548731633, 5921.322155497195, 4956.702597844069, 5016.774245158904, 5077.1876499759865, 5971.343152253248, 5982.965791630866, 5450.727463626882, 5690.800821971211, 5719.656820590778, 5721.513671337816, 5738.192469372301, 4973.980334031443, 5290.576753859605, 5402.270693456333, 5466.3713672928125, 5693.829185124453, 5350.759215835375, 5399.649022813504, 5489.1217405214975, 5744.24276347364, 5839.605761637708, 3089.1041597937246, 3585.8704508079873, 3739.1773809761808, 3886.9028274292236, 3925.4288441071144, 4809.739422471433, 5347.224652425454, 5364.30264065669, 5507.779688812563, 5824.9806283901, 4500.617447516997, 5348.919766203432, 5628.971855140698, 5652.434756524479, 5665.915011274752, 4879.463259041574, 4961.776720047678, 5620.330343087001, 5646.491815736604, 5652.689102099424, 5181.248718935809, 5238.476152384731, 5525.0, 5543.501084902378, 5558.944410556004, 5305.442928492453, 5577.498025177591, 5601.6358936668985, 5630.380658127521, 5637.238972738792, 4792.544708252711, 5487.286652735119, 5514.145307477347, 5527.39198688152, 5564.749586268546], "value": 3952.5772525076222, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.801981435291, 711.9216886142524, 757.2238455583026, 808.4179390838594, 812.9675312353313, 12759.489620415185, 16550.7517387239, 16553.25510352034, 16563.17184140791, 16576.917115414435, 14939.253037348144, 14961.551153465387, 14968.700625987502, 14977.850221497782, 15041.77437338438, 672.5561129654429, 692.6052150274346, 693.3967448319944, 839.895013123358, 840.6133178737788, 853.9274161696263, 858.5835869603237, 865.9350548708873, 867.3538214030556, 870.4777133719749, 925.1165137293868, 925.6066171876959, 927.8097989912052, 930.060638754859, 930.2604429478581, 702.2100137345486, 721.8772808622547, 916.1067958740175, 919.2875521470846, 919.5953780336664, 535.5715427657858, 537.3551737914479, 537.6666466790615, 652.0414989964792, 665.9567128136704, 15238.695226095528, 15299.235038248044, 15307.693846123126, 15311.846881531264, 15334.539963800993, 13781.242031688253, 13923.164610123426, 13950.302484875818, 14053.859461405358, 14216.715665686628, 11951.462184201731, 12423.813642795365, 12446.81329780054, 12663.620091397273, 12941.417636206299, 4204.810783514749, 4228.894277643083, 4352.36890650857, 4352.412424322708, 4353.346997950302, 113948.0, 116598.0, 117176.41411792971, 119746.0, 122543.3872830639, 10837.891621083689, 10909.672709818718, 11062.446877656084, 11084.61203857861, 11133.665990020312, 21863.672044919338, 21973.780262197175, 21992.01035953386, 22025.449363765714, 22387.32838014862, 7844.4901081429525, 7845.8973514231375, 7884.802879928047, 7886.5662388568035, 7937.523748575104, 3668.4497325401403, 4285.271503844354, 4325.713687964752, 4487.125010622897, 4511.481179664315, 3483.7387195959896, 3591.317649646559, 3592.820358982093, 3604.1530240393486, 3606.1345277133823, 632.6393955445444, 648.9902651460231, 652.3672038123108, 660.739008091801, 666.6999850067489, 601.711178634258, 619.2568917299259, 629.9181106456132, 636.8917284061628, 650.7364517370378, 8446.662133514714, 8966.237869781142, 9005.504697241584, 9008.234300084436, 9200.769980750401, 526.4025331248984, 562.521856422038, 626.4643729611117, 643.6942452335197, 644.2494493914537, 4202.2646036944025, 4388.100439409914, 4433.578810013044, 4454.888627784267, 4488.865334039984, 97606.02393976111, 136913.3154334222, 151824.0, 164628.17685911493, 165010.0, 115831.42084289693, 123846.38076809558, 124592.0, 132945.0, 138474.0, 117605.0, 118069.0, 120464.3976780128, 122614.0, 123170.0, 8290.958545207235, 8543.786405339917, 8566.700165494427, 8572.699955501528, 8747.081556436482, 66107.00839487508, 66477.0, 67405.64080257168, 67843.0, 70062.0, 64350.71298574096, 68542.0, 97225.0, 98009.0, 101561.0, 9866.85199722019, 11385.089192864385, 11495.885041149482, 11699.824502632297, 11942.449618567067, 11884.286942783461, 12161.87838121643, 12341.75316493683, 12847.357632118543, 12899.871001289866, 11036.779264414827, 11037.83443248368, 11569.537218511165, 11716.882831171579, 11939.925406713437, 11268.211225214156, 12153.392330383622, 12216.816747748613, 12252.509899603916, 12551.121421500407, 11338.319700817978, 11348.60279890233, 11539.596114135966, 11616.833939104074, 11878.168528203289, 10048.196144308291, 10091.19270458347, 10102.314492897469, 10596.258261921592, 10599.841002385125, 9799.0, 10303.3817970922, 10341.586336546454, 10407.22854337679, 10411.0], "value": 7602.797109983507, "unit": "score"}], "name": "dromaeo_css", "value": 7293.724561913238, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 168.0, 167.0, 113.0, 113.0, 113.0, 115.0, 113.0, 119.0, 129.0], "value": 130.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 106.0, 120.0, 139.0, 106.0, 108.0, 107.0, 108.0, 139.0, 108.0], "value": 118.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 185.0, 181.0, 183.0, 182.0, 183.0, 182.0, 182.0, 183.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 62.0, 97.0, 86.0, 48.0, 75.0, 82.0, 109.0, 83.0], "value": 78.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 107.0, 65.0, 98.0, 101.0, 131.0, 90.0, 68.0, 90.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 87.0, 88.0, 86.0, 91.0, 87.0, 90.0, 86.0], "value": 88.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 106.0, 96.0, 97.0, 95.0, 94.0], "value": 96.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 86.0, 84.0, 83.0, 90.0, 71.0, 109.0, 134.0], "value": 91.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 53.0, 54.0, 56.0, 58.0, 58.0, 57.0, 56.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 74.0, 72.0, 72.0, 70.0, 68.0, 69.0, 69.0, 72.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 82.0, 82.0, 84.0, 85.0, 84.0, 90.0, 89.0, 101.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 147.0, 138.0, 140.0, 136.0, 138.0, 135.0, 154.0, 146.0, 150.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 169.0, 167.0, 169.0, 166.0, 169.0, 166.0, 164.0, 168.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 78.0, 88.0, 87.0, 65.0, 59.0, 82.0, 83.0, 84.0, 86.0], "value": 77.5, "unit": "score"}], "name": "kraken", "value": 1479.3, "alertThreshold": 2.0}]} 22:44:50 INFO - Return code: 0 22:44:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:44:50 INFO - # TBPL SUCCESS # 22:44:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:44:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:44:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:44:50 INFO - 2016-10-25 22:44:50.836 screenresolution[1673:9973] starting screenresolution argv=screenresolution get 22:44:50 INFO - 2016-10-25 22:44:50.839 screenresolution[1673:9973] Display 0: 1600x1200x32@60 22:44:50 INFO - 2016-10-25 22:44:50.845 screenresolution[1674:9976] starting screenresolution argv=screenresolution list 22:44:50 INFO - Available Modes on Display 0 22:44:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:44:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:44:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:44:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:44:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:44:51 INFO - Intel Iris: 22:44:51 INFO - Chipset Model: Intel Iris 22:44:51 INFO - Type: GPU 22:44:51 INFO - Bus: Built-In 22:44:51 INFO - VRAM (Dynamic, Max): 1536 MB 22:44:51 INFO - Vendor: Intel (0x8086) 22:44:51 INFO - Device ID: 0x0a2e 22:44:51 INFO - Revision ID: 0x0009 22:44:51 INFO - Displays: 22:44:51 INFO - Display: 22:44:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:44:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:44:51 INFO - Display Serial Number: 1600x1200 60 22:44:51 INFO - Main Display: Yes 22:44:51 INFO - Mirror: Off 22:44:51 INFO - Online: Yes 22:44:51 INFO - Rotation: Supported 22:44:51 INFO - Return code: 0 22:44:51 INFO - Running post-action listener: _resource_record_post_action 22:44:51 INFO - [mozharness: 2016-10-26 05:44:51.078400Z] Finished run-tests step (success) 22:44:51 INFO - Running post-run listener: _resource_record_post_run 22:44:51 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 37704704; Write bytes: 664712192; Read time: 243; Write time: 1844 22:44:51 INFO - TinderboxPrint: CPU usage
53.3% 22:44:51 INFO - TinderboxPrint: I/O read bytes / time
37,704,704 / 243 22:44:51 INFO - TinderboxPrint: I/O write bytes / time
664,712,192 / 1,844 22:44:51 INFO - TinderboxPrint: CPU idle
2,258.0 (46.7%) 22:44:51 INFO - TinderboxPrint: CPU system
966.0 (20.0%) 22:44:51 INFO - TinderboxPrint: CPU user
1,609.8 (33.3%) 22:44:51 INFO - TinderboxPrint: Swap in / out
415,559,680 / 0 22:44:51 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358683136; Write bytes: 356845056; Read time: 27598; Write time: 699 22:44:51 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 35787776; Write bytes: 296877568; Read time: 224; Write time: 1108 22:44:51 INFO - Running post-run listener: _upload_blobber_files 22:44:51 INFO - Blob upload gear active. 22:44:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:44:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:44:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:44:51 INFO - (blobuploader) - INFO - Open directory for files ... 22:44:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:44:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:44:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:44:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:44:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:44:53 INFO - (blobuploader) - INFO - Done attempting. 22:44:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:44:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:44:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:44:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:44:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:44:54 INFO - (blobuploader) - INFO - Done attempting. 22:44:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:44:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:44:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:44:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:44:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:44:56 INFO - (blobuploader) - INFO - Done attempting. 22:44:56 INFO - (blobuploader) - INFO - Iteration through files over. 22:44:56 INFO - Return code: 0 22:44:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:44:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:44:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c52d878e5b734f30c3d80a9921bfeb8dcd02f4ed603c42ea66ad75dfa9884a75d73fec6bde167b80ae12940554a6b3f636bec2f9138d1390ba89c3cc8f1af3b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14933dfb731a5cc9a12de6eb60c6f4799908fba98fa303ad91cca891d54ddf89bcc79614de5a6ef8e81019469e69ec421fd315adc95e3788ac4d10e83ba1a217", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7058be5a7fa4a85ea1f141cf6bd4e298f5c13fd87678c71bdda0e4523a5546017b2c0c877c32a9d3076ca041d660a91c9183f7097dad9c79737328fa49b7381d"} 22:44:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:44:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:44:56 INFO - Contents: 22:44:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c52d878e5b734f30c3d80a9921bfeb8dcd02f4ed603c42ea66ad75dfa9884a75d73fec6bde167b80ae12940554a6b3f636bec2f9138d1390ba89c3cc8f1af3b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14933dfb731a5cc9a12de6eb60c6f4799908fba98fa303ad91cca891d54ddf89bcc79614de5a6ef8e81019469e69ec421fd315adc95e3788ac4d10e83ba1a217", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7058be5a7fa4a85ea1f141cf6bd4e298f5c13fd87678c71bdda0e4523a5546017b2c0c877c32a9d3076ca041d660a91c9183f7097dad9c79737328fa49b7381d"} 22:44:56 INFO - Running post-run listener: copy_logs_to_upload_dir 22:44:56 INFO - Copying logs to upload dir... 22:44:56 INFO - mkdir: /builds/slave/test/build/upload/logs 22:44:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.527546 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-25 22:44:56.285772) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 22:44:56.289835) ========= 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.iXIXq8B3jz/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.CZRoQw0Nwr/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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/Mozilla-Aurora/sha512/c52d878e5b734f30c3d80a9921bfeb8dcd02f4ed603c42ea66ad75dfa9884a75d73fec6bde167b80ae12940554a6b3f636bec2f9138d1390ba89c3cc8f1af3b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14933dfb731a5cc9a12de6eb60c6f4799908fba98fa303ad91cca891d54ddf89bcc79614de5a6ef8e81019469e69ec421fd315adc95e3788ac4d10e83ba1a217", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7058be5a7fa4a85ea1f141cf6bd4e298f5c13fd87678c71bdda0e4523a5546017b2c0c877c32a9d3076ca041d660a91c9183f7097dad9c79737328fa49b7381d"} build_url:https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011200 build_url: 'https://queue.taskcluster.net/v1/task/AY-9-Pb2TxyF2C9SVLYsig/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c52d878e5b734f30c3d80a9921bfeb8dcd02f4ed603c42ea66ad75dfa9884a75d73fec6bde167b80ae12940554a6b3f636bec2f9138d1390ba89c3cc8f1af3b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14933dfb731a5cc9a12de6eb60c6f4799908fba98fa303ad91cca891d54ddf89bcc79614de5a6ef8e81019469e69ec421fd315adc95e3788ac4d10e83ba1a217", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7058be5a7fa4a85ea1f141cf6bd4e298f5c13fd87678c71bdda0e4523a5546017b2c0c877c32a9d3076ca041d660a91c9183f7097dad9c79737328fa49b7381d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 22:44:56.325033) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 22:44:56.325419) ========= 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.iXIXq8B3jz/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.CZRoQw0Nwr/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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.005157 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 22:44:56.375786) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 22:44:56.376185) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 22:44:56.376633) ========= ========= Total master_lag: 0.18 =========