builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0184 starttime: 1476804204.19 results: success (0) buildid: 20161018060622 builduid: 90f0c3d022cb442990b711e1bde341e6 revision: 188a166bcec250089c5d0555b29ef73ba554caad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 08:23:24.189426) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 08:23:24.190131) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 08:23:24.190638) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 08:23:24.218351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 08:23:24.218950) ========= 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.eLM1isedbD/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.RA9xiXD2Vh/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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-18 08:23:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2016-10-18 08:23:24 (168 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090678 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 08:23:24.334169) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 08:23:24.334648) ========= 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.eLM1isedbD/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.RA9xiXD2Vh/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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.028538 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 08:23:24.387350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 08:23:24.387961) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 188a166bcec250089c5d0555b29ef73ba554caad --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 188a166bcec250089c5d0555b29ef73ba554caad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eLM1isedbD/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.RA9xiXD2Vh/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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-18 08:23:24,464 truncating revision to first 12 chars 2016-10-18 08:23:24,465 Setting DEBUG logging. 2016-10-18 08:23:24,465 attempt 1/10 2016-10-18 08:23:24,465 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/188a166bcec2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 08:23:25,531 unpacking tar archive at: mozilla-aurora-188a166bcec2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.328356 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 08:23:25.742637) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 08:23:25.743305) ========= script_repo_revision: 188a166bcec250089c5d0555b29ef73ba554caad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 08:23:25.744095) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 08:23:25.744723) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 08:23:25.766322) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-18 08:23:25.766968) ========= /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.eLM1isedbD/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.RA9xiXD2Vh/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 08:23:25 INFO - MultiFileLogger online at 20161018 08:23:25 in /builds/slave/test 08:23:25 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 08:23:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:23:25 INFO - {'append_to_log': False, 08:23:25 INFO - 'base_work_dir': '/builds/slave/test', 08:23:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:23:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:23:25 INFO - 'branch': 'Mozilla-Aurora', 08:23:25 INFO - 'buildbot_json_path': 'buildprops.json', 08:23:25 INFO - 'config_files': ('talos/mac_config.py',), 08:23:25 INFO - 'default_actions': ('clobber', 08:23:25 INFO - 'read-buildbot-config', 08:23:25 INFO - 'download-and-extract', 08:23:25 INFO - 'populate-webroot', 08:23:25 INFO - 'create-virtualenv', 08:23:25 INFO - 'install', 08:23:25 INFO - 'run-tests'), 08:23:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:23:25 INFO - 'download_minidump_stackwalk': True, 08:23:25 INFO - 'download_symbols': 'ondemand', 08:23:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:23:25 INFO - 'tooltool.py': '/tools/tooltool.py', 08:23:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:23:25 INFO - '/tools/misc-python/virtualenv.py')}, 08:23:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:23:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:23:25 INFO - 'installer_path': 'installer.exe', 08:23:25 INFO - 'log_level': 'info', 08:23:25 INFO - 'log_name': 'talos', 08:23:25 INFO - 'log_to_console': True, 08:23:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:23:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:23:25 INFO - 'opt_config_files': (), 08:23:25 INFO - 'pip_index': False, 08:23:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:23:25 INFO - 'cmd': ('bash', 08:23:25 INFO - '-c', 08:23:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:23:25 INFO - 'enabled': True, 08:23:25 INFO - 'halt_on_failure': False, 08:23:25 INFO - 'name': 'check_screen_resolution'},), 08:23:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:23:25 INFO - 'cmd': ('bash', 08:23:25 INFO - '-c', 08:23:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:23:25 INFO - 'enabled': True, 08:23:25 INFO - 'halt_on_failure': False, 08:23:25 INFO - 'name': 'check_screen_resolution'},), 08:23:25 INFO - 'run_cmd_checks_enabled': True, 08:23:25 INFO - 'sps_profile': False, 08:23:25 INFO - 'sps_profile_interval': 0, 08:23:25 INFO - 'suite': 'dromaeojs', 08:23:25 INFO - 'system_bits': '32', 08:23:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:23:25 INFO - 'title': 't-yosemite-r7-0184', 08:23:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:23:25 INFO - 'use_talos_json': True, 08:23:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:23:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:23:25 INFO - 'work_dir': 'build'} 08:23:25 INFO - [mozharness: 2016-10-18 15:23:25.985492Z] Running clobber step. 08:23:25 INFO - Running pre-action listener: _resource_record_pre_action 08:23:25 INFO - Running main action method: clobber 08:23:25 INFO - rmtree: /builds/slave/test/build 08:23:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:23:28 INFO - Running post-action listener: _resource_record_post_action 08:23:28 INFO - [mozharness: 2016-10-18 15:23:28.299294Z] Finished clobber step (success) 08:23:28 INFO - [mozharness: 2016-10-18 15:23:28.299413Z] Running read-buildbot-config step. 08:23:28 INFO - Running pre-action listener: _resource_record_pre_action 08:23:28 INFO - Running main action method: read_buildbot_config 08:23:28 INFO - Using buildbot properties: 08:23:28 INFO - { 08:23:28 INFO - "project": "", 08:23:28 INFO - "product": "firefox", 08:23:28 INFO - "script_repo_revision": "production", 08:23:28 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:23:28 INFO - "repository": "", 08:23:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:23:28 INFO - "buildid": "20161018060622", 08:23:28 INFO - "pgo_build": "False", 08:23:28 INFO - "basedir": "/builds/slave/test", 08:23:28 INFO - "buildnumber": 54, 08:23:28 INFO - "slavename": "t-yosemite-r7-0184", 08:23:28 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:23:28 INFO - "platform": "yosemite_r7", 08:23:28 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:23:28 INFO - "branch": "mozilla-aurora", 08:23:28 INFO - "repo_path": "releases/mozilla-aurora", 08:23:28 INFO - "revision": "188a166bcec250089c5d0555b29ef73ba554caad", 08:23:28 INFO - "stage_platform": "macosx64", 08:23:28 INFO - "builduid": "90f0c3d022cb442990b711e1bde341e6", 08:23:28 INFO - "slavebuilddir": "test" 08:23:28 INFO - } 08:23:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 08:23:28 INFO - Running post-action listener: _resource_record_post_action 08:23:28 INFO - [mozharness: 2016-10-18 15:23:28.302527Z] Finished read-buildbot-config step (success) 08:23:28 INFO - [mozharness: 2016-10-18 15:23:28.302630Z] Running download-and-extract step. 08:23:28 INFO - Running pre-action listener: _resource_record_pre_action 08:23:28 INFO - Running main action method: download_and_extract 08:23:28 INFO - mkdir: /builds/slave/test/build/tests 08:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:28 INFO - trying https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 08:23:28 INFO - Downloading https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/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 08:23:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/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 08:23:29 INFO - Downloaded 1199 bytes. 08:23:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 08:23:29 INFO - Using the following test package requirements: 08:23:29 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 08:23:29 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:23:29 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 08:23:29 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:23:29 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 08:23:29 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:23:29 INFO - u'jsshell-mac.zip'], 08:23:29 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:23:29 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 08:23:29 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 08:23:29 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:23:29 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 08:23:29 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:23:29 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 08:23:29 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:23:29 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 08:23:29 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:23:29 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 08:23:29 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:23:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 08:23:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:23:29 INFO - Fetch https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 08:23:29 INFO - Expected file size: 16435714 08:23:36 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 08:23:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 08:23:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:23:36 INFO - Fetch https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 08:23:37 INFO - Expected file size: 16435714 08:23:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 08:23:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:23:43 INFO - Fetch https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 08:23:44 INFO - Expected file size: 14414081 08:23:45 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')]} 08:23:45 INFO - trying https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:23:45 INFO - Downloading https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 08:23:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/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 08:23:48 INFO - Downloaded 115412294 bytes. 08:23:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:23:48 INFO - mkdir: /builds/slave/test/properties 08:23:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:23:48 INFO - Writing to file /builds/slave/test/properties/build_url 08:23:48 INFO - Contents: 08:23:48 INFO - build_url:https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:23:49 INFO - Running post-action listener: _resource_record_post_action 08:23:49 INFO - Running post-action listener: set_extra_try_arguments 08:23:49 INFO - [mozharness: 2016-10-18 15:23:49.080209Z] Finished download-and-extract step (success) 08:23:49 INFO - [mozharness: 2016-10-18 15:23:49.080328Z] Running populate-webroot step. 08:23:49 INFO - Running pre-action listener: _resource_record_pre_action 08:23:49 INFO - Running main action method: populate_webroot 08:23:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:23:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:23:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:23:49 INFO - '--tppagecycles', 08:23:49 INFO - '7'], 08:23:49 INFO - 'tests': ['tsvgm']}}, 08:23:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:23:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:23:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:23:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:23:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:49 INFO - 'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:49 INFO - 'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['damp', 'tps']}, 08:23:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:49 INFO - 'tests': ['damp', 'tps']}, 08:23:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['dromaeo_dom']}, 08:23:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:23:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['basic_compositor_video']}, 08:23:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:23:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['a11yr', 08:23:49 INFO - 'ts_paint', 08:23:49 INFO - 'tpaint', 08:23:49 INFO - 'sessionrestore', 08:23:49 INFO - 'sessionrestore_no_auto_restore', 08:23:49 INFO - 'tabpaint']}, 08:23:49 INFO - 'other-e10s': {'tests': ['a11yr', 08:23:49 INFO - 'ts_paint', 08:23:49 INFO - 'tpaint', 08:23:49 INFO - 'sessionrestore', 08:23:49 INFO - 'sessionrestore_no_auto_restore', 08:23:49 INFO - 'tabpaint']}, 08:23:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:23:49 INFO - 'ts_paint', 08:23:49 INFO - 'tpaint', 08:23:49 INFO - 'sessionrestore', 08:23:49 INFO - 'sessionrestore_no_auto_restore', 08:23:49 INFO - 'tabpaint']}, 08:23:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:23:49 INFO - 'ts_paint', 08:23:49 INFO - 'tpaint', 08:23:49 INFO - 'sessionrestore', 08:23:49 INFO - 'sessionrestore_no_auto_restore', 08:23:49 INFO - 'tabpaint']}, 08:23:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['a11yr', 08:23:49 INFO - 'ts_paint', 08:23:49 INFO - 'tpaint', 08:23:49 INFO - 'sessionrestore', 08:23:49 INFO - 'sessionrestore_no_auto_restore', 08:23:49 INFO - 'tabpaint']}, 08:23:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['a11yr', 08:23:49 INFO - 'ts_paint', 08:23:49 INFO - 'tpaint', 08:23:49 INFO - 'sessionrestore', 08:23:49 INFO - 'sessionrestore_no_auto_restore', 08:23:49 INFO - 'tabpaint']}, 08:23:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['tsvgx', 08:23:49 INFO - 'tsvgr_opacity', 08:23:49 INFO - 'tart', 08:23:49 INFO - 'tscrollx', 08:23:49 INFO - 'cart']}, 08:23:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:23:49 INFO - 'tsvgr_opacity', 08:23:49 INFO - 'tart', 08:23:49 INFO - 'tscrollx', 08:23:49 INFO - 'cart']}, 08:23:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:49 INFO - 'talos_options': ['--disable-e10s'], 08:23:49 INFO - 'tests': ['tp5o']}, 08:23:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:49 INFO - 'tests': ['tp5o']}, 08:23:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:49 INFO - 'talos_options': ['--disable-e10s', 08:23:49 INFO - '--xperf_path', 08:23:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:49 INFO - 'tests': ['tp5n']}, 08:23:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:49 INFO - 'talos_options': ['--xperf_path', 08:23:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:49 INFO - 'tests': ['tp5n']}}, 08:23:49 INFO - 'talos.zip': {'path': '', 08:23:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:23:49 INFO - Running post-action listener: _resource_record_post_action 08:23:49 INFO - [mozharness: 2016-10-18 15:23:49.098702Z] Finished populate-webroot step (success) 08:23:49 INFO - [mozharness: 2016-10-18 15:23:49.098821Z] Running create-virtualenv step. 08:23:49 INFO - Running pre-action listener: _resource_record_pre_action 08:23:49 INFO - Running main action method: create_virtualenv 08:23:49 INFO - Creating virtualenv /builds/slave/test/build/venv 08:23:49 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 08:23:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:23:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:23:49 INFO - Using real prefix '/tools/python27' 08:23:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:23:49 INFO - Installing distribute.............................................................................................................................................................................................done. 08:23:52 INFO - Installing pip.................done. 08:23:52 INFO - Return code: 0 08:23:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:23:52 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')]} 08:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:52 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')]} 08:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:52 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 0x109546490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd888d3c850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935ad30>, '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 0x1091c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109352b20>, '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.eLM1isedbD/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.RA9xiXD2Vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 08:23:52 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 08:23:52 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 08:23:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eLM1isedbD/Render', 08:23:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:52 INFO - 'HOME': '/Users/cltbld', 08:23:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:52 INFO - 'LOGNAME': 'cltbld', 08:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:52 INFO - 'MOZ_NO_REMOTE': '1', 08:23:52 INFO - 'NO_EM_RESTART': '1', 08:23:52 INFO - 'PAGER': '/bin/cat', 08:23:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:52 INFO - 'PWD': '/builds/slave/test', 08:23:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:52 INFO - 'SHELL': '/bin/bash', 08:23:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA9xiXD2Vh/Listeners', 08:23:52 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:23:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:52 INFO - 'USER': 'cltbld', 08:23:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:52 INFO - 'XPC_FLAGS': '0x0', 08:23:52 INFO - 'XPC_SERVICE_NAME': '0', 08:23:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:53 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 08:23:53 INFO - Cleaning up... 08:23:53 INFO - Return code: 0 08:23:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:23:53 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')]} 08:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:53 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')]} 08:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:53 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 0x109546490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd888d3c850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935ad30>, '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 0x1091c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109352b20>, '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.eLM1isedbD/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.RA9xiXD2Vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 08:23:53 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 08:23:53 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 08:23:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eLM1isedbD/Render', 08:23:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:53 INFO - 'HOME': '/Users/cltbld', 08:23:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:53 INFO - 'LOGNAME': 'cltbld', 08:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:53 INFO - 'MOZ_NO_REMOTE': '1', 08:23:53 INFO - 'NO_EM_RESTART': '1', 08:23:53 INFO - 'PAGER': '/bin/cat', 08:23:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:53 INFO - 'PWD': '/builds/slave/test', 08:23:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:53 INFO - 'SHELL': '/bin/bash', 08:23:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA9xiXD2Vh/Listeners', 08:23:53 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:23:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:53 INFO - 'USER': 'cltbld', 08:23:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:53 INFO - 'XPC_FLAGS': '0x0', 08:23:53 INFO - 'XPC_SERVICE_NAME': '0', 08:23:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:53 INFO - Downloading/unpacking psutil>=3.1.1 08:23:53 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 08:23:53 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 08:23:53 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 08:23:53 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 08:23:53 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 08:23:53 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 08:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:23:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:56 INFO - Installing collected packages: psutil 08:23:56 INFO - Running setup.py install for psutil 08:23:56 INFO - building 'psutil._psutil_osx' extension 08:23:56 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 08:23:57 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 08:23:57 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 08:23:57 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 08:23:57 INFO - building 'psutil._psutil_posix' extension 08:23:57 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 08:23:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:23:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:23:57 INFO - ^ 08:23:57 INFO - 1 warning generated. 08:23:57 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 08:23:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:57 INFO - Successfully installed psutil 08:23:57 INFO - Cleaning up... 08:23:57 INFO - Return code: 0 08:23:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:23:57 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')]} 08:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:57 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')]} 08:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:57 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 0x109546490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd888d3c850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935ad30>, '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 0x1091c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109352b20>, '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.eLM1isedbD/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.RA9xiXD2Vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 08:23:57 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 08:23:57 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 08:23:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eLM1isedbD/Render', 08:23:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:57 INFO - 'HOME': '/Users/cltbld', 08:23:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:57 INFO - 'LOGNAME': 'cltbld', 08:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:57 INFO - 'MOZ_NO_REMOTE': '1', 08:23:57 INFO - 'NO_EM_RESTART': '1', 08:23:57 INFO - 'PAGER': '/bin/cat', 08:23:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:57 INFO - 'PWD': '/builds/slave/test', 08:23:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:57 INFO - 'SHELL': '/bin/bash', 08:23:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA9xiXD2Vh/Listeners', 08:23:57 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:23:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:57 INFO - 'USER': 'cltbld', 08:23:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:57 INFO - 'XPC_FLAGS': '0x0', 08:23:57 INFO - 'XPC_SERVICE_NAME': '0', 08:23:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:23:57 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 08:23:57 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 08:23:57 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 08:23:57 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 08:23:57 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 08:23:57 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 08:24:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:24:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:24:00 INFO - Installing collected packages: mozsystemmonitor 08:24:00 INFO - Running setup.py install for mozsystemmonitor 08:24:00 INFO - Successfully installed mozsystemmonitor 08:24:00 INFO - Cleaning up... 08:24:00 INFO - Return code: 0 08:24:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109546490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd888d3c850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935ad30>, '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 0x1091c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109352b20>, '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.eLM1isedbD/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.RA9xiXD2Vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 08:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:24:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eLM1isedbD/Render', 08:24:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:00 INFO - 'HOME': '/Users/cltbld', 08:24:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:00 INFO - 'LOGNAME': 'cltbld', 08:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:00 INFO - 'MOZ_NO_REMOTE': '1', 08:24:00 INFO - 'NO_EM_RESTART': '1', 08:24:00 INFO - 'PAGER': '/bin/cat', 08:24:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:00 INFO - 'PWD': '/builds/slave/test', 08:24:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:00 INFO - 'SHELL': '/bin/bash', 08:24:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA9xiXD2Vh/Listeners', 08:24:00 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:24:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:00 INFO - 'USER': 'cltbld', 08:24:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:00 INFO - 'XPC_FLAGS': '0x0', 08:24:00 INFO - 'XPC_SERVICE_NAME': '0', 08:24:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:01 INFO - Downloading/unpacking jsonschema==2.5.1 08:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:24:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:24:03 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 08:24:03 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 08:24:03 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 08:24:03 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 08:24:03 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 08:24:03 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 08:24:03 INFO - Downloading functools32-3.2.3-2.tar.gz 08:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:24:03 INFO - warning: no files found matching '*.txt' 08:24:03 INFO - no previously-included directories found matching 'build' 08:24:03 INFO - no previously-included directories found matching 'dist' 08:24:03 INFO - no previously-included directories found matching '.git*' 08:24:03 INFO - Installing collected packages: jsonschema, functools32 08:24:04 INFO - Running setup.py install for functools32 08:24:04 INFO - warning: no files found matching '*.txt' 08:24:04 INFO - no previously-included directories found matching 'build' 08:24:04 INFO - no previously-included directories found matching 'dist' 08:24:04 INFO - no previously-included directories found matching '.git*' 08:24:04 INFO - Successfully installed jsonschema functools32 08:24:04 INFO - Cleaning up... 08:24:04 INFO - Return code: 0 08:24:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:04 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 0x109546490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd888d3c850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935ad30>, '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 0x1091c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109352b20>, '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.eLM1isedbD/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.RA9xiXD2Vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 08:24:04 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 08:24:04 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 08:24:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eLM1isedbD/Render', 08:24:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:04 INFO - 'HOME': '/Users/cltbld', 08:24:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:04 INFO - 'LOGNAME': 'cltbld', 08:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:04 INFO - 'MOZ_NO_REMOTE': '1', 08:24:04 INFO - 'NO_EM_RESTART': '1', 08:24:04 INFO - 'PAGER': '/bin/cat', 08:24:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:04 INFO - 'PWD': '/builds/slave/test', 08:24:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:04 INFO - 'SHELL': '/bin/bash', 08:24:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA9xiXD2Vh/Listeners', 08:24:04 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:24:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:04 INFO - 'USER': 'cltbld', 08:24:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:04 INFO - 'XPC_FLAGS': '0x0', 08:24:04 INFO - 'XPC_SERVICE_NAME': '0', 08:24:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:24:04 INFO - Cleaning up... 08:24:04 INFO - Return code: 0 08:24:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:04 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 0x109546490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd888d3c850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935ad30>, '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 0x1091c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109352b20>, '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.eLM1isedbD/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.RA9xiXD2Vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 08:24:04 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 08:24:04 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 08:24:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eLM1isedbD/Render', 08:24:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:04 INFO - 'HOME': '/Users/cltbld', 08:24:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:04 INFO - 'LOGNAME': 'cltbld', 08:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:04 INFO - 'MOZ_NO_REMOTE': '1', 08:24:04 INFO - 'NO_EM_RESTART': '1', 08:24:04 INFO - 'PAGER': '/bin/cat', 08:24:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:04 INFO - 'PWD': '/builds/slave/test', 08:24:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:04 INFO - 'SHELL': '/bin/bash', 08:24:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA9xiXD2Vh/Listeners', 08:24:04 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:24:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:04 INFO - 'USER': 'cltbld', 08:24:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:04 INFO - 'XPC_FLAGS': '0x0', 08:24:04 INFO - 'XPC_SERVICE_NAME': '0', 08:24:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:04 INFO - Downloading/unpacking blobuploader==1.2.4 08:24:04 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 08:24:04 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 08:24:04 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 08:24:04 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 08:24:04 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 08:24:04 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 08:24:07 INFO - Downloading blobuploader-1.2.4.tar.gz 08:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:24:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:24:07 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 08:24:07 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 08:24:07 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 08:24:07 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 08:24:07 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 08:24:07 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 08:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:24:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:24:08 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 08:24:08 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 08:24:08 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 08:24:08 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 08:24:08 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 08:24:08 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 08:24:08 INFO - Downloading docopt-0.6.1.tar.gz 08:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:24:08 INFO - Installing collected packages: blobuploader, requests, docopt 08:24:08 INFO - Running setup.py install for blobuploader 08:24:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:24:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:24:08 INFO - Running setup.py install for requests 08:24:09 INFO - Running setup.py install for docopt 08:24:09 INFO - Successfully installed blobuploader requests docopt 08:24:09 INFO - Cleaning up... 08:24:09 INFO - Return code: 0 08:24:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:09 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 0x109546490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd888d3c850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935ad30>, '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 0x1091c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109352b20>, '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.eLM1isedbD/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.RA9xiXD2Vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 08:24:09 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 08:24:09 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 08:24:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eLM1isedbD/Render', 08:24:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:09 INFO - 'HOME': '/Users/cltbld', 08:24:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:09 INFO - 'LOGNAME': 'cltbld', 08:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:09 INFO - 'MOZ_NO_REMOTE': '1', 08:24:09 INFO - 'NO_EM_RESTART': '1', 08:24:09 INFO - 'PAGER': '/bin/cat', 08:24:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:09 INFO - 'PWD': '/builds/slave/test', 08:24:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:09 INFO - 'SHELL': '/bin/bash', 08:24:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA9xiXD2Vh/Listeners', 08:24:09 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:24:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:09 INFO - 'USER': 'cltbld', 08:24:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:09 INFO - 'XPC_FLAGS': '0x0', 08:24:09 INFO - 'XPC_SERVICE_NAME': '0', 08:24:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:09 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-EWnYD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:09 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-4fAwQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:09 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-ncN80g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:10 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-BaZqaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:10 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-b5Ugp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:10 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-vFW3ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:10 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-Xbo0w6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:10 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-XmriH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:10 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-9kiu0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:10 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-RTTdgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:10 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-FcL7BV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:10 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-rnac7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:10 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-NtnJ14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:11 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-UqkePW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:11 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-9qfzDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:11 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-fTnU4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:11 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-9DngqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:24:11 INFO - Running setup.py install for manifestparser 08:24:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:24:11 INFO - Running setup.py install for mozcrash 08:24:11 INFO - Running setup.py install for mozdebug 08:24:11 INFO - Running setup.py install for mozdevice 08:24:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:24:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:24:12 INFO - Running setup.py install for mozfile 08:24:12 INFO - Running setup.py install for mozhttpd 08:24:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:24:12 INFO - Running setup.py install for mozinfo 08:24:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:24:12 INFO - Running setup.py install for mozInstall 08:24:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:24:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:24:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:24:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:24:12 INFO - Running setup.py install for mozleak 08:24:12 INFO - Running setup.py install for mozlog 08:24:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:24:12 INFO - Running setup.py install for moznetwork 08:24:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:24:13 INFO - Running setup.py install for mozprocess 08:24:13 INFO - Running setup.py install for mozprofile 08:24:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:24:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:24:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:24:13 INFO - Running setup.py install for mozrunner 08:24:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:24:13 INFO - Running setup.py install for mozscreenshot 08:24:13 INFO - Running setup.py install for moztest 08:24:13 INFO - Running setup.py install for mozversion 08:24:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:24:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:24:14 INFO - Cleaning up... 08:24:14 INFO - Return code: 0 08:24:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08: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')]} 08:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:14 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 0x109546490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd888d3c850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935ad30>, '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 0x1091c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109352b20>, '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.eLM1isedbD/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.RA9xiXD2Vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 08:24:14 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 08:24:14 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 08:24:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eLM1isedbD/Render', 08:24:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:14 INFO - 'HOME': '/Users/cltbld', 08:24:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:14 INFO - 'LOGNAME': 'cltbld', 08:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:14 INFO - 'MOZ_NO_REMOTE': '1', 08:24:14 INFO - 'NO_EM_RESTART': '1', 08:24:14 INFO - 'PAGER': '/bin/cat', 08:24:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:14 INFO - 'PWD': '/builds/slave/test', 08:24:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:14 INFO - 'SHELL': '/bin/bash', 08:24:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA9xiXD2Vh/Listeners', 08:24:14 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:24:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:14 INFO - 'USER': 'cltbld', 08:24:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:14 INFO - 'XPC_FLAGS': '0x0', 08:24:14 INFO - 'XPC_SERVICE_NAME': '0', 08:24:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:14 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-npcZ3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:14 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)) 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:14 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-kgnUd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:14 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)) 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:14 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-qvCHJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:14 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)) 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:14 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-2EonBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:14 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)) 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:14 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-xTmL7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:14 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)) 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:14 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-ucpMJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:14 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)) 08:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:14 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-U3XEyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:15 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)) 08:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:15 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-cHYqQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:15 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)) 08:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:15 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-sAile9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:15 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)) 08:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:15 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-Ey6vDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:15 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)) 08:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:15 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-BmrDzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:15 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)) 08:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:15 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-sCJpvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:15 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)) 08:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:15 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-eNO5gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:15 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)) 08:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:15 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-EJwZNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:15 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)) 08:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:15 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-PJGyAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:15 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)) 08:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:15 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-EpG3of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:16 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)) 08:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:16 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-FJJWji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:16 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)) 08:24:16 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)) 08:24:16 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)) 08:24:16 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)) 08:24:16 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)) 08:24:16 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)) 08:24:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:18 INFO - Downloading blessings-1.6.tar.gz 08:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:24:18 INFO - Installing collected packages: blessings 08:24:18 INFO - Running setup.py install for blessings 08:24:18 INFO - Successfully installed blessings 08:24:18 INFO - Cleaning up... 08:24:19 INFO - Return code: 0 08:24:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:24:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:24:19 INFO - Reading from file tmpfile_stdout 08:24:19 INFO - Current package versions: 08:24:19 INFO - blessings == 1.6 08:24:19 INFO - blobuploader == 1.2.4 08:24:19 INFO - docopt == 0.6.1 08:24:19 INFO - functools32 == 3.2.3-2 08:24:19 INFO - jsonschema == 2.5.1 08:24:19 INFO - manifestparser == 1.1 08:24:19 INFO - mozInstall == 1.12 08:24:19 INFO - mozcrash == 0.17 08:24:19 INFO - mozdebug == 0.1 08:24:19 INFO - mozdevice == 0.48 08:24:19 INFO - mozfile == 1.2 08:24:19 INFO - mozhttpd == 0.7 08:24:19 INFO - mozinfo == 0.9 08:24:19 INFO - mozleak == 0.1 08:24:19 INFO - mozlog == 3.4 08:24:19 INFO - moznetwork == 0.27 08:24:19 INFO - mozprocess == 0.23 08:24:19 INFO - mozprofile == 0.28 08:24:19 INFO - mozrunner == 6.12 08:24:19 INFO - mozscreenshot == 0.1 08:24:19 INFO - mozsystemmonitor == 0.3 08:24:19 INFO - moztest == 0.7 08:24:19 INFO - mozversion == 1.4 08:24:19 INFO - psutil == 3.1.1 08:24:19 INFO - requests == 1.2.3 08:24:19 INFO - wsgiref == 0.1.2 08:24:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08: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')]} 08:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:19 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 0x109546490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd888d3c850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935ad30>, '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 0x1091c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109352b20>, '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.eLM1isedbD/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.RA9xiXD2Vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 08:24:19 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 08:24:19 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 08:24:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eLM1isedbD/Render', 08:24:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:19 INFO - 'HOME': '/Users/cltbld', 08:24:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:19 INFO - 'LOGNAME': 'cltbld', 08:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:19 INFO - 'MOZ_NO_REMOTE': '1', 08:24:19 INFO - 'NO_EM_RESTART': '1', 08:24:19 INFO - 'PAGER': '/bin/cat', 08:24:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:19 INFO - 'PWD': '/builds/slave/test', 08:24:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:19 INFO - 'SHELL': '/bin/bash', 08:24:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA9xiXD2Vh/Listeners', 08:24:19 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:24:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:19 INFO - 'USER': 'cltbld', 08:24:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:19 INFO - 'XPC_FLAGS': '0x0', 08:24:19 INFO - 'XPC_SERVICE_NAME': '0', 08:24:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:19 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)) 08:24:19 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)) 08:24:19 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)) 08:24:19 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)) 08:24:19 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)) 08:24:19 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)) 08:24:19 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)) 08:24:19 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)) 08:24:19 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)) 08:24:19 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)) 08:24:19 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)) 08:24:19 INFO - Cleaning up... 08:24:19 INFO - Return code: 0 08:24:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08: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')]} 08:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109546490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd888d3c850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10935ad30>, '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 0x1091c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109352b20>, '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.eLM1isedbD/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.RA9xiXD2Vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 08: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', 'jsonschema'] in /builds/slave/test/build 08: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 jsonschema 08:24:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eLM1isedbD/Render', 08:24:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:19 INFO - 'HOME': '/Users/cltbld', 08:24:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:19 INFO - 'LOGNAME': 'cltbld', 08:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:19 INFO - 'MOZ_NO_REMOTE': '1', 08:24:19 INFO - 'NO_EM_RESTART': '1', 08:24:19 INFO - 'PAGER': '/bin/cat', 08:24:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:19 INFO - 'PWD': '/builds/slave/test', 08:24:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:19 INFO - 'SHELL': '/bin/bash', 08:24:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA9xiXD2Vh/Listeners', 08:24:19 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:24:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:19 INFO - 'USER': 'cltbld', 08:24:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:19 INFO - 'XPC_FLAGS': '0x0', 08:24:19 INFO - 'XPC_SERVICE_NAME': '0', 08:24:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:24:19 INFO - Cleaning up... 08:24:19 INFO - Return code: 0 08:24:19 INFO - Running post-action listener: _resource_record_post_action 08:24:19 INFO - Running post-action listener: _start_resource_monitoring 08:24:19 INFO - Starting resource monitoring. 08:24:19 INFO - [mozharness: 2016-10-18 15:24:19.914561Z] Finished create-virtualenv step (success) 08:24:19 INFO - [mozharness: 2016-10-18 15:24:19.915571Z] Running install step. 08:24:19 INFO - Running pre-action listener: _resource_record_pre_action 08:24:19 INFO - Running main action method: install 08:24:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:24:20 INFO - Reading from file tmpfile_stdout 08:24:20 INFO - Detecting whether we're running mozinstall >=1.0... 08:24:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:24:20 INFO - Reading from file tmpfile_stdout 08:24:20 INFO - Output received: 08:24:20 INFO - Usage: mozinstall [options] installer 08:24:20 INFO - Options: 08:24:20 INFO - -h, --help show this help message and exit 08:24:20 INFO - -d DEST, --destination=DEST 08:24:20 INFO - Directory to install application into. [default: 08:24:20 INFO - "/builds/slave/test"] 08:24:20 INFO - --app=APP Application being installed. [default: firefox] 08:24:20 INFO - mkdir: /builds/slave/test/build/application 08:24:20 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'] 08:24:20 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 08:24:52 INFO - Reading from file tmpfile_stdout 08:24:52 INFO - Output received: 08:24:52 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:24:52 INFO - Running post-action listener: _resource_record_post_action 08:24:52 INFO - [mozharness: 2016-10-18 15:24:52.923080Z] Finished install step (success) 08:24:52 INFO - [mozharness: 2016-10-18 15:24:52.923230Z] Running run-tests step. 08:24:52 INFO - Running pre-action listener: _resource_record_pre_action 08:24:52 INFO - Running main action method: run_tests 08:24:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:24:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:24:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:24:52 INFO - 2016-10-18 08:24:52.937 screenresolution[1633:7506] starting screenresolution argv=screenresolution get 08:24:52 INFO - 2016-10-18 08:24:52.940 screenresolution[1633:7506] Display 0: 1600x1200x32@60 08:24:52 INFO - 2016-10-18 08:24:52.946 screenresolution[1634:7509] starting screenresolution argv=screenresolution list 08:24:52 INFO - Available Modes on Display 0 08:24:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:24:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:24:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:24:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:24:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:24:53 INFO - Intel Iris: 08:24:53 INFO - Chipset Model: Intel Iris 08:24:53 INFO - Type: GPU 08:24:53 INFO - Bus: Built-In 08:24:53 INFO - VRAM (Dynamic, Max): 1536 MB 08:24:53 INFO - Vendor: Intel (0x8086) 08:24:53 INFO - Device ID: 0x0a2e 08:24:53 INFO - Revision ID: 0x0009 08:24:53 INFO - Displays: 08:24:53 INFO - Display: 08:24:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:24:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:24:53 INFO - Display Serial Number: 1600x1200 60 08:24:53 INFO - Main Display: Yes 08:24:53 INFO - Mirror: Off 08:24:53 INFO - Online: Yes 08:24:53 INFO - Rotation: Supported 08:24:53 INFO - Return code: 0 08:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:24:53 INFO - Python 2.7.3 08:24:53 INFO - Return code: 0 08:24:53 INFO - grabbing minidump binary from tooltool 08:24:53 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')]} 08:24:53 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 0x10935ad30>, '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 0x1091c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109352b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:24:53 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 08:24:53 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 08:24:53 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 08:24:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:24:53 INFO - Return code: 0 08:24:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:24:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:24:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:24:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:24:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:24:53 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/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0184', '--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 08:24:53 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/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0184 --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 08:24:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eLM1isedbD/Render', 08:24:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:53 INFO - 'HOME': '/Users/cltbld', 08:24:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:53 INFO - 'LOGNAME': 'cltbld', 08:24:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:24:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:53 INFO - 'MOZ_NO_REMOTE': '1', 08:24:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:24:53 INFO - 'NO_EM_RESTART': '1', 08:24:53 INFO - 'PAGER': '/bin/cat', 08:24:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:53 INFO - 'PWD': '/builds/slave/test', 08:24:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:24:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:53 INFO - 'SHELL': '/bin/bash', 08:24:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA9xiXD2Vh/Listeners', 08:24:53 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 08:24:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:53 INFO - 'USER': 'cltbld', 08:24:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:53 INFO - 'XPC_FLAGS': '0x0', 08:24:53 INFO - 'XPC_SERVICE_NAME': '0', 08:24:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:53 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/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0184', '--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 08:24:53 INFO - mozversion application_buildid: 20161018060622 08:24:53 INFO - mozversion application_changeset: 188a166bcec250089c5d0555b29ef73ba554caad 08:24:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:24:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:24:53 INFO - mozversion application_name: Firefox 08:24:53 INFO - mozversion application_remotingname: firefox-dev 08:24:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:24:53 INFO - mozversion application_vendor: Mozilla 08:24:53 INFO - mozversion application_version: 51.0a2 08:24:53 INFO - mozversion platform_buildid: 20161018060622 08:24:53 INFO - mozversion platform_changeset: 188a166bcec250089c5d0555b29ef73ba554caad 08:24:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:24:53 INFO - mozversion platform_version: 51.0a2 08:24:53 INFO - using testdate: 1476804293 08:24:53 INFO - actual date: 1476804293 08:24:53 INFO - starting webserver on 'localhost:49272' 08:24:53 INFO - SUITE-START | Running 2 tests 08:24:53 INFO - TEST-START | dromaeo_css 08:24:53 INFO - operating with platform_type : mac_ 08:24:53 INFO - Initialising browser for dromaeo_css test... 08:24:53 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpUz7B42/profile http://localhost:49272/getInfo.html) 08:24:55 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 08:24:55 INFO - PROCESS | 1644 | colorDepth:24 08:24:55 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 08:24:55 INFO - PROCESS | 1644 | __metrics 08:24:55 INFO - PROCESS | 1644 | 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" 08:24:55 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:24:56 INFO - TEST-INFO | 1644: exit 0 08:24:56 INFO - Browser initialized. 08:24:56 INFO - Running cycle 1/1 for dromaeo_css test... 08:24:56 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpUz7B42/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:08 INFO - PROCESS | 1646 | RSS: Main: 218968064 08:25:08 INFO - PROCESS | 1646 | 08:26:00 INFO - PROCESS | 1646 | 1476804360372 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] 08:28:11 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 08:28:12 INFO - PROCESS | 1646 | RSS: Main: 359432192 08:28:12 INFO - PROCESS | 1646 | 08:31:15 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 08:31:16 INFO - PROCESS | 1646 | RSS: Main: 350031872 08:31:16 INFO - PROCESS | 1646 | 08:34:18 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 08:34:19 INFO - PROCESS | 1646 | RSS: Main: 326615040 08:34:19 INFO - PROCESS | 1646 | 08:37:21 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 08:37:22 INFO - PROCESS | 1646 | RSS: Main: 335233024 08:37:22 INFO - PROCESS | 1646 | 08:40:25 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 08:40:26 INFO - PROCESS | 1646 | RSS: Main: 313716736 08:40:26 INFO - PROCESS | 1646 | 08:43:29 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 08:43:29 INFO - PROCESS | 1646 | RSS: Main: 363794432 08:43:29 INFO - PROCESS | 1646 | 08:43:29 INFO - PROCESS | 1646 | __start_tp_report 08:43:29 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 08:43:29 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 08:43:29 INFO - PROCESS | 1646 | |i|pagename|runs| 08:43:29 INFO - PROCESS | 1646 | |0;dojo.html;3143.1827724791556;3296.9010929672104;3320.003998800359;3325.700686938178;3361.1093060339012;5606.215129881814;5630.127330263816;5659.320881494226;5664.971675141624;5692.658440493563;5561.416051314614;5626.971865140668;5631.239782629344;5651.547876169907;5667.886642267152;5123.052235336456;5125.871853203663;5140.691558506502;5163.509466600667;5186.377634683843;5124.6668966517245;5145.485451454843;5146.5110814472755;5243.161094224924;5290.629655924067;5162.948370516285;5193.246979188016;5202.167653175493;5208.427073021964;5208.661437006583;5186.144286192793;5221.477852214786;5252.159654455307;5257.921131183035;5295.708736019517;5123.769430375604;5152.6650767699975;5165.66423182492;5180.430152683201;5193.714345710984;5516.806911758069;5522.834314970557;5542.0855558832745;5562.833115006516;5570.442955704438;6126.522546379484;6136.815895523141;6139.807300203914;6140.293866205354;6171;6202.534809889276;6268.059791031336;6296.307406185316;6300.243970723497;6319.273283572402;5603.719814009283;5649.265595472644;5661.179129026268;5702.771889124471;5727.083666613322;5259;6293.402126797947;6307.558470906993;6313.747450102036;6340.746370145235;6053.667048312297;6066.817995460055;6081.331053584102;6091.8477038073515;6093.786717464867;6050.909236361458;6058.727357268934;6097.512199024068;6119.44924956756;6204.968975155186;6039.365866583946;6041.24484439445;6045.274567051982;6045.8488537786025;6081.513478921675;6118.556367312614;6130.938690613037;6141.700809433414;6158.04550294705;6162.322144564095;4870.09903167915;4889.144399730033;4894.241392584155;4909.926351104737;4923.040007198562;4315.4605674290715;4381.18947994622;4382.320740285261;4390.47314322277;4415.757133357696;5637;5665.745041473144;5710.571707121982;5736.971315143398;5741.45456181662;6265.154204182468;6267.561270711007;6281.528885333527;6288.717007734663;6294.779682711175;5687.687177205294;5749.223854779635;5760.07838745807;5765.019946609003;5781.739821708034;4495.910081798345;5259.684418934876;5306.044911915815;5327.786888524493;5356.009138309425;6266.561340706106;6280.026595877555;6296.024116261987;6301.684915754102;6312.368763123651;6236.376362363727;6240.656763878031;6250.937490625218;6275.246970363403;6285.214348206474;6205.317415084247;6248.4064013918605;6281.371862813682;6317.084022816574;6321.30465648769;6027.879442411215;6040.365761595145;6102.4507794298725;6119.015143218386;6143.665407145256;6200.968995154995;6215.627062376272;6217.191765070512;6237.12680224778;6255.311915689362;5867.5305975521005;5991.108812618779;6039.607425517327;6059.787907423395;6060.2424696912885;5900.940990590039;5930.05119180929;5975.9103613446705;5987.670678112746;6010.579259451796;5699.829005129853;5820.854478638068;5862.970685146547;5879;5879.73541190656;6027.517798576016;6028.005379112397;6039.78860739872;6056.394360563909;6073.089036644538;5696.658200507983;5751.48236658686;5751.5398768099285;5780.826575202751;5789.623674461315 08:43:29 INFO - PROCESS | 1646 | |1;ext.html;518.9922151167733;524.004391655854;530.2920600997668;530.355617924222;581.9931518473039;30728.38543229137;32491.837540812292;32493.350132997326;32499.837500812493;41071;43400.34899476502;43862.7806860966;43880;43885.78057109718;43906.12187756243;9850.852237216448;10051.547680354364;10053.145482633949;10067.848982265272;10070.74823129424;8900.154485323885;9104.817903641922;9862.45756483393;9977.451240181786;12128.45421956014;12034.277943323385;12430.378481075955;12437.378131093408;12440;12500.49998000079;12301.507939682402;12322.383880805924;12363.320017399084;12364.62906112818;12380.257184568954;8832.470051796912;9057.456552606865;11831.053515718722;12233.632991010283;12330.938345308306;39382.015449613704;41406.37890431646;41460.37809432861;41477.792611036755;41489.58510414887;3436.570428696413;3501.7023552998025;3557;3668.559772827251;3724.925501489955;29401.846412495717;30056.948006819875;30170.69829301701;31645.20886977821;31674.366512669847;3111.0977816433206;3158.731507821838;3211.5182722591567;3290.457074582691;3309.38776326378;494782.5260873709;499653;499814;500908;502191;59081;59563;59635.21094367176;59661;59733.402665973656;59883.10175347373;59962.40037599568;61868;62045;62084;16246.675066498603;16846.578835528966;16866.32534698623;16882.74675879863;16883.24025418859;12742.681432964064;12804.487820487077;13190.406431710597;13252.271125088213;13256.536021239403;11484.368359740294;13707.45170193201;14011.879049676001;15292;15616;7030.683619237147;7134.92865071353;7193.568385896759;7203.171635262012;7273.908913662993;859.4499520307008;885.7254251182154;991.9851202231972;1031.4636389077637;1055.767731099157;29197.854010730236;30253;30380.54429183564;30545.78474955985;30597.541036884464;969.7817990951979;1013.1945103642622;1022.6983040003217;1031.29356390871;1046.5970601318547;15239.314230859638;15494.5351639451;15525.45660901863;15893.443729469413;16356.182190890408;676524.6173769099;681980;682907.5854620695;684416;685401;55612;55692.72153639206;55733;55789.72105139448;55882.60293492614;1229.6126720083146;1251.361805479212;1342.5166939901824;1363.0254368126837;1388.5695434415363;27249.86375068112;28173;31533.8423307882;31594.36811263808;32187.034388968368;48036.7598162007;48713.75643121904;48755;48760;48828.755856220494;567385;572506;573449;573815;574164;25428.982840686906;25647.743522564535;25762.87118564395;26014.21957341283;39587;43668.34497482604;46637.533624663316;46760;46822;47489.52510474851;37874;38374.80812595919;39148.80425597854;40090.79954600208;40405;38302.233955321295;38310.42534361931;38511.03722406962;39994;40087.79956100201;36910.892673219845;37985.86042418732;38283.61716382801;39055.2188956225;40148.996275093356;31950.6804931957;33962.830185848914;34805.303893922486;34960.650393495736;35091.12272193113;20614.58770824605;25567.87216063908;25695.345726094594;25722.09972650948;26172.476550469266 08:43:29 INFO - PROCESS | 1646 | |2;jquery.html;321.9103335210313;333.6238018175028;357.13038750642204;367.9153794627236;380.43315459964646;15562.455314063996;15692.921535392321;20317.695234571456;20955.790442095575;21147.894260528676;17887.55281117973;18066.909665451687;20848.374548763524;21167.364979050653;21438.35684929451;5889.587728858982;6133;6189.535784816134;6192.0402337637515;6214.067889816541;4886.51134886512;5952.523798096142;5989.940100598982;6025.879482410371;6138.7237574309265;5968.492678122365;5978.8206353809455;5979.730912108944;5985.102234664813;6024.7288872000645;5590.64199022462;5949.881002379928;5962.4633782959745;5983.910241346383;6018.909716354258;5023.974880125613;5229.869253268661;5232.03207406631;5238.60710446718;5241.292425522543;20449.693254601192;26557.468850623074;26689.599656005175;26802;26897;2273.886305684709;2305.262316058862;2315.3401280635107;2332.9066837326486;2532.871972318339;13899.096558723651;15227.923860380737;15431.228438578139;15982.920085399615;16157.4344897928;1702.8126906040325;1734.9913250433667;1746.6244757377224;1771.4242871066954;1899.9715004274947;81569.18430815735;111389;112139;117905.41047294709;125193.74806251912;10785.460726963778;11041.83437248442;11121.833172502418;11159.386233757059;11249.156313276537;14031.719365612835;14054.648633784032;14056.648583785487;14058.226797526235;14060.71878562423;8674.349423793115;8776.517291548898;8792.208701216921;8830.249428798625;8928.687495937611;8828.8675669865;8859.202671759444;8862.512561809162;9021.32340074497;9030.683926062557;5756.438384918754;6669.866602667919;6683.966580167068;6688.264290927994;6701;1826.8081851405411;1840.8527317814542;1846.2153584726439;1847.3995951315876;1866.8599855010928;793.3098204562068;895.5387975192781;941;957.8075296256067;963.6819849449665;20961.161553537688;22237.666435003488;22249.777502225093;22446.438839029153;22485.32544023682;916.2624087609405;917.655879045358;923.4828496042238;926.6154545863526;952.3904700991371;9398.718038458857;11304.830427543593;11520.423978801195;11580.6525804226;11745.530178792753;535279;623936;624118;626142;649598;122670;127108.72891271154;127317.3634131842;131717;131854.34072829766;937.1237892570468;951.3911096897853;959.947202903833;968.7045451137329;972.6498460554195;19048.619027619647;19410.320638777575;19487;19608.313709020116;19633.60732785365;38405.23189536249;50268.4919452417;51659;51857.481425185266;52456;72404.63797680978;73519;74867;75584;75835.86246206422;7992.920070799218;8075.798105047421;8084.272415482635;8194.057683366489;8269.627866746132;11977;12469.812952805534;13139.60581182566;13210;13635.318234088058;9762.414255144715;11138.443077846237;11607.477663504993;11714.824277635671;11725.237859539102;10541.156707463539;10691.09125724322;10911.508982095665;11338.206325557132;11947.462364193805;10004;11499.712507187387;11706.004989575982;11870;11906.761864762482;7744.806379840549;8070.273675369245;8180.754577362689;8186.426950113435;8317.376196785144;11101.071769093018;11496.712582185512;11902.166848320881;11947;11949.402529873645 08:43:29 INFO - PROCESS | 1646 | |3;mootools.html;1318.4923804335328;1469.5885152157396;1470.6396932751475;1626.5526980080476;1784.3130394798006;7914.802129946755;8372.790680232989;8732.694355697551;9018.05310442404;9050.592723327449;8849.955750221256;8870.15733505316;8949.955250223757;8956.8656470153;8959.552022398886;2386.0217310902535;2386.3079706884982;2387.176424133671;2388.319328991238;2417.9395515112087;2368.336865677613;2404.5551572959057;2410.529946660402;2417.3593997590565;2418.5888398972215;2385.7494963028894;2394.2577800881695;2406.711194656644;2415.7463466336044;2419.334682962182;2105;2269.171752310411;2368.490774483486;2377.702787151606;2380.678608387863;1960.4412742368356;2338.485533182714;2366.337425520857;2376.346504711218;2376.560336337783;8699.652013919498;8765.605547750367;8874.600642971081;8878.200961913395;8887.15572020657;5272.156454967187;5489.752961116719;5497.945020549783;5499.230107784873;5500.339959204881;3576.7138628909624;3591.1560783215923;3645.9453108203397;3668.046307959923;3674.467202255658;1043.2942139601805;1053.7734387106732;1064.7497838008062;1067.0983019348637;1076.4671487613682;11822;11864.881351186465;11964.34196119213;11977.041836653047;11999.400029998465;4456.3538286948215;4502.16709908668;4694.460137084211;4700.647451441156;4701.989072349461;9217.354785164975;9228.907710922938;9235.122663347105;9238.214751746176;9238.353315268001;5273.578113750891;5283.128283833124;5286.947130528645;5288.9735551322;5316.813911513079;4405.867823965286;4432.401625780542;4543.840965566255;4774.832880849223;4951.282064100686;3759.4172903200047;3786.753860999026;3903.33643280643;3914.7651140931634;3919.6080391961145;1148.494662348564;1172.261475270574;1174.448009435564;1180.4215934192184;1190;737.848741008092;865.7922098696394;912.6988093928987;912.7216199059351;925.1165137293868;5598.916016259759;5690.2033715279895;5744.454276843693;5780.739866706008;5948.643081415129;437.2501160509741;448.9236829738952;465.7740995617123;466.92062349400686;467.4297357224181;3779.508663873679;3831.6551510363643;3877.6122387760997;3899.415087736862;4021.3163762160502;10392;10737.624183153552;10863.891361086446;10948.34309941406;10963.013328800445;11015.504302306415;11025.724356891142;11028.50371733274;11028.613998510014;11029.779404412027;8112.797180070545;8357.58212089393;8389.580520973926;8496.362772792065;8505.95747021261;5442.9930462864495;5581.302337207849;5633.788735421904;5733.054046082517;5747;9878.308518403643;9942.701718948443;10148.847767283645;10172.033656802592;10311;10141;10224.846627300447;10314.587416503256;10345.948270258601;10498.737531561772;6543.083968244545;6646.767363142267;7101.467389945671;7201.099862517185;7203.819904502429;8484.957575212331;8560.357973152162;8671.783205419662;8675.609597567998;8682.305415566865;7551.924480755122;7678.270564296383;7683.270089341504;7730.6907723692675;7854;7476.065491813523;7519;7559.962200188964;7577.318041376303;7661.885071723817;6927.411170050602;7071.292870712888;7087.82280442993;7097.183823860322;7106.076210092655;4814.422269327703;4908.656394052382;4917.680350777331;4939.703617782944;5002.099622067917;4803.866258606037;4874.366332376911;4878;5044.915343201229;5075.3402057732255 08:43:29 INFO - PROCESS | 1646 | |4;prototype.html;259.3244597822672;296.09690444145366;310.1641077296685;314.72147149772456;317.74739082429465;4576.885577860555;4685.406961633044;5248.265242865992;5413.4857188567075;5516.227728118061;5012.649114561982;5310.76101575429;5341.278927344817;5372.194170874361;5396.846012058484;3224.983875080633;4131.35963925592;4151.58484151584;4155.522114956789;4172.97762048297;3421;3445.3626079175306;3932.3315036443732;4110.486189226347;4161.875143745678;3744.2698673758628;4087.4890638670167;4104.261232978063;4109.547949725527;4121.9381709274385;4079.551249362568;4085.6527195188296;4105.2405305018665;4111.506619205685;4113.136241389312;2958.6893376195403;2974.98850390866;3372.0052584487635;3562.6259242779392;3570.982145089284;4351.5648435156545;5008.273800298973;5261.6842989420375;5310.522053015247;5347.786088556492;4672.275797251432;4685.88285292867;4702.741349225791;4713.622910167179;4717.693349932278;4738.896023104838;4972.5276098770555;5656.757431926056;5673.744681489343;5683.4424508970715;3429.777064490825;3757.5866654667966;3889.183271512986;3917.5298964124204;3921.509811273591;5683.886322273532;5932.2838343517005;5937.317208521075;5944.414179831787;5974.6713930733795;3380.5267262583257;3991.1419044905483;4002.4996875390575;4007.318755811519;4059.837606495766;3476.5132881396626;3694.981525092411;3751.1806773714725;3918.000909767991;4076.7553946763287;4640.79116439761;4641.257398816173;4649.302604609268;4657.69724967876;4668.3697700810635;5336.03951288764;5754.683492407958;5767.250257466502;5776.133579963039;5785.566082543742;1122.8939494597814;1134.9886501135047;1273.2106094221456;1312.6193403912948;1320.4454129265732;874.361715947362;894.7047474333455;910.526526206369;923.7505873414275;923.8706581078654;4994.850154495298;5333.413324534298;5356.8660783479945;5376.220448035013;5397;5500.3949565547755;5776.249087618583;5787.739551720183;5789.478946894799;5792.797252096157;4773.832915847928;4907.472651584437;5233.371995360505;5337.466253374631;5338.876757097064;2158.9892050539647;2331.065215870823;2565.551028569993;2572.4469239113682;2620.0960668569314;4462.620677242406;4648;4986.775595098229;5045.183733855809;5053.852112852023;4497.730136191839;4501.347304640809;4613.0245991335405;4688.929666055012;4996.5003499650475;4534.6372290216705;4585.257602111176;4683.555062269079;4900.803967841389;5031.509402845615;4159.04524873309;4405.08378855199;4468.977655111704;4667.786375542316;4883.902321953612;4432.977835110803;4766.856994290177;4769.737664428351;4812.989272252726;4813.109574728686;4353.151135528541;4775.257031183663;4916.311716359784;4995.350604421402;5032.773525191302;3038.7265146136956;3245.772795904264;3393.6267010629304;3396.414839966125;3404.778689385182;4470.915068602784;4807.423109226916;4821.396445919165;4834.5890599299455;5042.899142017212;4661.580457758818;5057;5097.61767867404;5743.741531631003;5753.309602847685;5071.1632580625255;5076.466970968143;5475.2334673145;5741.91387129185;5769.173105178516;5361.72126846081;5556.91664625039;5598.552115830642;5645.266115404971;5660.094534770995;5440;5685.948099601587;5711.685857277889;5721.914171287351;5760.971195143998;4479.440069991251;5415.862668839431;5508.256385388082;5602.719864006865;5612.803551875665 08:43:29 INFO - PROCESS | 1646 | |5;yui.html;694.756835107712;739.3752279323969;761.402299195132;779.3258831111089;801.6873419366448;14735.263236838155;15974.600634984132;15989.200539972984;16006.439774607905;16060.11669358185;14417.351219195136;14576.416943322281;14587.781183282259;14595.708085838276;14600.488982885601;673.5891106425076;694.4375056204491;697.5291678117276;821.9054808696986;832.5296207642677;834.7370578267856;856.0797143071193;856.1823458597056;856.3063918226256;857.1599832164483;913.7715571107224;913.7761248494128;916.5692124701413;916.7616419730884;920.8572671235969;711.3242419701304;735.5843948169268;871.5424402188838;902.2691619787927;913.0413066280412;674.9898751518731;675.1054852320646;675.152683382352;676.2797620534116;677.6171463123369;14882.702345953021;14930;14931.626709332246;14935.327910243956;14955.40178392863;13749.037567370287;13837.584872453843;13937.233452160128;13972.790408143886;13997.930010349985;12190.268583884996;12363.381830908418;12379.257244565355;12953.54662586805;13083.215007099605;4577.931331030038;4595.4025976622825;4614.284785858197;4654.604358629521;4741.525847415265;106210;106377;107424;109618;112267.43866280616;10902.945485272523;10965.177611679155;11075.944620277009;11202.327860328407;11215.495302711397;21910.12359505634;21913.233036843634;21939.341819745434;21955.231566895083;21980.340589782332;7728.381729461629;7826.1391246962785;8066.274035336848;8119.3910456715985;8127.431079824474;4180.268453020709;4345.196138714348;4412.4705035395955;4439.134368798118;4556.903824240886;3428.708559772447;3597.6762091411897;3599.85600575974;3603.9819800900827;3611.043073585502;617.5769597825504;665.3147258323934;671.2683175338807;674.2583158525681;678.5962352400314;586.1676419484343;590.5010266324948;597.5966222799593;628.4532456762554;641.8812519683873;8762.693305734269;8954.703485649945;9046.05016473274;9158.725238242863;9203.539823008956;488.96332775042015;517.3533083645443;592.754007087054;602.9125776762345;616.7810427298244;4225.3873188388125;4386.956130438719;4395.208862404734;4416.624586910084;4501.167284052395;92881.74913877982;102936;161848;164581;170879.43680844796;134497.32751336377;138705;138899;138923.30538347244;144286;91899.16201675929;115260.42369788098;119380.40309798569;119815.40092299657;124410.75589243992;8196.754097377088;8336.208060234268;8505.362097842562;8693.130686931256;8775.166359195866;66310.66844665745;66406.66796665985;66840.6657966707;67672;68699.10169169812;76414.61792691001;99462.51343716466;99495.00504994858;100701.79992213397;107106.46446767716;9995.60017599317;10576.41829699374;10687.198460115678;10863.945680271549;11377.658670239905;10164.390136591828;11713.941430292794;12231.510739570318;12270.386480675752;12720.109592328448;11144.33134011962;11265.436728163395;11408.94295528517;11733.823992640288;11920.225185362924;10931.945340273247;11340.94329528347;11416.714582135513;11714.121440892137;12163.209391389886;9723.46520941355;11288.661340159808;11481.598144065252;11563.132765042486;11975;9778.315517913677;11383.943080284545;11771.058315334923;11966.58116965902;12140.817887731868;11513.366764828015;11610.535578576762;11660.017796974365;11808.23169520484;11878.821817672915 08:43:29 INFO - PROCESS | 1646 | __end_tp_report 08:43:29 INFO - PROCESS | 1646 | __start_cc_report 08:43:29 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1307 08:43:29 INFO - PROCESS | 1646 | __end_cc_report 08:43:29 INFO - PROCESS | 1646 | __startTimestamp1476805409318__endTimestamp 08:43:29 INFO - PROCESS | 1646 | 08:43:29 INFO - PROCESS | 1646 | ------- Summary: start ------- 08:43:29 INFO - PROCESS | 1646 | Number of tests: 6 08:43:29 INFO - PROCESS | 1646 | 08:43:29 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5681.71 Median:5820.85 stddev:642.75 (11.0%) stddev-sans-first:613.10 08:43:29 INFO - PROCESS | 1646 | Values: 3143.2 3296.9 3320.0 3325.7 3361.1 5606.2 5630.1 5659.3 5665.0 5692.7 5561.4 5627.0 5631.2 5651.5 5667.9 5123.1 5125.9 5140.7 5163.5 5186.4 5124.7 5145.5 5146.5 5243.2 5290.6 5162.9 5193.2 5202.2 5208.4 5208.7 5186.1 5221.5 5252.2 5257.9 5295.7 5123.8 5152.7 5165.7 5180.4 5193.7 5516.8 5522.8 5542.1 5562.8 5570.4 6126.5 6136.8 6139.8 6140.3 6171.0 6202.5 6268.1 6296.3 6300.2 6319.3 5603.7 5649.3 5661.2 5702.8 5727.1 5259.0 6293.4 6307.6 6313.7 6340.7 6053.7 6066.8 6081.3 6091.8 6093.8 6050.9 6058.7 6097.5 6119.4 6205.0 6039.4 6041.2 6045.3 6045.8 6081.5 6118.6 6130.9 6141.7 6158.0 6162.3 4870.1 4889.1 4894.2 4909.9 4923.0 4315.5 4381.2 4382.3 4390.5 4415.8 5637.0 5665.7 5710.6 5737.0 5741.5 6265.2 6267.6 6281.5 6288.7 6294.8 5687.7 5749.2 5760.1 5765.0 5781.7 4495.9 5259.7 5306.0 5327.8 5356.0 6266.6 6280.0 6296.0 6301.7 6312.4 6236.4 6240.7 6250.9 6275.2 6285.2 6205.3 6248.4 6281.4 6317.1 6321.3 6027.9 6040.4 6102.5 6119.0 6143.7 6201.0 6215.6 6217.2 6237.1 6255.3 5867.5 5991.1 6039.6 6059.8 6060.2 5900.9 5930.1 5975.9 5987.7 6010.6 5699.8 5820.9 5863.0 5879.0 5879.7 6027.5 6028.0 6039.8 6056.4 6073.1 5696.7 5751.5 5751.5 5780.8 5789.6 08:43:29 INFO - PROCESS | 1646 | 08:43:29 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:71442.52 Median:20289.73 stddev:157661.80 (777.1%) stddev-sans-first:158014.16 08:43:29 INFO - PROCESS | 1646 | Values: 519.0 524.0 530.3 530.4 582.0 30728.4 32491.8 32493.4 32499.8 41071.0 43400.3 43862.8 43880.0 43885.8 43906.1 9850.9 10051.5 10053.1 10067.8 10070.7 8900.2 9104.8 9862.5 9977.5 12128.5 12034.3 12430.4 12437.4 12440.0 12500.5 12301.5 12322.4 12363.3 12364.6 12380.3 8832.5 9057.5 11831.1 12233.6 12330.9 39382.0 41406.4 41460.4 41477.8 41489.6 3436.6 3501.7 3557.0 3668.6 3724.9 29401.8 30056.9 30170.7 31645.2 31674.4 3111.1 3158.7 3211.5 3290.5 3309.4 494782.5 499653.0 499814.0 500908.0 502191.0 59081.0 59563.0 59635.2 59661.0 59733.4 59883.1 59962.4 61868.0 62045.0 62084.0 16246.7 16846.6 16866.3 16882.7 16883.2 12742.7 12804.5 13190.4 13252.3 13256.5 11484.4 13707.5 14011.9 15292.0 15616.0 7030.7 7134.9 7193.6 7203.2 7273.9 859.4 885.7 992.0 1031.5 1055.8 29197.9 30253.0 30380.5 30545.8 30597.5 969.8 1013.2 1022.7 1031.3 1046.6 15239.3 15494.5 15525.5 15893.4 16356.2 676524.6 681980.0 682907.6 684416.0 685401.0 55612.0 55692.7 55733.0 55789.7 55882.6 1229.6 1251.4 1342.5 1363.0 1388.6 27249.9 28173.0 31533.8 31594.4 32187.0 48036.8 48713.8 48755.0 48760.0 48828.8 567385.0 572506.0 573449.0 573815.0 574164.0 25429.0 25647.7 25762.9 26014.2 39587.0 43668.3 46637.5 46760.0 46822.0 47489.5 37874.0 38374.8 39148.8 40090.8 40405.0 38302.2 38310.4 38511.0 39994.0 40087.8 36910.9 37985.9 38283.6 39055.2 40149.0 31950.7 33962.8 34805.3 34960.7 35091.1 20614.6 25567.9 25695.3 25722.1 26172.5 08:43:29 INFO - PROCESS | 1646 | 08:43:29 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:35192.93 Median:26849.50 stddev:101947.34 (379.7%) stddev-sans-first:102199.71 08:43:29 INFO - PROCESS | 1646 | Values: 321.9 333.6 357.1 367.9 380.4 15562.5 15692.9 20317.7 20955.8 21147.9 17887.6 18066.9 20848.4 21167.4 21438.4 5889.6 6133.0 6189.5 6192.0 6214.1 4886.5 5952.5 5989.9 6025.9 6138.7 5968.5 5978.8 5979.7 5985.1 6024.7 5590.6 5949.9 5962.5 5983.9 6018.9 5024.0 5229.9 5232.0 5238.6 5241.3 20449.7 26557.5 26689.6 26802.0 26897.0 2273.9 2305.3 2315.3 2332.9 2532.9 13899.1 15227.9 15431.2 15982.9 16157.4 1702.8 1735.0 1746.6 1771.4 1900.0 81569.2 111389.0 112139.0 117905.4 125193.7 10785.5 11041.8 11121.8 11159.4 11249.2 14031.7 14054.6 14056.6 14058.2 14060.7 8674.3 8776.5 8792.2 8830.2 8928.7 8828.9 8859.2 8862.5 9021.3 9030.7 5756.4 6669.9 6684.0 6688.3 6701.0 1826.8 1840.9 1846.2 1847.4 1866.9 793.3 895.5 941.0 957.8 963.7 20961.2 22237.7 22249.8 22446.4 22485.3 916.3 917.7 923.5 926.6 952.4 9398.7 11304.8 11520.4 11580.7 11745.5 535279.0 623936.0 624118.0 626142.0 649598.0 122670.0 127108.7 127317.4 131717.0 131854.3 937.1 951.4 959.9 968.7 972.6 19048.6 19410.3 19487.0 19608.3 19633.6 38405.2 50268.5 51659.0 51857.5 52456.0 72404.6 73519.0 74867.0 75584.0 75835.9 7992.9 8075.8 8084.3 8194.1 8269.6 11977.0 12469.8 13139.6 13210.0 13635.3 9762.4 11138.4 11607.5 11714.8 11725.2 10541.2 10691.1 10911.5 11338.2 11947.5 10004.0 11499.7 11706.0 11870.0 11906.8 7744.8 8070.3 8180.8 8186.4 8317.4 11101.1 11496.7 11902.2 11947.0 11949.4 08:43:29 INFO - PROCESS | 1646 | 08:43:29 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5706.02 Median:4738.41 stddev:3268.24 (69.0%) stddev-sans-first:3260.78 08:43:29 INFO - PROCESS | 1646 | Values: 1318.5 1469.6 1470.6 1626.6 1784.3 7914.8 8372.8 8732.7 9018.1 9050.6 8850.0 8870.2 8950.0 8956.9 8959.6 2386.0 2386.3 2387.2 2388.3 2417.9 2368.3 2404.6 2410.5 2417.4 2418.6 2385.7 2394.3 2406.7 2415.7 2419.3 2105.0 2269.2 2368.5 2377.7 2380.7 1960.4 2338.5 2366.3 2376.3 2376.6 8699.7 8765.6 8874.6 8878.2 8887.2 5272.2 5489.8 5497.9 5499.2 5500.3 3576.7 3591.2 3645.9 3668.0 3674.5 1043.3 1053.8 1064.7 1067.1 1076.5 11822.0 11864.9 11964.3 11977.0 11999.4 4456.4 4502.2 4694.5 4700.6 4702.0 9217.4 9228.9 9235.1 9238.2 9238.4 5273.6 5283.1 5286.9 5289.0 5316.8 4405.9 4432.4 4543.8 4774.8 4951.3 3759.4 3786.8 3903.3 3914.8 3919.6 1148.5 1172.3 1174.4 1180.4 1190.0 737.8 865.8 912.7 912.7 925.1 5598.9 5690.2 5744.5 5780.7 5948.6 437.3 448.9 465.8 466.9 467.4 3779.5 3831.7 3877.6 3899.4 4021.3 10392.0 10737.6 10863.9 10948.3 10963.0 11015.5 11025.7 11028.5 11028.6 11029.8 8112.8 8357.6 8389.6 8496.4 8506.0 5443.0 5581.3 5633.8 5733.1 5747.0 9878.3 9942.7 10148.8 10172.0 10311.0 10141.0 10224.8 10314.6 10345.9 10498.7 6543.1 6646.8 7101.5 7201.1 7203.8 8485.0 8560.4 8671.8 8675.6 8682.3 7551.9 7678.3 7683.3 7730.7 7854.0 7476.1 7519.0 7560.0 7577.3 7661.9 6927.4 7071.3 7087.8 7097.2 7106.1 4814.4 4908.7 4917.7 4939.7 5002.1 4803.9 4874.4 4878.0 5044.9 5075.3 08:43:29 INFO - PROCESS | 1646 | 08:43:29 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4361.60 Median:4728.29 stddev:1348.41 (28.5%) stddev-sans-first:1316.56 08:43:29 INFO - PROCESS | 1646 | Values: 259.3 296.1 310.2 314.7 317.7 4576.9 4685.4 5248.3 5413.5 5516.2 5012.6 5310.8 5341.3 5372.2 5396.8 3225.0 4131.4 4151.6 4155.5 4173.0 3421.0 3445.4 3932.3 4110.5 4161.9 3744.3 4087.5 4104.3 4109.5 4121.9 4079.6 4085.7 4105.2 4111.5 4113.1 2958.7 2975.0 3372.0 3562.6 3571.0 4351.6 5008.3 5261.7 5310.5 5347.8 4672.3 4685.9 4702.7 4713.6 4717.7 4738.9 4972.5 5656.8 5673.7 5683.4 3429.8 3757.6 3889.2 3917.5 3921.5 5683.9 5932.3 5937.3 5944.4 5974.7 3380.5 3991.1 4002.5 4007.3 4059.8 3476.5 3695.0 3751.2 3918.0 4076.8 4640.8 4641.3 4649.3 4657.7 4668.4 5336.0 5754.7 5767.3 5776.1 5785.6 1122.9 1135.0 1273.2 1312.6 1320.4 874.4 894.7 910.5 923.8 923.9 4994.9 5333.4 5356.9 5376.2 5397.0 5500.4 5776.2 5787.7 5789.5 5792.8 4773.8 4907.5 5233.4 5337.5 5338.9 2159.0 2331.1 2565.6 2572.4 2620.1 4462.6 4648.0 4986.8 5045.2 5053.9 4497.7 4501.3 4613.0 4688.9 4996.5 4534.6 4585.3 4683.6 4900.8 5031.5 4159.0 4405.1 4469.0 4667.8 4883.9 4433.0 4766.9 4769.7 4813.0 4813.1 4353.2 4775.3 4916.3 4995.4 5032.8 3038.7 3245.8 3393.6 3396.4 3404.8 4470.9 4807.4 4821.4 4834.6 5042.9 4661.6 5057.0 5097.6 5743.7 5753.3 5071.2 5076.5 5475.2 5741.9 5769.2 5361.7 5556.9 5598.6 5645.3 5660.1 5440.0 5685.9 5711.7 5721.9 5761.0 4479.4 5415.9 5508.3 5602.7 5612.8 08:43:29 INFO - PROCESS | 1646 | 08:43:29 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:24936.12 Median:3607.51 stddev:40606.33 (1125.6%) stddev-sans-first:40679.45 08:43:29 INFO - PROCESS | 1646 | Values: 694.8 739.4 761.4 779.3 801.7 14735.3 15974.6 15989.2 16006.4 16060.1 14417.4 14576.4 14587.8 14595.7 14600.5 673.6 694.4 697.5 821.9 832.5 834.7 856.1 856.2 856.3 857.2 913.8 913.8 916.6 916.8 920.9 711.3 735.6 871.5 902.3 913.0 675.0 675.1 675.2 676.3 677.6 14882.7 14930.0 14931.6 14935.3 14955.4 13749.0 13837.6 13937.2 13972.8 13997.9 12190.3 12363.4 12379.3 12953.5 13083.2 4577.9 4595.4 4614.3 4654.6 4741.5 106210.0 106377.0 107424.0 109618.0 112267.4 10902.9 10965.2 11075.9 11202.3 11215.5 21910.1 21913.2 21939.3 21955.2 21980.3 7728.4 7826.1 8066.3 8119.4 8127.4 4180.3 4345.2 4412.5 4439.1 4556.9 3428.7 3597.7 3599.9 3604.0 3611.0 617.6 665.3 671.3 674.3 678.6 586.2 590.5 597.6 628.5 641.9 8762.7 8954.7 9046.1 9158.7 9203.5 489.0 517.4 592.8 602.9 616.8 4225.4 4387.0 4395.2 4416.6 4501.2 92881.7 102936.0 161848.0 164581.0 170879.4 134497.3 138705.0 138899.0 138923.3 144286.0 91899.2 115260.4 119380.4 119815.4 124410.8 8196.8 8336.2 8505.4 8693.1 8775.2 66310.7 66406.7 66840.7 67672.0 68699.1 76414.6 99462.5 99495.0 100701.8 107106.5 9995.6 10576.4 10687.2 10863.9 11377.7 10164.4 11713.9 12231.5 12270.4 12720.1 11144.3 11265.4 11408.9 11733.8 11920.2 10931.9 11340.9 11416.7 11714.1 12163.2 9723.5 11288.7 11481.6 11563.1 11975.0 9778.3 11383.9 11771.1 11966.6 12140.8 11513.4 11610.5 11660.0 11808.2 11878.8 08:43:29 INFO - PROCESS | 1646 | -------- Summary: end -------- 08:43:29 INFO - PROCESS | 1646 | 08:43:29 INFO - TEST-INFO | 1646: exit 0 08:43:29 INFO - TEST-OK | dromaeo_css | took 1116366ms 08:43:29 INFO - TEST-START | kraken 08:43:29 INFO - operating with platform_type : mac_ 08:43:29 INFO - Initialising browser for kraken test... 08:43:29 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpSKmYTE/profile http://localhost:49272/getInfo.html) 08:43:32 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 08:43:32 INFO - PROCESS | 1656 | colorDepth:24 08:43:32 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 08:43:32 INFO - PROCESS | 1656 | __metrics 08:43:32 INFO - PROCESS | 1656 | 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" 08:43:32 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:43:33 INFO - TEST-INFO | 1656: exit 0 08:43:33 INFO - Browser initialized. 08:43:33 INFO - Running cycle 1/1 for kraken test... 08:43:33 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpSKmYTE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:45 INFO - PROCESS | 1657 | RSS: Main: 219254784 08:43:45 INFO - PROCESS | 1657 | 08:43:48 INFO - PROCESS | 1657 | 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) 08:43:48 INFO - PROCESS | 1657 | RSS: Main: 269389824 08:43:48 INFO - PROCESS | 1657 | 08:43:51 INFO - PROCESS | 1657 | 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) 08:43:52 INFO - PROCESS | 1657 | RSS: Main: 280256512 08:43:52 INFO - PROCESS | 1657 | 08:43:55 INFO - PROCESS | 1657 | 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) 08:43:55 INFO - PROCESS | 1657 | RSS: Main: 378966016 08:43:55 INFO - PROCESS | 1657 | 08:43:57 INFO - PROCESS | 1657 | 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) 08:43:58 INFO - PROCESS | 1657 | RSS: Main: 280489984 08:43:58 INFO - PROCESS | 1657 | 08:44:00 INFO - PROCESS | 1657 | 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) 08:44:01 INFO - PROCESS | 1657 | RSS: Main: 280973312 08:44:01 INFO - PROCESS | 1657 | 08:44:03 INFO - PROCESS | 1657 | 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) 08:44:04 INFO - PROCESS | 1657 | RSS: Main: 316919808 08:44:04 INFO - PROCESS | 1657 | 08:44:07 INFO - PROCESS | 1657 | 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) 08:44:07 INFO - PROCESS | 1657 | RSS: Main: 319479808 08:44:07 INFO - PROCESS | 1657 | 08:44:10 INFO - PROCESS | 1657 | 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) 08:44:11 INFO - PROCESS | 1657 | RSS: Main: 319336448 08:44:11 INFO - PROCESS | 1657 | 08:44:12 INFO - PROCESS | 1657 | 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) 08:44:13 INFO - PROCESS | 1657 | RSS: Main: 295792640 08:44:13 INFO - PROCESS | 1657 | 08:44:15 INFO - PROCESS | 1657 | 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) 08:44:16 INFO - PROCESS | 1657 | RSS: Main: 296726528 08:44:16 INFO - PROCESS | 1657 | 08:44:18 INFO - PROCESS | 1657 | 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) 08:44:18 INFO - PROCESS | 1657 | RSS: Main: 307585024 08:44:18 INFO - PROCESS | 1657 | 08:44:21 INFO - PROCESS | 1657 | 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) 08:44:22 INFO - PROCESS | 1657 | RSS: Main: 312737792 08:44:22 INFO - PROCESS | 1657 | 08:44:25 INFO - PROCESS | 1657 | 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) 08:44:25 INFO - PROCESS | 1657 | RSS: Main: 312246272 08:44:25 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | 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) 08:44:27 INFO - PROCESS | 1657 | RSS: Main: 356089856 08:44:27 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | __start_tp_report 08:44:27 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 08:44:27 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 08:44:27 INFO - PROCESS | 1657 | |i|pagename|runs| 08:44:27 INFO - PROCESS | 1657 | |0;ai-astar;116;113;114;112;111;113;113;112;112;113 08:44:27 INFO - PROCESS | 1657 | |1;audio-beat-detection;139;109;108;141;113;132;141;109;143;113 08:44:27 INFO - PROCESS | 1657 | |2;audio-dft;180;185;182;184;180;181;181;182;185;183 08:44:27 INFO - PROCESS | 1657 | |3;audio-fft;83;74;83;88;62;59;58;58;83;58 08:44:27 INFO - PROCESS | 1657 | |4;audio-oscillator;86;69;92;69;68;67;91;66;68;89 08:44:27 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;87;86;87;84;87;84;88;84;87;85 08:44:27 INFO - PROCESS | 1657 | |6;imaging-darkroom;93;93;93;95;93;93;93;91;93;93 08:44:27 INFO - PROCESS | 1657 | |7;imaging-desaturate;102;145;133;83;82;85;84;86;85;86 08:44:27 INFO - PROCESS | 1657 | |8;json-parse-financial;57;56;55;56;59;58;58;57;58;58 08:44:27 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;71;65;69;79;74;70;69;69;70;72 08:44:27 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;86;85;85;81;83;81;81;89;89;82 08:44:27 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;137;139;137;136;133;134;126;137;169;138 08:44:27 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;164;164;162;161;163;163;161;161;163;163 08:44:27 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;66;64;66;63;66;66;66;67;66;66 08:44:27 INFO - PROCESS | 1657 | __end_tp_report 08:44:27 INFO - PROCESS | 1657 | __start_cc_report 08:44:27 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1977 08:44:27 INFO - PROCESS | 1657 | __end_cc_report 08:44:27 INFO - PROCESS | 1657 | __startTimestamp1476805467753__endTimestamp 08:44:27 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | ------- Summary: start ------- 08:44:27 INFO - PROCESS | 1657 | Number of tests: 14 08:44:27 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:1.37 (1.2%) stddev-sans-first:0.88 08:44:27 INFO - PROCESS | 1657 | Values: 116.0 113.0 114.0 112.0 111.0 113.0 113.0 112.0 112.0 113.0 08:44:27 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:135.50 stddev:15.53 (11.5%) stddev-sans-first:15.59 08:44:27 INFO - PROCESS | 1657 | Values: 139.0 109.0 108.0 141.0 113.0 132.0 141.0 109.0 143.0 113.0 08:44:27 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:182.30 Median:182.50 stddev:1.89 (1.0%) stddev-sans-first:1.81 08:44:27 INFO - PROCESS | 1657 | Values: 180.0 185.0 182.0 184.0 180.0 181.0 181.0 182.0 185.0 183.0 08:44:27 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:70.60 Median:78.50 stddev:12.74 (16.2%) stddev-sans-first:12.70 08:44:27 INFO - PROCESS | 1657 | Values: 83.0 74.0 83.0 88.0 62.0 59.0 58.0 58.0 83.0 58.0 08:44:27 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:77.50 stddev:11.33 (14.6%) stddev-sans-first:11.48 08:44:27 INFO - PROCESS | 1657 | Values: 86.0 69.0 92.0 69.0 68.0 67.0 91.0 66.0 68.0 89.0 08:44:27 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:87.00 stddev:1.52 (1.8%) stddev-sans-first:1.56 08:44:27 INFO - PROCESS | 1657 | Values: 87.0 86.0 87.0 84.0 87.0 84.0 88.0 84.0 87.0 85.0 08:44:27 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.94 (1.0%) stddev-sans-first:1.00 08:44:27 INFO - PROCESS | 1657 | Values: 93.0 93.0 93.0 95.0 93.0 93.0 93.0 91.0 93.0 93.0 08:44:27 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:84.50 stddev:22.96 (27.2%) stddev-sans-first:24.29 08:44:27 INFO - PROCESS | 1657 | Values: 102.0 145.0 133.0 83.0 82.0 85.0 84.0 86.0 85.0 86.0 08:44:27 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:58.00 stddev:1.23 (2.1%) stddev-sans-first:1.30 08:44:27 INFO - PROCESS | 1657 | Values: 57.0 56.0 55.0 56.0 59.0 58.0 58.0 57.0 58.0 58.0 08:44:27 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:70.50 stddev:3.71 (5.3%) stddev-sans-first:3.93 08:44:27 INFO - PROCESS | 1657 | Values: 71.0 65.0 69.0 79.0 74.0 70.0 69.0 69.0 70.0 72.0 08:44:27 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:85.00 stddev:3.12 (3.7%) stddev-sans-first:3.24 08:44:27 INFO - PROCESS | 1657 | Values: 86.0 85.0 85.0 81.0 83.0 81.0 81.0 89.0 89.0 82.0 08:44:27 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:137.00 stddev:11.31 (8.3%) stddev-sans-first:11.98 08:44:27 INFO - PROCESS | 1657 | Values: 137.0 139.0 137.0 136.0 133.0 134.0 126.0 137.0 169.0 138.0 08:44:27 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:163.00 stddev:1.18 (0.7%) stddev-sans-first:1.12 08:44:27 INFO - PROCESS | 1657 | Values: 164.0 164.0 162.0 161.0 163.0 163.0 161.0 161.0 163.0 163.0 08:44:27 INFO - PROCESS | 1657 | 08:44:27 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.17 (1.8%) stddev-sans-first:1.24 08:44:27 INFO - PROCESS | 1657 | Values: 66.0 64.0 66.0 63.0 66.0 66.0 66.0 67.0 66.0 66.0 08:44:27 INFO - PROCESS | 1657 | -------- Summary: end -------- 08:44:27 INFO - PROCESS | 1657 | 08:44:28 INFO - TEST-INFO | 1657: exit 0 08:44:28 INFO - TEST-OK | kraken | took 58671ms 08:44:28 INFO - SUITE-END | took 1175s 08:44:28 INFO - Completed test suite (00:19:35) 08:44:28 INFO - javascript benchmark 08:44:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3143.1827724791556, 3296.9010929672104, 3320.003998800359, 3325.700686938178, 3361.1093060339012, 5606.215129881814, 5630.127330263816, 5659.320881494226, 5664.971675141624, 5692.658440493563, 5561.416051314614, 5626.971865140668, 5631.239782629344, 5651.547876169907, 5667.886642267152, 5123.052235336456, 5125.871853203663, 5140.691558506502, 5163.509466600667, 5186.377634683843, 5124.6668966517245, 5145.485451454843, 5146.5110814472755, 5243.161094224924, 5290.629655924067, 5162.948370516285, 5193.246979188016, 5202.167653175493, 5208.427073021964, 5208.661437006583, 5186.144286192793, 5221.477852214786, 5252.159654455307, 5257.921131183035, 5295.708736019517, 5123.769430375604, 5152.6650767699975, 5165.66423182492, 5180.430152683201, 5193.714345710984, 5516.806911758069, 5522.834314970557, 5542.0855558832745, 5562.833115006516, 5570.442955704438, 6126.522546379484, 6136.815895523141, 6139.807300203914, 6140.293866205354, 6171.0, 6202.534809889276, 6268.059791031336, 6296.307406185316, 6300.243970723497, 6319.273283572402, 5603.719814009283, 5649.265595472644, 5661.179129026268, 5702.771889124471, 5727.083666613322, 5259.0, 6293.402126797947, 6307.558470906993, 6313.747450102036, 6340.746370145235, 6053.667048312297, 6066.817995460055, 6081.331053584102, 6091.8477038073515, 6093.786717464867, 6050.909236361458, 6058.727357268934, 6097.512199024068, 6119.44924956756, 6204.968975155186, 6039.365866583946, 6041.24484439445, 6045.274567051982, 6045.8488537786025, 6081.513478921675, 6118.556367312614, 6130.938690613037, 6141.700809433414, 6158.04550294705, 6162.322144564095, 4870.09903167915, 4889.144399730033, 4894.241392584155, 4909.926351104737, 4923.040007198562, 4315.4605674290715, 4381.18947994622, 4382.320740285261, 4390.47314322277, 4415.757133357696, 5637.0, 5665.745041473144, 5710.571707121982, 5736.971315143398, 5741.45456181662, 6265.154204182468, 6267.561270711007, 6281.528885333527, 6288.717007734663, 6294.779682711175, 5687.687177205294, 5749.223854779635, 5760.07838745807, 5765.019946609003, 5781.739821708034, 4495.910081798345, 5259.684418934876, 5306.044911915815, 5327.786888524493, 5356.009138309425, 6266.561340706106, 6280.026595877555, 6296.024116261987, 6301.684915754102, 6312.368763123651, 6236.376362363727, 6240.656763878031, 6250.937490625218, 6275.246970363403, 6285.214348206474, 6205.317415084247, 6248.4064013918605, 6281.371862813682, 6317.084022816574, 6321.30465648769, 6027.879442411215, 6040.365761595145, 6102.4507794298725, 6119.015143218386, 6143.665407145256, 6200.968995154995, 6215.627062376272, 6217.191765070512, 6237.12680224778, 6255.311915689362, 5867.5305975521005, 5991.108812618779, 6039.607425517327, 6059.787907423395, 6060.2424696912885, 5900.940990590039, 5930.05119180929, 5975.9103613446705, 5987.670678112746, 6010.579259451796, 5699.829005129853, 5820.854478638068, 5862.970685146547, 5879.0, 5879.73541190656, 6027.517798576016, 6028.005379112397, 6039.78860739872, 6056.394360563909, 6073.089036644538, 5696.658200507983, 5751.48236658686, 5751.5398768099285, 5780.826575202751, 5789.623674461315], "value": 5639.54931822675, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.9922151167733, 524.004391655854, 530.2920600997668, 530.355617924222, 581.9931518473039, 30728.38543229137, 32491.837540812292, 32493.350132997326, 32499.837500812493, 41071.0, 43400.34899476502, 43862.7806860966, 43880.0, 43885.78057109718, 43906.12187756243, 9850.852237216448, 10051.547680354364, 10053.145482633949, 10067.848982265272, 10070.74823129424, 8900.154485323885, 9104.817903641922, 9862.45756483393, 9977.451240181786, 12128.45421956014, 12034.277943323385, 12430.378481075955, 12437.378131093408, 12440.0, 12500.49998000079, 12301.507939682402, 12322.383880805924, 12363.320017399084, 12364.62906112818, 12380.257184568954, 8832.470051796912, 9057.456552606865, 11831.053515718722, 12233.632991010283, 12330.938345308306, 39382.015449613704, 41406.37890431646, 41460.37809432861, 41477.792611036755, 41489.58510414887, 3436.570428696413, 3501.7023552998025, 3557.0, 3668.559772827251, 3724.925501489955, 29401.846412495717, 30056.948006819875, 30170.69829301701, 31645.20886977821, 31674.366512669847, 3111.0977816433206, 3158.731507821838, 3211.5182722591567, 3290.457074582691, 3309.38776326378, 494782.5260873709, 499653.0, 499814.0, 500908.0, 502191.0, 59081.0, 59563.0, 59635.21094367176, 59661.0, 59733.402665973656, 59883.10175347373, 59962.40037599568, 61868.0, 62045.0, 62084.0, 16246.675066498603, 16846.578835528966, 16866.32534698623, 16882.74675879863, 16883.24025418859, 12742.681432964064, 12804.487820487077, 13190.406431710597, 13252.271125088213, 13256.536021239403, 11484.368359740294, 13707.45170193201, 14011.879049676001, 15292.0, 15616.0, 7030.683619237147, 7134.92865071353, 7193.568385896759, 7203.171635262012, 7273.908913662993, 859.4499520307008, 885.7254251182154, 991.9851202231972, 1031.4636389077637, 1055.767731099157, 29197.854010730236, 30253.0, 30380.54429183564, 30545.78474955985, 30597.541036884464, 969.7817990951979, 1013.1945103642622, 1022.6983040003217, 1031.29356390871, 1046.5970601318547, 15239.314230859638, 15494.5351639451, 15525.45660901863, 15893.443729469413, 16356.182190890408, 676524.6173769099, 681980.0, 682907.5854620695, 684416.0, 685401.0, 55612.0, 55692.72153639206, 55733.0, 55789.72105139448, 55882.60293492614, 1229.6126720083146, 1251.361805479212, 1342.5166939901824, 1363.0254368126837, 1388.5695434415363, 27249.86375068112, 28173.0, 31533.8423307882, 31594.36811263808, 32187.034388968368, 48036.7598162007, 48713.75643121904, 48755.0, 48760.0, 48828.755856220494, 567385.0, 572506.0, 573449.0, 573815.0, 574164.0, 25428.982840686906, 25647.743522564535, 25762.87118564395, 26014.21957341283, 39587.0, 43668.34497482604, 46637.533624663316, 46760.0, 46822.0, 47489.52510474851, 37874.0, 38374.80812595919, 39148.80425597854, 40090.79954600208, 40405.0, 38302.233955321295, 38310.42534361931, 38511.03722406962, 39994.0, 40087.79956100201, 36910.892673219845, 37985.86042418732, 38283.61716382801, 39055.2188956225, 40148.996275093356, 31950.6804931957, 33962.830185848914, 34805.303893922486, 34960.650393495736, 35091.12272193113, 20614.58770824605, 25567.87216063908, 25695.345726094594, 25722.09972650948, 26172.476550469266], "value": 20198.744551795942, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.9103335210313, 333.6238018175028, 357.13038750642204, 367.9153794627236, 380.43315459964646, 15562.455314063996, 15692.921535392321, 20317.695234571456, 20955.790442095575, 21147.894260528676, 17887.55281117973, 18066.909665451687, 20848.374548763524, 21167.364979050653, 21438.35684929451, 5889.587728858982, 6133.0, 6189.535784816134, 6192.0402337637515, 6214.067889816541, 4886.51134886512, 5952.523798096142, 5989.940100598982, 6025.879482410371, 6138.7237574309265, 5968.492678122365, 5978.8206353809455, 5979.730912108944, 5985.102234664813, 6024.7288872000645, 5590.64199022462, 5949.881002379928, 5962.4633782959745, 5983.910241346383, 6018.909716354258, 5023.974880125613, 5229.869253268661, 5232.03207406631, 5238.60710446718, 5241.292425522543, 20449.693254601192, 26557.468850623074, 26689.599656005175, 26802.0, 26897.0, 2273.886305684709, 2305.262316058862, 2315.3401280635107, 2332.9066837326486, 2532.871972318339, 13899.096558723651, 15227.923860380737, 15431.228438578139, 15982.920085399615, 16157.4344897928, 1702.8126906040325, 1734.9913250433667, 1746.6244757377224, 1771.4242871066954, 1899.9715004274947, 81569.18430815735, 111389.0, 112139.0, 117905.41047294709, 125193.74806251912, 10785.460726963778, 11041.83437248442, 11121.833172502418, 11159.386233757059, 11249.156313276537, 14031.719365612835, 14054.648633784032, 14056.648583785487, 14058.226797526235, 14060.71878562423, 8674.349423793115, 8776.517291548898, 8792.208701216921, 8830.249428798625, 8928.687495937611, 8828.8675669865, 8859.202671759444, 8862.512561809162, 9021.32340074497, 9030.683926062557, 5756.438384918754, 6669.866602667919, 6683.966580167068, 6688.264290927994, 6701.0, 1826.8081851405411, 1840.8527317814542, 1846.2153584726439, 1847.3995951315876, 1866.8599855010928, 793.3098204562068, 895.5387975192781, 941.0, 957.8075296256067, 963.6819849449665, 20961.161553537688, 22237.666435003488, 22249.777502225093, 22446.438839029153, 22485.32544023682, 916.2624087609405, 917.655879045358, 923.4828496042238, 926.6154545863526, 952.3904700991371, 9398.718038458857, 11304.830427543593, 11520.423978801195, 11580.6525804226, 11745.530178792753, 535279.0, 623936.0, 624118.0, 626142.0, 649598.0, 122670.0, 127108.72891271154, 127317.3634131842, 131717.0, 131854.34072829766, 937.1237892570468, 951.3911096897853, 959.947202903833, 968.7045451137329, 972.6498460554195, 19048.619027619647, 19410.320638777575, 19487.0, 19608.313709020116, 19633.60732785365, 38405.23189536249, 50268.4919452417, 51659.0, 51857.481425185266, 52456.0, 72404.63797680978, 73519.0, 74867.0, 75584.0, 75835.86246206422, 7992.920070799218, 8075.798105047421, 8084.272415482635, 8194.057683366489, 8269.627866746132, 11977.0, 12469.812952805534, 13139.60581182566, 13210.0, 13635.318234088058, 9762.414255144715, 11138.443077846237, 11607.477663504993, 11714.824277635671, 11725.237859539102, 10541.156707463539, 10691.09125724322, 10911.508982095665, 11338.206325557132, 11947.462364193805, 10004.0, 11499.712507187387, 11706.004989575982, 11870.0, 11906.761864762482, 7744.806379840549, 8070.273675369245, 8180.754577362689, 8186.426950113435, 8317.376196785144, 11101.071769093018, 11496.712582185512, 11902.166848320881, 11947.0, 11949.402529873645], "value": 9710.094334926496, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.4923804335328, 1469.5885152157396, 1470.6396932751475, 1626.5526980080476, 1784.3130394798006, 7914.802129946755, 8372.790680232989, 8732.694355697551, 9018.05310442404, 9050.592723327449, 8849.955750221256, 8870.15733505316, 8949.955250223757, 8956.8656470153, 8959.552022398886, 2386.0217310902535, 2386.3079706884982, 2387.176424133671, 2388.319328991238, 2417.9395515112087, 2368.336865677613, 2404.5551572959057, 2410.529946660402, 2417.3593997590565, 2418.5888398972215, 2385.7494963028894, 2394.2577800881695, 2406.711194656644, 2415.7463466336044, 2419.334682962182, 2105.0, 2269.171752310411, 2368.490774483486, 2377.702787151606, 2380.678608387863, 1960.4412742368356, 2338.485533182714, 2366.337425520857, 2376.346504711218, 2376.560336337783, 8699.652013919498, 8765.605547750367, 8874.600642971081, 8878.200961913395, 8887.15572020657, 5272.156454967187, 5489.752961116719, 5497.945020549783, 5499.230107784873, 5500.339959204881, 3576.7138628909624, 3591.1560783215923, 3645.9453108203397, 3668.046307959923, 3674.467202255658, 1043.2942139601805, 1053.7734387106732, 1064.7497838008062, 1067.0983019348637, 1076.4671487613682, 11822.0, 11864.881351186465, 11964.34196119213, 11977.041836653047, 11999.400029998465, 4456.3538286948215, 4502.16709908668, 4694.460137084211, 4700.647451441156, 4701.989072349461, 9217.354785164975, 9228.907710922938, 9235.122663347105, 9238.214751746176, 9238.353315268001, 5273.578113750891, 5283.128283833124, 5286.947130528645, 5288.9735551322, 5316.813911513079, 4405.867823965286, 4432.401625780542, 4543.840965566255, 4774.832880849223, 4951.282064100686, 3759.4172903200047, 3786.753860999026, 3903.33643280643, 3914.7651140931634, 3919.6080391961145, 1148.494662348564, 1172.261475270574, 1174.448009435564, 1180.4215934192184, 1190.0, 737.848741008092, 865.7922098696394, 912.6988093928987, 912.7216199059351, 925.1165137293868, 5598.916016259759, 5690.2033715279895, 5744.454276843693, 5780.739866706008, 5948.643081415129, 437.2501160509741, 448.9236829738952, 465.7740995617123, 466.92062349400686, 467.4297357224181, 3779.508663873679, 3831.6551510363643, 3877.6122387760997, 3899.415087736862, 4021.3163762160502, 10392.0, 10737.624183153552, 10863.891361086446, 10948.34309941406, 10963.013328800445, 11015.504302306415, 11025.724356891142, 11028.50371733274, 11028.613998510014, 11029.779404412027, 8112.797180070545, 8357.58212089393, 8389.580520973926, 8496.362772792065, 8505.95747021261, 5442.9930462864495, 5581.302337207849, 5633.788735421904, 5733.054046082517, 5747.0, 9878.308518403643, 9942.701718948443, 10148.847767283645, 10172.033656802592, 10311.0, 10141.0, 10224.846627300447, 10314.587416503256, 10345.948270258601, 10498.737531561772, 6543.083968244545, 6646.767363142267, 7101.467389945671, 7201.099862517185, 7203.819904502429, 8484.957575212331, 8560.357973152162, 8671.783205419662, 8675.609597567998, 8682.305415566865, 7551.924480755122, 7678.270564296383, 7683.270089341504, 7730.6907723692675, 7854.0, 7476.065491813523, 7519.0, 7559.962200188964, 7577.318041376303, 7661.885071723817, 6927.411170050602, 7071.292870712888, 7087.82280442993, 7097.183823860322, 7106.076210092655, 4814.422269327703, 4908.656394052382, 4917.680350777331, 4939.703617782944, 5002.099622067917, 4803.866258606037, 4874.366332376911, 4878.0, 5044.915343201229, 5075.3402057732255], "value": 4478.5665403224075, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [259.3244597822672, 296.09690444145366, 310.1641077296685, 314.72147149772456, 317.74739082429465, 4576.885577860555, 4685.406961633044, 5248.265242865992, 5413.4857188567075, 5516.227728118061, 5012.649114561982, 5310.76101575429, 5341.278927344817, 5372.194170874361, 5396.846012058484, 3224.983875080633, 4131.35963925592, 4151.58484151584, 4155.522114956789, 4172.97762048297, 3421.0, 3445.3626079175306, 3932.3315036443732, 4110.486189226347, 4161.875143745678, 3744.2698673758628, 4087.4890638670167, 4104.261232978063, 4109.547949725527, 4121.9381709274385, 4079.551249362568, 4085.6527195188296, 4105.2405305018665, 4111.506619205685, 4113.136241389312, 2958.6893376195403, 2974.98850390866, 3372.0052584487635, 3562.6259242779392, 3570.982145089284, 4351.5648435156545, 5008.273800298973, 5261.6842989420375, 5310.522053015247, 5347.786088556492, 4672.275797251432, 4685.88285292867, 4702.741349225791, 4713.622910167179, 4717.693349932278, 4738.896023104838, 4972.5276098770555, 5656.757431926056, 5673.744681489343, 5683.4424508970715, 3429.777064490825, 3757.5866654667966, 3889.183271512986, 3917.5298964124204, 3921.509811273591, 5683.886322273532, 5932.2838343517005, 5937.317208521075, 5944.414179831787, 5974.6713930733795, 3380.5267262583257, 3991.1419044905483, 4002.4996875390575, 4007.318755811519, 4059.837606495766, 3476.5132881396626, 3694.981525092411, 3751.1806773714725, 3918.000909767991, 4076.7553946763287, 4640.79116439761, 4641.257398816173, 4649.302604609268, 4657.69724967876, 4668.3697700810635, 5336.03951288764, 5754.683492407958, 5767.250257466502, 5776.133579963039, 5785.566082543742, 1122.8939494597814, 1134.9886501135047, 1273.2106094221456, 1312.6193403912948, 1320.4454129265732, 874.361715947362, 894.7047474333455, 910.526526206369, 923.7505873414275, 923.8706581078654, 4994.850154495298, 5333.413324534298, 5356.8660783479945, 5376.220448035013, 5397.0, 5500.3949565547755, 5776.249087618583, 5787.739551720183, 5789.478946894799, 5792.797252096157, 4773.832915847928, 4907.472651584437, 5233.371995360505, 5337.466253374631, 5338.876757097064, 2158.9892050539647, 2331.065215870823, 2565.551028569993, 2572.4469239113682, 2620.0960668569314, 4462.620677242406, 4648.0, 4986.775595098229, 5045.183733855809, 5053.852112852023, 4497.730136191839, 4501.347304640809, 4613.0245991335405, 4688.929666055012, 4996.5003499650475, 4534.6372290216705, 4585.257602111176, 4683.555062269079, 4900.803967841389, 5031.509402845615, 4159.04524873309, 4405.08378855199, 4468.977655111704, 4667.786375542316, 4883.902321953612, 4432.977835110803, 4766.856994290177, 4769.737664428351, 4812.989272252726, 4813.109574728686, 4353.151135528541, 4775.257031183663, 4916.311716359784, 4995.350604421402, 5032.773525191302, 3038.7265146136956, 3245.772795904264, 3393.6267010629304, 3396.414839966125, 3404.778689385182, 4470.915068602784, 4807.423109226916, 4821.396445919165, 4834.5890599299455, 5042.899142017212, 4661.580457758818, 5057.0, 5097.61767867404, 5743.741531631003, 5753.309602847685, 5071.1632580625255, 5076.466970968143, 5475.2334673145, 5741.91387129185, 5769.173105178516, 5361.72126846081, 5556.91664625039, 5598.552115830642, 5645.266115404971, 5660.094534770995, 5440.0, 5685.948099601587, 5711.685857277889, 5721.914171287351, 5760.971195143998, 4479.440069991251, 5415.862668839431, 5508.256385388082, 5602.719864006865, 5612.803551875665], "value": 3933.6573828104897, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.756835107712, 739.3752279323969, 761.402299195132, 779.3258831111089, 801.6873419366448, 14735.263236838155, 15974.600634984132, 15989.200539972984, 16006.439774607905, 16060.11669358185, 14417.351219195136, 14576.416943322281, 14587.781183282259, 14595.708085838276, 14600.488982885601, 673.5891106425076, 694.4375056204491, 697.5291678117276, 821.9054808696986, 832.5296207642677, 834.7370578267856, 856.0797143071193, 856.1823458597056, 856.3063918226256, 857.1599832164483, 913.7715571107224, 913.7761248494128, 916.5692124701413, 916.7616419730884, 920.8572671235969, 711.3242419701304, 735.5843948169268, 871.5424402188838, 902.2691619787927, 913.0413066280412, 674.9898751518731, 675.1054852320646, 675.152683382352, 676.2797620534116, 677.6171463123369, 14882.702345953021, 14930.0, 14931.626709332246, 14935.327910243956, 14955.40178392863, 13749.037567370287, 13837.584872453843, 13937.233452160128, 13972.790408143886, 13997.930010349985, 12190.268583884996, 12363.381830908418, 12379.257244565355, 12953.54662586805, 13083.215007099605, 4577.931331030038, 4595.4025976622825, 4614.284785858197, 4654.604358629521, 4741.525847415265, 106210.0, 106377.0, 107424.0, 109618.0, 112267.43866280616, 10902.945485272523, 10965.177611679155, 11075.944620277009, 11202.327860328407, 11215.495302711397, 21910.12359505634, 21913.233036843634, 21939.341819745434, 21955.231566895083, 21980.340589782332, 7728.381729461629, 7826.1391246962785, 8066.274035336848, 8119.3910456715985, 8127.431079824474, 4180.268453020709, 4345.196138714348, 4412.4705035395955, 4439.134368798118, 4556.903824240886, 3428.708559772447, 3597.6762091411897, 3599.85600575974, 3603.9819800900827, 3611.043073585502, 617.5769597825504, 665.3147258323934, 671.2683175338807, 674.2583158525681, 678.5962352400314, 586.1676419484343, 590.5010266324948, 597.5966222799593, 628.4532456762554, 641.8812519683873, 8762.693305734269, 8954.703485649945, 9046.05016473274, 9158.725238242863, 9203.539823008956, 488.96332775042015, 517.3533083645443, 592.754007087054, 602.9125776762345, 616.7810427298244, 4225.3873188388125, 4386.956130438719, 4395.208862404734, 4416.624586910084, 4501.167284052395, 92881.74913877982, 102936.0, 161848.0, 164581.0, 170879.43680844796, 134497.32751336377, 138705.0, 138899.0, 138923.30538347244, 144286.0, 91899.16201675929, 115260.42369788098, 119380.40309798569, 119815.40092299657, 124410.75589243992, 8196.754097377088, 8336.208060234268, 8505.362097842562, 8693.130686931256, 8775.166359195866, 66310.66844665745, 66406.66796665985, 66840.6657966707, 67672.0, 68699.10169169812, 76414.61792691001, 99462.51343716466, 99495.00504994858, 100701.79992213397, 107106.46446767716, 9995.60017599317, 10576.41829699374, 10687.198460115678, 10863.945680271549, 11377.658670239905, 10164.390136591828, 11713.941430292794, 12231.510739570318, 12270.386480675752, 12720.109592328448, 11144.33134011962, 11265.436728163395, 11408.94295528517, 11733.823992640288, 11920.225185362924, 10931.945340273247, 11340.94329528347, 11416.714582135513, 11714.121440892137, 12163.209391389886, 9723.46520941355, 11288.661340159808, 11481.598144065252, 11563.132765042486, 11975.0, 9778.315517913677, 11383.943080284545, 11771.058315334923, 11966.58116965902, 12140.817887731868, 11513.366764828015, 11610.535578576762, 11660.017796974365, 11808.23169520484, 11878.821817672915], "value": 7639.659982921745, "unit": "score"}], "name": "dromaeo_css", "value": 7280.176180759649, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 114.0, 112.0, 111.0, 113.0, 113.0, 112.0, 112.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 109.0, 108.0, 141.0, 113.0, 132.0, 141.0, 109.0, 143.0, 113.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 185.0, 182.0, 184.0, 180.0, 181.0, 181.0, 182.0, 185.0, 183.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 74.0, 83.0, 88.0, 62.0, 59.0, 58.0, 58.0, 83.0, 58.0], "value": 70.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 92.0, 69.0, 68.0, 67.0, 91.0, 66.0, 68.0, 89.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 84.0, 87.0, 84.0, 88.0, 84.0, 87.0, 85.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 95.0, 93.0, 93.0, 93.0, 91.0, 93.0, 93.0], "value": 93.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 145.0, 133.0, 83.0, 82.0, 85.0, 84.0, 86.0, 85.0, 86.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 56.0, 59.0, 58.0, 58.0, 57.0, 58.0, 58.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 65.0, 69.0, 79.0, 74.0, 70.0, 69.0, 69.0, 70.0, 72.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 81.0, 83.0, 81.0, 81.0, 89.0, 89.0, 82.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 139.0, 137.0, 136.0, 133.0, 134.0, 126.0, 137.0, 169.0, 138.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 161.0, 163.0, 163.0, 161.0, 161.0, 163.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 66.0, 63.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1421.9999999999998, "alertThreshold": 2.0}]} 08:44:28 INFO - Return code: 0 08:44:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:44:29 INFO - # TBPL SUCCESS # 08:44:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:44:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:44:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:44:29 INFO - 2016-10-18 08:44:29.060 screenresolution[1661:9863] starting screenresolution argv=screenresolution get 08:44:29 INFO - 2016-10-18 08:44:29.063 screenresolution[1661:9863] Display 0: 1600x1200x32@60 08:44:29 INFO - 2016-10-18 08:44:29.069 screenresolution[1662:9866] starting screenresolution argv=screenresolution list 08:44:29 INFO - Available Modes on Display 0 08:44:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:44:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:44:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:44:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:44:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:44:29 INFO - Intel Iris: 08:44:29 INFO - Chipset Model: Intel Iris 08:44:29 INFO - Type: GPU 08:44:29 INFO - Bus: Built-In 08:44:29 INFO - VRAM (Dynamic, Max): 1536 MB 08:44:29 INFO - Vendor: Intel (0x8086) 08:44:29 INFO - Device ID: 0x0a2e 08:44:29 INFO - Revision ID: 0x0009 08:44:29 INFO - Displays: 08:44:29 INFO - Display: 08:44:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:44:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:44:29 INFO - Display Serial Number: 1600x1200 60 08:44:29 INFO - Main Display: Yes 08:44:29 INFO - Mirror: Off 08:44:29 INFO - Online: Yes 08:44:29 INFO - Rotation: Supported 08:44:29 INFO - Return code: 0 08:44:29 INFO - Running post-action listener: _resource_record_post_action 08:44:29 INFO - [mozharness: 2016-10-18 15:44:29.304767Z] Finished run-tests step (success) 08:44:29 INFO - Running post-run listener: _resource_record_post_run 08:44:29 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 38368256; Write bytes: 661879296; Read time: 390; Write time: 2662 08:44:29 INFO - TinderboxPrint: CPU usage
53.4% 08:44:29 INFO - TinderboxPrint: I/O read bytes / time
38,368,256 / 390 08:44:29 INFO - TinderboxPrint: I/O write bytes / time
661,879,296 / 2,662 08:44:29 INFO - TinderboxPrint: CPU idle
2,254.7 (46.6%) 08:44:29 INFO - TinderboxPrint: CPU system
963.1 (19.9%) 08:44:29 INFO - TinderboxPrint: CPU user
1,615.9 (33.4%) 08:44:29 INFO - TinderboxPrint: Swap in / out
401,809,408 / 0 08:44:29 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 351924736; Write bytes: 346990592; Read time: 26989; Write time: 721 08:44:29 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 37409792; Write bytes: 294806016; Read time: 369; Write time: 1883 08:44:29 INFO - Running post-run listener: _upload_blobber_files 08:44:29 INFO - Blob upload gear active. 08:44:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:44:29 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 08:44:29 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'] 08:44:29 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 08:44:30 INFO - (blobuploader) - INFO - Open directory for files ... 08:44:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:44:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:44:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:31 INFO - (blobuploader) - INFO - Done attempting. 08:44:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:44:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:44:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:32 INFO - (blobuploader) - INFO - Done attempting. 08:44:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:44:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:44:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:44:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:44:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:44:34 INFO - (blobuploader) - INFO - Done attempting. 08:44:34 INFO - (blobuploader) - INFO - Iteration through files over. 08:44:34 INFO - Return code: 0 08:44:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:44:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:44:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92124438572c3b4600280e412c433b20223c5dfdaa292bdb1000e253170e54c416e24cec521cfbcd1c2fbf8f1f0f4c8760f506d94f6a464c20795a36dc4b78aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/832e2028cb972fc8e6e1a716b050f1f7db7dcd7ac4acb0cce520318dabb0a2e052d3310ed4af08d6c040e7d2af0743a37069b242e0081dfe67246cb5ff1ec388", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afa4da10683ffe69f7e48ce73f31e88431311b6eab5c2317f93dbfe82f0054fd484c09ecc6ce8a2df0d06075e4fcf9ad2a95b34a531d523dde028fcbbd1c06ca"} 08:44:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:44:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:44:34 INFO - Contents: 08:44:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92124438572c3b4600280e412c433b20223c5dfdaa292bdb1000e253170e54c416e24cec521cfbcd1c2fbf8f1f0f4c8760f506d94f6a464c20795a36dc4b78aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/832e2028cb972fc8e6e1a716b050f1f7db7dcd7ac4acb0cce520318dabb0a2e052d3310ed4af08d6c040e7d2af0743a37069b242e0081dfe67246cb5ff1ec388", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afa4da10683ffe69f7e48ce73f31e88431311b6eab5c2317f93dbfe82f0054fd484c09ecc6ce8a2df0d06075e4fcf9ad2a95b34a531d523dde028fcbbd1c06ca"} 08:44:34 INFO - Running post-run listener: copy_logs_to_upload_dir 08:44:34 INFO - Copying logs to upload dir... 08:44:34 INFO - mkdir: /builds/slave/test/build/upload/logs 08:44:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.815919 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-18 08:44:34.637416) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 08:44:34.641102) ========= 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.eLM1isedbD/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.RA9xiXD2Vh/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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/92124438572c3b4600280e412c433b20223c5dfdaa292bdb1000e253170e54c416e24cec521cfbcd1c2fbf8f1f0f4c8760f506d94f6a464c20795a36dc4b78aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/832e2028cb972fc8e6e1a716b050f1f7db7dcd7ac4acb0cce520318dabb0a2e052d3310ed4af08d6c040e7d2af0743a37069b242e0081dfe67246cb5ff1ec388", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afa4da10683ffe69f7e48ce73f31e88431311b6eab5c2317f93dbfe82f0054fd484c09ecc6ce8a2df0d06075e4fcf9ad2a95b34a531d523dde028fcbbd1c06ca"} build_url:https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011072 build_url: 'https://queue.taskcluster.net/v1/task/ILCejBwNQuexILGMQDgRoQ/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/92124438572c3b4600280e412c433b20223c5dfdaa292bdb1000e253170e54c416e24cec521cfbcd1c2fbf8f1f0f4c8760f506d94f6a464c20795a36dc4b78aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/832e2028cb972fc8e6e1a716b050f1f7db7dcd7ac4acb0cce520318dabb0a2e052d3310ed4af08d6c040e7d2af0743a37069b242e0081dfe67246cb5ff1ec388", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afa4da10683ffe69f7e48ce73f31e88431311b6eab5c2317f93dbfe82f0054fd484c09ecc6ce8a2df0d06075e4fcf9ad2a95b34a531d523dde028fcbbd1c06ca"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 08:44:34.679409) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 08:44:34.679890) ========= 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.eLM1isedbD/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.RA9xiXD2Vh/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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.005150 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 08:44:34.731057) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 08:44:34.731473) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 08:44:34.731909) ========= ========= Total master_lag: 0.20 =========