builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0243 starttime: 1480215539.48 results: success (0) buildid: 20161126175419 builduid: f8c4519588ea4af088cbcf9731dbb1f9 revision: 3d81e7906de637040bb850628487fd8aa921569c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 18:58:59.478421) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 18:58:59.478856) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 18:58:59.479144) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 18:58:59.516298) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 18:58:59.516600) ========= 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.mz058ZFOOc/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.C901fE3sb3/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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-11-26 18:58:59-- 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% 18.7M=0.001s 2016-11-26 18:58:59 (18.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162196 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 18:58:59.702210) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 18:58:59.702519) ========= 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.mz058ZFOOc/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.C901fE3sb3/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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.025020 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 18:58:59.750519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-26 18:58:59.750848) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3d81e7906de637040bb850628487fd8aa921569c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3d81e7906de637040bb850628487fd8aa921569c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mz058ZFOOc/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.C901fE3sb3/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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-11-26 18:58:59,852 truncating revision to first 12 chars 2016-11-26 18:58:59,852 Setting DEBUG logging. 2016-11-26 18:58:59,852 attempt 1/10 2016-11-26 18:58:59,852 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3d81e7906de6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-26 18:59:01,919 unpacking tar archive at: mozilla-central-3d81e7906de6/testing/mozharness/ program finished with exit code 0 elapsedTime=2.341112 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-26 18:59:02.118336) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 18:59:02.119058) ========= script_repo_revision: 3d81e7906de637040bb850628487fd8aa921569c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 18:59:02.119794) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 18:59:02.120431) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 18:59:02.142029) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-26 18:59:02.142714) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mz058ZFOOc/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.C901fE3sb3/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 18:59:02 INFO - MultiFileLogger online at 20161126 18:59:02 in /builds/slave/test 18:59:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:59:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:59:02 INFO - {'append_to_log': False, 18:59:02 INFO - 'base_work_dir': '/builds/slave/test', 18:59:02 INFO - 'blob_upload_branch': 'Firefox', 18:59:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:59:02 INFO - 'branch': 'Firefox', 18:59:02 INFO - 'buildbot_json_path': 'buildprops.json', 18:59:02 INFO - 'config_files': ('talos/mac_config.py',), 18:59:02 INFO - 'default_actions': ('clobber', 18:59:02 INFO - 'read-buildbot-config', 18:59:02 INFO - 'download-and-extract', 18:59:02 INFO - 'populate-webroot', 18:59:02 INFO - 'create-virtualenv', 18:59:02 INFO - 'install', 18:59:02 INFO - 'run-tests'), 18:59:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:59:02 INFO - 'download_minidump_stackwalk': True, 18:59:02 INFO - 'download_symbols': 'ondemand', 18:59:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:59:02 INFO - 'tooltool.py': '/tools/tooltool.py', 18:59:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:59:02 INFO - '/tools/misc-python/virtualenv.py')}, 18:59:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:59:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:59:02 INFO - 'installer_path': 'installer.exe', 18:59:02 INFO - 'log_level': 'info', 18:59:02 INFO - 'log_name': 'talos', 18:59:02 INFO - 'log_to_console': True, 18:59:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:59:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:59:02 INFO - 'opt_config_files': (), 18:59:02 INFO - 'pip_index': False, 18:59:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:59:02 INFO - 'cmd': ('bash', 18:59:02 INFO - '-c', 18:59:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:59:02 INFO - 'enabled': True, 18:59:02 INFO - 'halt_on_failure': False, 18:59:02 INFO - 'name': 'check_screen_resolution'},), 18:59:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:59:02 INFO - 'cmd': ('bash', 18:59:02 INFO - '-c', 18:59:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:59:02 INFO - 'enabled': True, 18:59:02 INFO - 'halt_on_failure': False, 18:59:02 INFO - 'name': 'check_screen_resolution'},), 18:59:02 INFO - 'run_cmd_checks_enabled': True, 18:59:02 INFO - 'sps_profile': False, 18:59:02 INFO - 'sps_profile_interval': 0, 18:59:02 INFO - 'suite': 'dromaeojs', 18:59:02 INFO - 'system_bits': '32', 18:59:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:59:02 INFO - 'title': 't-yosemite-r7-0243', 18:59:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:59:02 INFO - 'use_talos_json': True, 18:59:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:59:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:59:02 INFO - 'work_dir': 'build'} 18:59:02 INFO - [mozharness: 2016-11-27 02:59:02.347553Z] Running clobber step. 18:59:02 INFO - Running pre-action listener: _resource_record_pre_action 18:59:02 INFO - Running main action method: clobber 18:59:02 INFO - rmtree: /builds/slave/test/build 18:59:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:59:04 INFO - Running post-action listener: _resource_record_post_action 18:59:04 INFO - [mozharness: 2016-11-27 02:59:04.784797Z] Finished clobber step (success) 18:59:04 INFO - [mozharness: 2016-11-27 02:59:04.784872Z] Running read-buildbot-config step. 18:59:04 INFO - Running pre-action listener: _resource_record_pre_action 18:59:04 INFO - Running main action method: read_buildbot_config 18:59:04 INFO - Using buildbot properties: 18:59:04 INFO - { 18:59:04 INFO - "project": "", 18:59:04 INFO - "product": "firefox", 18:59:04 INFO - "script_repo_revision": "production", 18:59:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:59:04 INFO - "repository": "", 18:59:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:59:04 INFO - "buildid": "20161126175419", 18:59:04 INFO - "pgo_build": "False", 18:59:04 INFO - "basedir": "/builds/slave/test", 18:59:04 INFO - "buildnumber": 32, 18:59:04 INFO - "slavename": "t-yosemite-r7-0243", 18:59:04 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 18:59:04 INFO - "platform": "yosemite_r7", 18:59:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:59:04 INFO - "branch": "mozilla-central", 18:59:04 INFO - "repo_path": "mozilla-central", 18:59:04 INFO - "revision": "3d81e7906de637040bb850628487fd8aa921569c", 18:59:04 INFO - "stage_platform": "macosx64", 18:59:04 INFO - "builduid": "f8c4519588ea4af088cbcf9731dbb1f9", 18:59:04 INFO - "slavebuilddir": "test" 18:59:04 INFO - } 18:59:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 18:59:04 INFO - Running post-action listener: _resource_record_post_action 18:59:04 INFO - [mozharness: 2016-11-27 02:59:04.788165Z] Finished read-buildbot-config step (success) 18:59:04 INFO - [mozharness: 2016-11-27 02:59:04.788290Z] Running download-and-extract step. 18:59:04 INFO - Running pre-action listener: _resource_record_pre_action 18:59:04 INFO - Running main action method: download_and_extract 18:59:04 INFO - mkdir: /builds/slave/test/build/tests 18:59: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')]} 18:59:04 INFO - trying https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 18:59:04 INFO - Downloading https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 18:59:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 18:59:06 INFO - Downloaded 1199 bytes. 18:59:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 18:59:06 INFO - Using the following test package requirements: 18:59:06 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:59:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:59:06 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 18:59:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:59:06 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 18:59:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:59:06 INFO - u'jsshell-mac.zip'], 18:59:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:59:06 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 18:59:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:59:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:59:06 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 18:59:06 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:59:06 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 18:59:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:59:06 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 18:59:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:59:06 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 18:59:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:59:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 18:59:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:59:06 INFO - Fetch https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 18:59:06 INFO - Http code: 200 18:59:06 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 18:59:06 INFO - x-amz-cf-id: uCmvL2jmQPdlAPuQQzssV1v6MimFunzSEJEsn9TaaROEM8Xpt5aLOQ== 18:59:06 INFO - x-amz-version-id: lKkKyMVsbTZVJUyvQzvhRQ8E7qW5qaDY 18:59:06 INFO - Expected file size: 16281336 18:59:06 INFO - Obtained file size: 16281336 18:59:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:59:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 18:59:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:59:13 INFO - Fetch https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 18:59:14 INFO - Http code: 200 18:59:14 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 18:59:14 INFO - x-amz-cf-id: LihZVjslc1xwzSIt2Df6n7KXq_JXglA-h56BStpx-2_3E7nv_80oeg== 18:59:14 INFO - x-amz-version-id: lKkKyMVsbTZVJUyvQzvhRQ8E7qW5qaDY 18:59:14 INFO - Expected file size: 16281336 18:59:14 INFO - Obtained file size: 16281336 18:59:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 18:59:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:59:20 INFO - Fetch https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 18:59:21 INFO - Http code: 200 18:59:21 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 18:59:21 INFO - x-amz-cf-id: s4EjtPpQKICbff8dwmO7wnrTrtf4IeAnjrjAfUoc-Phdn7nbTjIQpw== 18:59:21 INFO - x-amz-version-id: kIEkk.9hAH3eV42payuiNA0F0r3qFPyp 18:59:22 INFO - Expected file size: 14409702 18:59:22 INFO - Obtained file size: 14409702 18:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:22 INFO - trying https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:59:22 INFO - Downloading https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 18:59:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 18:59:25 INFO - Downloaded 107606844 bytes. 18:59:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:59:25 INFO - mkdir: /builds/slave/test/properties 18:59:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:59:25 INFO - Writing to file /builds/slave/test/properties/build_url 18:59:25 INFO - Contents: 18:59:25 INFO - build_url:https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:59:25 INFO - Running post-action listener: _resource_record_post_action 18:59:25 INFO - Running post-action listener: set_extra_try_arguments 18:59:25 INFO - [mozharness: 2016-11-27 02:59:25.805435Z] Finished download-and-extract step (success) 18:59:25 INFO - [mozharness: 2016-11-27 02:59:25.805603Z] Running populate-webroot step. 18:59:25 INFO - Running pre-action listener: _resource_record_pre_action 18:59:25 INFO - Running main action method: populate_webroot 18:59:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:59:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:59:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:59:25 INFO - '--tppagecycles', 18:59:25 INFO - '7'], 18:59:25 INFO - 'tests': ['tsvgm']}}, 18:59:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:59:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:59:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:59:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:59:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:59:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:59:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:59:25 INFO - 'talos_options': ['--disable-e10s'], 18:59:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:59:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:59:25 INFO - 'talos_options': ['--disable-e10s'], 18:59:25 INFO - 'tests': ['damp', 'tps']}, 18:59:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:59:25 INFO - 'tests': ['damp', 'tps']}, 18:59:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:59:25 INFO - 'tests': ['dromaeo_dom']}, 18:59:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:59:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:59:25 INFO - 'tests': ['basic_compositor_video']}, 18:59:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:59:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:59:25 INFO - 'tests': ['a11yr', 18:59:25 INFO - 'ts_paint', 18:59:25 INFO - 'tpaint', 18:59:25 INFO - 'sessionrestore', 18:59:25 INFO - 'sessionrestore_no_auto_restore', 18:59:25 INFO - 'tabpaint']}, 18:59:25 INFO - 'other-e10s': {'tests': ['a11yr', 18:59:25 INFO - 'ts_paint', 18:59:25 INFO - 'tpaint', 18:59:25 INFO - 'sessionrestore', 18:59:25 INFO - 'sessionrestore_no_auto_restore', 18:59:25 INFO - 'tabpaint']}, 18:59:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:59:25 INFO - 'ts_paint', 18:59:25 INFO - 'tpaint', 18:59:25 INFO - 'sessionrestore', 18:59:25 INFO - 'sessionrestore_no_auto_restore', 18:59:25 INFO - 'tabpaint']}, 18:59:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:59:25 INFO - 'ts_paint', 18:59:25 INFO - 'tpaint', 18:59:25 INFO - 'sessionrestore', 18:59:25 INFO - 'sessionrestore_no_auto_restore', 18:59:25 INFO - 'tabpaint']}, 18:59:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:59:25 INFO - 'tests': ['a11yr', 18:59:25 INFO - 'ts_paint', 18:59:25 INFO - 'tpaint', 18:59:25 INFO - 'sessionrestore', 18:59:25 INFO - 'sessionrestore_no_auto_restore', 18:59:25 INFO - 'tabpaint']}, 18:59:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:59:25 INFO - 'tests': ['a11yr', 18:59:25 INFO - 'ts_paint', 18:59:25 INFO - 'tpaint', 18:59:25 INFO - 'sessionrestore', 18:59:25 INFO - 'sessionrestore_no_auto_restore', 18:59:25 INFO - 'tabpaint']}, 18:59:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:59:25 INFO - 'tests': ['tsvgx', 18:59:25 INFO - 'tsvgr_opacity', 18:59:25 INFO - 'tart', 18:59:25 INFO - 'tscrollx', 18:59:25 INFO - 'cart', 18:59:25 INFO - 'tsvg_static']}, 18:59:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:59:25 INFO - 'tsvgr_opacity', 18:59:25 INFO - 'tart', 18:59:25 INFO - 'tscrollx', 18:59:25 INFO - 'cart', 18:59:25 INFO - 'tsvg_static']}, 18:59:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:59:25 INFO - 'talos_options': ['--disable-e10s'], 18:59:25 INFO - 'tests': ['tp5o']}, 18:59:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:59:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:59:25 INFO - 'talos_options': ['--disable-e10s', 18:59:25 INFO - '--xperf_path', 18:59:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:25 INFO - 'tests': ['tp5n']}, 18:59:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:59:25 INFO - 'talos_options': ['--xperf_path', 18:59:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:25 INFO - 'tests': ['tp5n']}}, 18:59:25 INFO - 'talos.zip': {'path': '', 18:59:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:59:25 INFO - Running post-action listener: _resource_record_post_action 18:59:25 INFO - [mozharness: 2016-11-27 02:59:25.824119Z] Finished populate-webroot step (success) 18:59:25 INFO - [mozharness: 2016-11-27 02:59:25.824265Z] Running create-virtualenv step. 18:59:25 INFO - Running pre-action listener: _resource_record_pre_action 18:59:25 INFO - Running main action method: create_virtualenv 18:59:25 INFO - Creating virtualenv /builds/slave/test/build/venv 18:59:25 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 18:59:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:59:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:59:25 INFO - Using real prefix '/tools/python27' 18:59:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:59:26 INFO - Installing distribute.............................................................................................................................................................................................done. 18:59:29 INFO - Installing pip.................done. 18:59:29 INFO - Return code: 0 18:59:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:59:29 INFO - Reading from file tmpfile_stdout 18:59:29 INFO - Output received: 18:59:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:59:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:59:29 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')]} 18:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:29 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')]} 18:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:29 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 0x1019c93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d88db0000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017dfd30>, '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 0x101646db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017d7b20>, '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.mz058ZFOOc/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.C901fE3sb3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 18:59:29 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 18:59:29 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 18:59:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mz058ZFOOc/Render', 18:59:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:29 INFO - 'HOME': '/Users/cltbld', 18:59:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:29 INFO - 'LOGNAME': 'cltbld', 18:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:29 INFO - 'MOZ_NO_REMOTE': '1', 18:59:29 INFO - 'NO_EM_RESTART': '1', 18:59:29 INFO - 'PAGER': '/bin/cat', 18:59:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:29 INFO - 'PWD': '/builds/slave/test', 18:59:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:29 INFO - 'SHELL': '/bin/bash', 18:59:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C901fE3sb3/Listeners', 18:59:29 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 18:59:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:29 INFO - 'USER': 'cltbld', 18:59:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:29 INFO - 'XPC_FLAGS': '0x0', 18:59:29 INFO - 'XPC_SERVICE_NAME': '0', 18:59:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:30 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 18:59:30 INFO - Cleaning up... 18:59:30 INFO - Return code: 0 18:59:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:59:30 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')]} 18:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:30 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')]} 18:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:30 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 0x1019c93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d88db0000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017dfd30>, '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 0x101646db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017d7b20>, '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.mz058ZFOOc/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.C901fE3sb3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 18:59:30 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 18:59:30 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 18:59:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mz058ZFOOc/Render', 18:59:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:30 INFO - 'HOME': '/Users/cltbld', 18:59:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:30 INFO - 'LOGNAME': 'cltbld', 18:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:30 INFO - 'MOZ_NO_REMOTE': '1', 18:59:30 INFO - 'NO_EM_RESTART': '1', 18:59:30 INFO - 'PAGER': '/bin/cat', 18:59:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:30 INFO - 'PWD': '/builds/slave/test', 18:59:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:30 INFO - 'SHELL': '/bin/bash', 18:59:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C901fE3sb3/Listeners', 18:59:30 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 18:59:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:30 INFO - 'USER': 'cltbld', 18:59:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:30 INFO - 'XPC_FLAGS': '0x0', 18:59:30 INFO - 'XPC_SERVICE_NAME': '0', 18:59:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:30 INFO - Downloading/unpacking psutil>=3.1.1 18:59:30 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 18:59:30 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 18:59:30 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 18:59:30 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 18:59:30 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 18:59:30 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 18:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:59:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:33 INFO - Installing collected packages: psutil 18:59:33 INFO - Running setup.py install for psutil 18:59:33 INFO - building 'psutil._psutil_osx' extension 18:59:33 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 18:59:34 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 18:59:34 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 18:59:34 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 18:59:34 INFO - building 'psutil._psutil_posix' extension 18:59:34 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 18:59:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:59:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:59:34 INFO - ^ 18:59:34 INFO - 1 warning generated. 18:59:34 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 18:59:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:34 INFO - Successfully installed psutil 18:59:34 INFO - Cleaning up... 18:59:35 INFO - Return code: 0 18:59:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:35 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 0x1019c93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d88db0000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017dfd30>, '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 0x101646db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017d7b20>, '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.mz058ZFOOc/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.C901fE3sb3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 18:59:35 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 18:59:35 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 18:59:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mz058ZFOOc/Render', 18:59:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:35 INFO - 'HOME': '/Users/cltbld', 18:59:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:35 INFO - 'LOGNAME': 'cltbld', 18:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:35 INFO - 'MOZ_NO_REMOTE': '1', 18:59:35 INFO - 'NO_EM_RESTART': '1', 18:59:35 INFO - 'PAGER': '/bin/cat', 18:59:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:35 INFO - 'PWD': '/builds/slave/test', 18:59:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:35 INFO - 'SHELL': '/bin/bash', 18:59:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C901fE3sb3/Listeners', 18:59:35 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 18:59:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:35 INFO - 'USER': 'cltbld', 18:59:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:35 INFO - 'XPC_FLAGS': '0x0', 18:59:35 INFO - 'XPC_SERVICE_NAME': '0', 18:59:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:59:35 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 18:59:35 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 18:59:35 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 18:59:35 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 18:59:35 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 18:59:35 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 18:59:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:59:37 INFO - Installing collected packages: mozsystemmonitor 18:59:37 INFO - Running setup.py install for mozsystemmonitor 18:59:38 INFO - Successfully installed mozsystemmonitor 18:59:38 INFO - Cleaning up... 18:59:38 INFO - Return code: 0 18:59:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:59:38 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')]} 18:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:38 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')]} 18:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:38 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 0x1019c93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d88db0000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017dfd30>, '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 0x101646db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017d7b20>, '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.mz058ZFOOc/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.C901fE3sb3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 18:59:38 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 18:59:38 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 18:59:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mz058ZFOOc/Render', 18:59:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:38 INFO - 'HOME': '/Users/cltbld', 18:59:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:38 INFO - 'LOGNAME': 'cltbld', 18:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:38 INFO - 'MOZ_NO_REMOTE': '1', 18:59:38 INFO - 'NO_EM_RESTART': '1', 18:59:38 INFO - 'PAGER': '/bin/cat', 18:59:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:38 INFO - 'PWD': '/builds/slave/test', 18:59:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:38 INFO - 'SHELL': '/bin/bash', 18:59:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C901fE3sb3/Listeners', 18:59:38 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 18:59:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:38 INFO - 'USER': 'cltbld', 18:59:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:38 INFO - 'XPC_FLAGS': '0x0', 18:59:38 INFO - 'XPC_SERVICE_NAME': '0', 18:59:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:39 INFO - Downloading/unpacking jsonschema==2.5.1 18:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:59:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:59:42 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 18:59:42 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 18:59:42 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 18:59:42 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 18:59:42 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 18:59:42 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 18:59:42 INFO - Downloading functools32-3.2.3-2.tar.gz 18:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:59:42 INFO - warning: no files found matching '*.txt' 18:59:42 INFO - no previously-included directories found matching 'build' 18:59:42 INFO - no previously-included directories found matching 'dist' 18:59:42 INFO - no previously-included directories found matching '.git*' 18:59:42 INFO - Installing collected packages: jsonschema, functools32 18:59:42 INFO - Running setup.py install for functools32 18:59:42 INFO - warning: no files found matching '*.txt' 18:59:42 INFO - no previously-included directories found matching 'build' 18:59:42 INFO - no previously-included directories found matching 'dist' 18:59:42 INFO - no previously-included directories found matching '.git*' 18:59:42 INFO - Successfully installed jsonschema functools32 18:59:42 INFO - Cleaning up... 18:59:42 INFO - Return code: 0 18:59:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:59:42 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')]} 18:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:42 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')]} 18:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:42 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 0x1019c93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d88db0000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017dfd30>, '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 0x101646db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017d7b20>, '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.mz058ZFOOc/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.C901fE3sb3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 18:59:42 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 18:59:42 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 18:59:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mz058ZFOOc/Render', 18:59:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:42 INFO - 'HOME': '/Users/cltbld', 18:59:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:42 INFO - 'LOGNAME': 'cltbld', 18:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:42 INFO - 'MOZ_NO_REMOTE': '1', 18:59:42 INFO - 'NO_EM_RESTART': '1', 18:59:42 INFO - 'PAGER': '/bin/cat', 18:59:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:42 INFO - 'PWD': '/builds/slave/test', 18:59:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:42 INFO - 'SHELL': '/bin/bash', 18:59:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C901fE3sb3/Listeners', 18:59:42 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 18:59:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:42 INFO - 'USER': 'cltbld', 18:59:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:42 INFO - 'XPC_FLAGS': '0x0', 18:59:42 INFO - 'XPC_SERVICE_NAME': '0', 18:59:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:59:43 INFO - Cleaning up... 18:59:43 INFO - Return code: 0 18:59:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1019c93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d88db0000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017dfd30>, '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 0x101646db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017d7b20>, '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.mz058ZFOOc/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.C901fE3sb3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 18:59:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:59:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:59:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mz058ZFOOc/Render', 18:59:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:43 INFO - 'HOME': '/Users/cltbld', 18:59:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:43 INFO - 'LOGNAME': 'cltbld', 18:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:43 INFO - 'MOZ_NO_REMOTE': '1', 18:59:43 INFO - 'NO_EM_RESTART': '1', 18:59:43 INFO - 'PAGER': '/bin/cat', 18:59:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:43 INFO - 'PWD': '/builds/slave/test', 18:59:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:43 INFO - 'SHELL': '/bin/bash', 18:59:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C901fE3sb3/Listeners', 18:59:43 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 18:59:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:43 INFO - 'USER': 'cltbld', 18:59:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:43 INFO - 'XPC_FLAGS': '0x0', 18:59:43 INFO - 'XPC_SERVICE_NAME': '0', 18:59:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:43 INFO - Downloading/unpacking blobuploader==1.2.4 18:59:43 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 18:59:43 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 18:59:43 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 18:59:43 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 18:59:43 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 18:59:43 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 18:59:45 INFO - Downloading blobuploader-1.2.4.tar.gz 18:59:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:59:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:59:45 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 18:59:45 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 18:59:45 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 18:59:45 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 18:59:45 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 18:59:45 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 18:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:59:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:59:46 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 18:59:46 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 18:59:46 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 18:59:46 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 18:59:46 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 18:59:46 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 18:59:47 INFO - Downloading docopt-0.6.1.tar.gz 18:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:59:47 INFO - Installing collected packages: blobuploader, requests, docopt 18:59:47 INFO - Running setup.py install for blobuploader 18:59:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:59:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:59:47 INFO - Running setup.py install for requests 18:59:47 INFO - Running setup.py install for docopt 18:59:48 INFO - Successfully installed blobuploader requests docopt 18:59:48 INFO - Cleaning up... 18:59:48 INFO - Return code: 0 18:59:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:48 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')]} 18:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:48 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')]} 18:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:48 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 0x1019c93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d88db0000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017dfd30>, '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 0x101646db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017d7b20>, '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.mz058ZFOOc/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.C901fE3sb3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 18:59:48 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 18:59:48 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 18:59:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mz058ZFOOc/Render', 18:59:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:48 INFO - 'HOME': '/Users/cltbld', 18:59:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:48 INFO - 'LOGNAME': 'cltbld', 18:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:48 INFO - 'MOZ_NO_REMOTE': '1', 18:59:48 INFO - 'NO_EM_RESTART': '1', 18:59:48 INFO - 'PAGER': '/bin/cat', 18:59:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:48 INFO - 'PWD': '/builds/slave/test', 18:59:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:48 INFO - 'SHELL': '/bin/bash', 18:59:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C901fE3sb3/Listeners', 18:59:48 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 18:59:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:48 INFO - 'USER': 'cltbld', 18:59:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:48 INFO - 'XPC_FLAGS': '0x0', 18:59:48 INFO - 'XPC_SERVICE_NAME': '0', 18:59:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:48 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-MSiIbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:48 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-zvH1oD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:48 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-ZdEwkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:48 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-__Cnr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:48 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-pH7DSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:48 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-08jT8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:48 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-rHv5NO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:49 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-Piqrok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:49 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-sCoBeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:49 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-7kHz5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:49 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-V4yKd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:49 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-m7KJuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:49 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-rOGpTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:49 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-6mEWHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:49 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-9zih_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:49 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-162UC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:50 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-a6c2XQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:59:50 INFO - Running setup.py install for manifestparser 18:59:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:59:50 INFO - Running setup.py install for mozcrash 18:59:50 INFO - Running setup.py install for mozdebug 18:59:50 INFO - Running setup.py install for mozdevice 18:59:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:59:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:59:50 INFO - Running setup.py install for mozfile 18:59:50 INFO - Running setup.py install for mozhttpd 18:59:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:59:51 INFO - Running setup.py install for mozinfo 18:59:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:59:51 INFO - Running setup.py install for mozInstall 18:59:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:59:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:59:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:59:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:59:51 INFO - Running setup.py install for mozleak 18:59:51 INFO - Running setup.py install for mozlog 18:59:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:59:51 INFO - Running setup.py install for moznetwork 18:59:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:59:51 INFO - Running setup.py install for mozprocess 18:59:51 INFO - Running setup.py install for mozprofile 18:59:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:59:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:59:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:59:52 INFO - Running setup.py install for mozrunner 18:59:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:59:52 INFO - Running setup.py install for mozscreenshot 18:59:52 INFO - Running setup.py install for moztest 18:59:52 INFO - Running setup.py install for mozversion 18:59:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:59:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:59:52 INFO - Cleaning up... 18:59:52 INFO - Return code: 0 18:59:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:52 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 0x1019c93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d88db0000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017dfd30>, '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 0x101646db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017d7b20>, '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.mz058ZFOOc/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.C901fE3sb3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 18:59:52 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 18:59:52 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 18:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mz058ZFOOc/Render', 18:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:52 INFO - 'HOME': '/Users/cltbld', 18:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:52 INFO - 'LOGNAME': 'cltbld', 18:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:52 INFO - 'MOZ_NO_REMOTE': '1', 18:59:52 INFO - 'NO_EM_RESTART': '1', 18:59:52 INFO - 'PAGER': '/bin/cat', 18:59:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:52 INFO - 'PWD': '/builds/slave/test', 18:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:52 INFO - 'SHELL': '/bin/bash', 18:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C901fE3sb3/Listeners', 18:59:52 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 18:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:52 INFO - 'USER': 'cltbld', 18:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:52 INFO - 'XPC_FLAGS': '0x0', 18:59:52 INFO - 'XPC_SERVICE_NAME': '0', 18:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:52 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-ATgwnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:53 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)) 18:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:53 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-9X5GDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:53 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-Weomf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:53 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)) 18:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:53 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-zy1Yo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:53 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-jYnbiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:53 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)) 18:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:53 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-dzMBRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:53 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)) 18:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:53 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-Zsf8Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:53 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)) 18:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:53 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-ypyW9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:53 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)) 18:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:53 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-9iDr5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:53 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)) 18:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:53 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-BI4WiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:54 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)) 18:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:54 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-0HCu4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:54 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)) 18:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:54 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-Mtbdg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:54 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)) 18:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:54 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-uEMKKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:54 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)) 18:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:54 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-O3QQC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:54 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-t5psoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:54 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)) 18:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:54 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-7satyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:54 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)) 18:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:54 INFO - Running setup.py (path:/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/pip-8kfLOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:54 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)) 18:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:59:54 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)) 18:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:59:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:59:54 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 18:59:54 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 18:59:54 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 18:59:54 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 18:59:54 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 18:59:54 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 18:59:57 INFO - Downloading blessings-1.6.tar.gz 18:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:59:57 INFO - Installing collected packages: blessings 18:59:57 INFO - Running setup.py install for blessings 18:59:57 INFO - Successfully installed blessings 18:59:57 INFO - Cleaning up... 18:59:57 INFO - Return code: 0 18:59:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:59:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:59:57 INFO - Reading from file tmpfile_stdout 18:59:57 INFO - Current package versions: 18:59:57 INFO - blessings == 1.6 18:59:57 INFO - blobuploader == 1.2.4 18:59:57 INFO - docopt == 0.6.1 18:59:57 INFO - functools32 == 3.2.3-2 18:59:57 INFO - jsonschema == 2.5.1 18:59:57 INFO - manifestparser == 1.1 18:59:57 INFO - mozInstall == 1.12 18:59:57 INFO - mozcrash == 1.0 18:59:57 INFO - mozdebug == 0.1 18:59:57 INFO - mozdevice == 0.49 18:59:57 INFO - mozfile == 1.2 18:59:57 INFO - mozhttpd == 0.7 18:59:57 INFO - mozinfo == 0.9 18:59:57 INFO - mozleak == 0.1 18:59:57 INFO - mozlog == 3.4 18:59:57 INFO - moznetwork == 0.27 18:59:57 INFO - mozprocess == 0.23 18:59:57 INFO - mozprofile == 0.28 18:59:57 INFO - mozrunner == 6.13 18:59:57 INFO - mozscreenshot == 0.1 18:59:57 INFO - mozsystemmonitor == 0.3 18:59:57 INFO - moztest == 0.7 18:59:57 INFO - mozversion == 1.4 18:59:57 INFO - psutil == 3.1.1 18:59:57 INFO - requests == 1.2.3 18:59:57 INFO - wsgiref == 0.1.2 18:59:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:57 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 0x1019c93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d88db0000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017dfd30>, '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 0x101646db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017d7b20>, '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.mz058ZFOOc/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.C901fE3sb3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 18:59:57 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 18:59:57 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 18:59:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mz058ZFOOc/Render', 18:59:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:57 INFO - 'HOME': '/Users/cltbld', 18:59:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:57 INFO - 'LOGNAME': 'cltbld', 18:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:57 INFO - 'MOZ_NO_REMOTE': '1', 18:59:57 INFO - 'NO_EM_RESTART': '1', 18:59:57 INFO - 'PAGER': '/bin/cat', 18:59:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:57 INFO - 'PWD': '/builds/slave/test', 18:59:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:57 INFO - 'SHELL': '/bin/bash', 18:59:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C901fE3sb3/Listeners', 18:59:57 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 18:59:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:57 INFO - 'USER': 'cltbld', 18:59:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:57 INFO - 'XPC_FLAGS': '0x0', 18:59:57 INFO - 'XPC_SERVICE_NAME': '0', 18:59:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:58 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)) 18:59:58 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)) 18:59:58 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)) 18:59:58 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)) 18:59:58 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)) 18:59:58 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)) 18:59:58 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)) 18:59:58 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)) 18:59:58 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)) 18:59:58 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)) 18:59:58 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)) 18:59:58 INFO - Cleaning up... 18:59:58 INFO - Return code: 0 18:59:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:59:58 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')]} 18:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:58 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')]} 18:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:58 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 0x1019c93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d88db0000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017dfd30>, '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 0x101646db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017d7b20>, '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.mz058ZFOOc/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.C901fE3sb3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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 18:59:58 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 18:59:58 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 18:59:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mz058ZFOOc/Render', 18:59:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:58 INFO - 'HOME': '/Users/cltbld', 18:59:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:58 INFO - 'LOGNAME': 'cltbld', 18:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:58 INFO - 'MOZ_NO_REMOTE': '1', 18:59:58 INFO - 'NO_EM_RESTART': '1', 18:59:58 INFO - 'PAGER': '/bin/cat', 18:59:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:58 INFO - 'PWD': '/builds/slave/test', 18:59:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:58 INFO - 'SHELL': '/bin/bash', 18:59:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C901fE3sb3/Listeners', 18:59:58 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 18:59:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:58 INFO - 'USER': 'cltbld', 18:59:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:58 INFO - 'XPC_FLAGS': '0x0', 18:59:58 INFO - 'XPC_SERVICE_NAME': '0', 18:59:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:59:58 INFO - Cleaning up... 18:59:58 INFO - Return code: 0 18:59:58 INFO - Running post-action listener: _resource_record_post_action 18:59:58 INFO - Running post-action listener: _start_resource_monitoring 18:59:58 INFO - Starting resource monitoring. 18:59:58 INFO - [mozharness: 2016-11-27 02:59:58.519688Z] Finished create-virtualenv step (success) 18:59:58 INFO - [mozharness: 2016-11-27 02:59:58.520713Z] Running install step. 18:59:58 INFO - Running pre-action listener: _resource_record_pre_action 18:59:58 INFO - Running main action method: install 18:59:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:59:58 INFO - Reading from file tmpfile_stdout 18:59:58 INFO - Detecting whether we're running mozinstall >=1.0... 18:59:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:59:58 INFO - Reading from file tmpfile_stdout 18:59:58 INFO - Output received: 18:59:58 INFO - Usage: mozinstall [options] installer 18:59:58 INFO - Options: 18:59:58 INFO - -h, --help show this help message and exit 18:59:58 INFO - -d DEST, --destination=DEST 18:59:58 INFO - Directory to install application into. [default: 18:59:58 INFO - "/builds/slave/test"] 18:59:58 INFO - --app=APP Application being installed. [default: firefox] 18:59:58 INFO - mkdir: /builds/slave/test/build/application 18:59:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:00:31 INFO - Reading from file tmpfile_stdout 19:00:31 INFO - Output received: 19:00:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:00:31 INFO - Running post-action listener: _resource_record_post_action 19:00:31 INFO - [mozharness: 2016-11-27 03:00:31.600679Z] Finished install step (success) 19:00:31 INFO - [mozharness: 2016-11-27 03:00:31.600827Z] Running run-tests step. 19:00:31 INFO - Running pre-action listener: _resource_record_pre_action 19:00:31 INFO - Running main action method: run_tests 19:00:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:00:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:00:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:00:31 INFO - 2016-11-26 19:00:31.615 screenresolution[1632:7793] starting screenresolution argv=screenresolution get 19:00:31 INFO - 2016-11-26 19:00:31.618 screenresolution[1632:7793] Display 0: 1600x1200x32@60 19:00:31 INFO - 2016-11-26 19:00:31.624 screenresolution[1633:7795] starting screenresolution argv=screenresolution list 19:00:31 INFO - Available Modes on Display 0 19:00:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:00:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:00:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:00:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:00:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:00:31 INFO - Intel Iris: 19:00:31 INFO - Chipset Model: Intel Iris 19:00:31 INFO - Type: GPU 19:00:31 INFO - Bus: Built-In 19:00:31 INFO - VRAM (Dynamic, Max): 1536 MB 19:00:31 INFO - Vendor: Intel (0x8086) 19:00:31 INFO - Device ID: 0x0a2e 19:00:31 INFO - Revision ID: 0x0009 19:00:31 INFO - Displays: 19:00:31 INFO - Display: 19:00:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:00:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:00:31 INFO - Display Serial Number: 1600x1200 60 19:00:31 INFO - Main Display: Yes 19:00:31 INFO - Mirror: Off 19:00:31 INFO - Online: Yes 19:00:31 INFO - Rotation: Supported 19:00:31 INFO - Return code: 0 19:00:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:00:31 INFO - Python 2.7.3 19:00:31 INFO - Return code: 0 19:00:31 INFO - grabbing minidump binary from tooltool 19:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:31 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 0x1017dfd30>, '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 0x101646db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017d7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:00:31 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 19:00:31 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 19:00:31 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 19:00:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:00:31 INFO - Return code: 0 19:00:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:00:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:00:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:00:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:00:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:00:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0243', '--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 19:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0243 --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 19:00:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mz058ZFOOc/Render', 19:00:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:31 INFO - 'HOME': '/Users/cltbld', 19:00:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:31 INFO - 'LOGNAME': 'cltbld', 19:00:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:00:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:31 INFO - 'MOZ_NO_REMOTE': '1', 19:00:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:00:31 INFO - 'NO_EM_RESTART': '1', 19:00:31 INFO - 'PAGER': '/bin/cat', 19:00:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:31 INFO - 'PWD': '/builds/slave/test', 19:00:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:00:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:31 INFO - 'SHELL': '/bin/bash', 19:00:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C901fE3sb3/Listeners', 19:00:31 INFO - 'TMPDIR': '/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/', 19:00:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:31 INFO - 'USER': 'cltbld', 19:00:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:31 INFO - 'XPC_FLAGS': '0x0', 19:00:31 INFO - 'XPC_SERVICE_NAME': '0', 19:00:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0243', '--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 19:00:32 INFO - mozversion application_buildid: 20161126175419 19:00:32 INFO - mozversion application_changeset: 3d81e7906de637040bb850628487fd8aa921569c 19:00:32 INFO - mozversion application_display_name: Nightly 19:00:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:00:32 INFO - mozversion application_name: Firefox 19:00:32 INFO - mozversion application_remotingname: firefox 19:00:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:00:32 INFO - mozversion application_vendor: Mozilla 19:00:32 INFO - mozversion application_version: 53.0a1 19:00:32 INFO - mozversion platform_buildid: 20161126175419 19:00:32 INFO - mozversion platform_changeset: 3d81e7906de637040bb850628487fd8aa921569c 19:00:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:00:32 INFO - mozversion platform_version: 53.0a1 19:00:32 INFO - using testdate: 1480215632 19:00:32 INFO - actual date: 1480215632 19:00:32 INFO - starting webserver on 'localhost:49243' 19:00:32 INFO - SUITE-START | Running 2 tests 19:00:32 INFO - TEST-START | dromaeo_css 19:00:32 INFO - operating with platform_type : mac_ 19:00:32 INFO - Initialising browser for dromaeo_css test... 19:00:32 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/tmpHXGwne/profile http://localhost:49243/getInfo.html) 19:00:34 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 19:00:34 INFO - PROCESS | 1643 | colorDepth:24 19:00:34 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 19:00:34 INFO - PROCESS | 1643 | __metrics 19:00:35 INFO - PROCESS | 1643 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:00:35 INFO - PROCESS | 1643 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:00:36 INFO - TEST-INFO | 1643: exit 0 19:00:36 INFO - Browser initialized. 19:00:36 INFO - Running cycle 1/1 for dromaeo_css test... 19:00:36 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/tmpHXGwne/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:48 INFO - PROCESS | 1645 | RSS: Main: 244805632 19:00:48 INFO - PROCESS | 1645 | 19:01:40 INFO - PROCESS | 1645 | 1480215700005 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] 19:03:53 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 19:03:55 INFO - PROCESS | 1645 | RSS: Main: 383180800 19:03:55 INFO - PROCESS | 1645 | 19:06:58 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 19:06:58 INFO - PROCESS | 1645 | RSS: Main: 373944320 19:06:58 INFO - PROCESS | 1645 | 19:10:01 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 19:10:01 INFO - PROCESS | 1645 | RSS: Main: 354463744 19:10:01 INFO - PROCESS | 1645 | 19:13:03 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 19:13:04 INFO - PROCESS | 1645 | RSS: Main: 344506368 19:13:04 INFO - PROCESS | 1645 | 19:16:08 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 19:16:08 INFO - PROCESS | 1645 | RSS: Main: 340086784 19:16:08 INFO - PROCESS | 1645 | 19:19:11 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 19:19:12 INFO - PROCESS | 1645 | RSS: Main: 469475328 19:19:12 INFO - PROCESS | 1645 | 19:19:12 INFO - PROCESS | 1645 | __start_tp_report 19:19:12 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 19:19:12 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 19:19:12 INFO - PROCESS | 1645 | |i|pagename|runs| 19:19:12 INFO - PROCESS | 1645 | |0;dojo.html;3073.3545955349373;3334.649861764514;3339.5992480902282;3372.376110419571;3387.5257463955036;5481.013417584833;5530.170474428838;5547.750351234194;5636.830895073144;5653.745581448834;5462.262594549735;5542.806001789938;5571.582131340156;5577.69322687253;5578.967890940179;5065.822696205633;5071.340725705653;5082.3138876251605;5117.078925793356;5157.6131790115705;5117.539421452068;5178.249153872686;5185.066687996159;5192.376914770233;5194.324737784083;5096.974515127437;5115.923261151067;5120.078385890538;5130.9743451282875;5172.974135129319;4315.115401342733;4506.842260520899;4977.651564390494;5151.5878729701535;5179;5001.474845141244;5004.474530174352;5057.49425057495;5096.031753966771;5146.3824341078935;5512.448755124496;5547.001539722848;5588.441155884379;5589.944100558983;5620.4660557247;6143.508519318444;6162.969185154046;6165.445109940127;6166.352532984017;6166.506679465632;5785.88428231433;5823.155642431866;6035.7283922223605;6215.68921553925;6219.626822390671;5495.873345964068;5550.5282051026115;5581.553475721932;5610.242617246701;5674.1488776683;6199.473044791243;6209.534284928648;6216.160818289473;6222.751089956351;6234.0337247726675;5805.912911306334;5910.054391297372;5926.377730338252;5927.9407205928255;5934.347221805598;5983.730732117066;6025.3974602540275;6069.393060693896;6070.332263451017;6137.41694539018;6038.365971572922;6053.939460605337;6054.334023257438;6065.787697430657;6075.878482430327;6034.456898879122;6104.4591554472245;6109.829807539378;6156.415140561639;6163.3528479509905;4838.056578967138;4894.339264199288;4899.436564795023;4925.852224433273;4929.186684197139;4309.870703878826;4392.538783427758;4412.4043254160915;4441.20058389493;4446.9777651111535;4690.882727931761;5575.972120139373;5629.465200805998;5652.660840349592;5663.150527420919;6185.288691800501;6191.380861913773;6197.1324014637985;6207.81376558704;6209.0996805462955;5658.575606829504;5663.66018038919;5684.6020778545935;5687.744051517691;5705.1727499512335;5218.478152184751;5274.92087618686;5293.629445938747;5330.200469929464;5345.492178243061;6187.659678717714;6224.1597384352535;6278.0896769967185;6279.120923070683;6303.653299068412;6183.81448556544;6192.473639740492;6193.535484838565;6219.533534984804;6225.097360882737;5328.920066198933;6101.450869421773;6244;6251.624902505864;6258.780942666985;5852.970735146297;5899.439553242435;5976.193213916065;6093.6039157454625;6095.05526643371;4983.426905905867;6141.170941922784;6170.845728856814;6173.629582225081;6209.285932117864;5974.253218347707;5989.790357337472;6001.459868611846;6002.549808764447;6016.09758536223;5626.381098079126;5763.8559036024435;5816.069428891357;5978.940210597838;5983.940160598512;5719.056355701263;5785.27684039495;5815.302163740378;5860.208871802252;5905.261842269716;5959.642421454727;5985.40145985398;6008.909866351921;6016.007358785751;6028.969855150696;5658.292713410824;5809.2738407699035;5813.534917206698;5815.214945982408;5874.970625147018 19:19:12 INFO - PROCESS | 1645 | |1;ext.html;468.8780916961589;499.7726034654233;508.71511953306145;521.280632726837;522.3288074823852;23593.29220123397;38864.61135388645;39776.403353949645;39962.2007559849;42196.36705449413;40772.79613601935;41098;41157.17685646285;41198.17603647925;41253;9263.397879137869;9453.527323633825;9458.905410945905;9467.337286389955;9486.383385079982;8450.57747112645;8673.913260867404;11088.2238243323;11331.03686186671;11341.546338146465;11174.27367221128;11223.60717374892;11225.494852731606;11243.550257989671;11282.435878206057;11258.155638327118;11323.037541808957;11323.886761132448;11326.433678316092;11332.376719280437;6882.931170688279;7651.732189373401;8865.911340886638;10878.075363594104;11192.888071119267;31916.840415798004;39350.60649393498;39438;39445;39497.60502394968;3211.5022171563446;3316.436205845012;3318.1206980150278;3527.206378564828;3594.029612004744;28847.703464947648;29543.5568466471;30321.848390758125;30366.69633303661;30407.935722249615;3162.810231386124;3164.746820254374;3218.4045951499047;3303.620083690382;3315.1049216711353;330142;335468;337571;339013;340219.97800220276;57045;57418;57433.564160895476;57444.13833792497;57460.71269643625;59061.45631262138;59231.111533327035;59243.407565923786;59260.11109833356;59278.40721592729;15115.395384184729;15379.923100384427;15391.307391167424;15399.692006159814;15399.92300038515;10359;11797.410129493663;11894.82157767634;11896.16726829131;11925.642230733092;14117.858821411859;14475.203863787592;15755.763663545056;15996.04023758555;16225.188740562924;6649.235337936103;6731.831704207336;6756.290589488131;6791.728330866808;6835.760748373783;827.7640872351351;866.2809867809702;912.780932576177;931.855562387831;950;24911.62632560513;28890.566641500394;29125.41749165047;29327.560086598718;29477.852610737238;1011.1708399112804;1011.2819897872446;1011.4437059617181;1016.4460369098858;1170.145793570698;12918.935405323102;12930.806037909439;14929.17889516087;15236.619084522754;15430.614234644;627693;630711;630920;631485;866806;46411.535884641395;54605;55887.720561396934;56240.87518249612;58929.70535147383;1317.4795955597676;1332.486992507872;1355.1868878672717;1357.18568858684;1358.5041459867077;29341.853290734263;29490.85254573799;29838;30229.244268893453;30440.41127044974;41112;55230.72384638212;55360.44639553714;57458.71270643787;57543.42456575548;532952;538495;539773;540301.7607710973;540929;24922.750772492043;25218.495630087662;25305.62041569341;25315.240542783748;25326.240212793644;44652;44889.77555112204;44951.62219617333;45257.547424525335;45794.771026144655;37184;37283.254334912606;38236.42645360266;38502.80748596239;38591.228175435775;36769.26461470809;37145.628543714214;37354.846717140375;37537.624623753414;37756.62243377641;36098.111023519734;36412;37097.6290237105;37115.25769484649;37396.87809365724;30728.846355768972;31844.68155318417;33497.49753753744;33633.15917102092;33784.831075844464;21667.783322166575;24572.50854982926;24632.13787517428;24688.382790429663;25229.621555677048 19:19:12 INFO - PROCESS | 1645 | |2;jquery.html;351.5781062724731;369.20989083361604;371.2945403732909;379.86704653371316;396.18781497929257;11371.431428428576;14487.637809054779;15285.541433756991;18017.81982180178;19456.70814937777;15250.6949861003;18371.448856534324;19255;19484.318048868292;19515.707264391047;5335.813246536362;5684.261046064006;5685.260916080924;5687.090065589507;5692.715364231793;4682.484926658065;5391.595630327722;5494.80768173114;5656.717164141776;5745.540356771448;5759.473739459047;5760.308762948452;5762.3949485304065;5765.913511297334;5766.625169363999;5530.5299049581035;5722.9141562876175;5779.393163717791;5783.334916484616;5787;4677.836275730368;5575.637583557056;5576.470235327637;5578.414266501999;5583.581231407661;12211.023118150526;12344.38278086092;12531.18547294423;12672.68318292041;12688.04839637031;2115.3442432845713;2119.035838693391;2256.4922892349255;2296.3455415206586;2705.702372738997;9342.392744471656;9739.220862331067;9801.313908026441;10022.699319020368;10109.797804043952;1816.4459839748872;1820.2809890093472;1849.519125027489;1885.377825317642;1891.3474851176322;90201;106359;111023.44488277507;114842.42578787135;114902;10605.522751476203;10792.946035269773;10894.509747061402;11049.889501104886;11135.387553684463;13667.521636742666;13676.52132175389;13682;13909.565825980615;13974.720505589832;7044.436445084381;7261.41908647307;7919.049714034353;8042.316403105801;8065;7723.189065148191;7736.187700291501;7741.806454838674;7894.723684671009;7904.683812647545;3640.381135207021;4196.950762309422;4218.451601291812;4278.4010238566625;4532.977335113369;1378.2970684950747;1684.61253911601;1774;1849.2418108575419;1896.4689886831434;840.3361344537869;884.2218847414234;891.7159290621485;954.9952250238705;969.6340928135468;17848.91075544614;17993.910030449762;19396.450590320303;19403.90298048529;19679.90160049219;738.9912769070288;882.8455020371409;924.9537523123817;929.7164364868645;932.4032619123766;9644.39708825851;9656.179224765974;9977.45124018186;10201.183905287558;10216.233782466345;576617;577785;586122;590359;592382;114053;117763.41118294524;119411.2088318676;122055;124361.37819310845;939.4081728510994;954.8710924025306;955.3360414511986;959.2086528613921;960.7805226289024;15640.530784076042;16779;16790.58023549421;17212.741808872626;17384.15217738062;43464;43592.34611480767;47792.522074778804;49105;52503;70504.29495704977;71612;72062.42789449291;72760.54478910498;73984;7409.925900740924;7693.422993275415;7741.883871741816;7746.49647772893;8022.398320126131;10162.54268557902;11854;12086.576969806014;12091.81862272049;12200.14598978063;10332.896671033193;10396;10600.25798194119;10639.414832184304;10792.003479356345;10369.792604148026;10414.47927603632;10502.4223667699;10614.946925265323;10684.732881678021;10349.172066234532;10399.792004160026;10819.891801082204;10827.079698225423;10896.891031089588;6678.966605166943;7570.318671319607;7705.499142555716;7788.766337009899;7953;9060.95469522648;10285.640002600172;10419.583216671248;10605.734856628646;10706.625268115578 19:19:12 INFO - PROCESS | 1645 | |3;mootools.html;1318.1234479071418;1339.189790176943;1450.1734011613382;1590.3956496531316;1827.926882924683;7237.878128890024;7653.272939070786;7766.184550622188;8077.313428358597;8109.918900811005;8034.558099304536;8100.230478104585;8107.878381824277;8113.63488643011;8121.472104313216;1953.716711076893;2225.532638145987;2260.367097212783;2262.9773702262933;2263.864168149908;2073.657846455333;2208.6245338292447;2269.636858102704;2284.543091381722;2292.071710957065;2254.0983606557343;2256.1201131558705;2259.3222033389916;2259.412552736292;2261.185973049701;2217.6230040893006;2262.298687406893;2266.92065777697;2270.3642979965634;2272.2047283450906;2253.8196944244423;2264.932696310686;2284.280451657739;2284.862908225512;2285.462916214688;8056.919430805676;8140.267375936194;8191.221833925768;8195.754127376129;8220.547869867154;4944.8763780905765;5109.846704598868;5109.897802043938;5110.616703747197;5112.488751124895;3306.437905556061;3332.8333583320737;3391.5082313064468;3402.659734026602;3435.381631306364;991.8214721350154;1041.9895801041969;1072.860528131338;1074.2802322443981;1085.1698450685233;10558.472076396149;10568.365898046142;10596.62911798091;10617.628383006559;10634.255602107856;4189.2459357315365;4445.955540444619;4533.778448560248;4549.408576884984;4577.771111444415;9030.86453703195;9196.172344489029;9199.678011269574;9203.079692030877;9205.723828285161;5084.33903592538;5093.643444958817;5093.796248150033;5095.923561146586;5096.464871188546;4540.8637740867825;4651.186042442559;4675.906481870412;4682;4702.529747025338;3035.8633861476287;3201.0076876167996;3687.502187204747;3730.477733117366;3788.9242215156096;1235.6540168752583;1237.696764292754;1240.951396070319;1255;1255.767682978652;737.4727070144764;757.2768006553728;760.8326168242978;763.1262204775501;834.6244190114352;5032.169692000779;5075.949240507622;5131.486851314913;5213.739313034409;5259.184826351921;345.9775114617542;424.56482105841144;429.74000729558793;430.22774120453863;434.5458995349804;3109.191610181369;3443.6039855416448;3448.5689288838894;3524.6827785499427;3541.8229088545986;9385.15533601979;9688.806223875483;9818.361806482555;9845.409275443497;9849.162821160282;9824.557894894748;9827.11555959967;9846.803063938825;9854.944967060233;9874.308798384043;7320.048393708784;7518.661660225303;7535.321821036024;7667.309942105126;7671.964284821589;5127.820526281562;5179.45615710345;5180.637355385237;5205.765740541609;5261.079311120462;8963.05887881763;9027.052159523155;9075.455472671661;9123.726288211365;9239.538023098952;9127;9193.908060919573;9245.121713437213;9324.440533568008;9332.486713230837;6404.711787969646;6625.4699624029;6632.801015969529;6752.3922846944015;6918.757843475454;6602.382416308035;7626.466147369631;7649.388048956182;7703.807404814925;7728.497647652885;6943.79168624942;7001.824954376181;7028.578285302899;7066.116735408074;7149.463790215651;6762.357576030269;6896.310368963063;6899.689513971783;6925.238223795479;6963.61700106499;6398.48812095022;6545.083688283549;6545.443637290884;6567.605943643397;6576.868462630625;4421.646268298593;4471;4487.68586198976;4525.50219475864;4592.517785632461;4451.577100175478;4520.4575450946095;4560.429946256718;4564.350555697002;4619.35329053926 19:19:12 INFO - PROCESS | 1645 | |4;prototype.html;278.14609149909785;299.7437191201523;301.6952877593631;305.1684160662196;314.7497739297257;4196.916061678772;5136;5206.817761378353;5281.86795330116;5316.069687804638;5134.948650513494;5153.56194723449;5231.2153177023465;5247.842564723055;5259.289995850559;3717.925641487169;3826.712996525258;3871.845126194949;3893.396523538842;4027.41602467642;3297.653746356634;3915.39311406731;3956.76259424434;3989.40158976153;3994.181192855472;3725.2921944830396;3839.7712731925794;3881.3789793633023;3904.414337849317;3959;3315.552400425936;3568.839402226893;3664.4320130379833;3924.6075392460525;3961.1681546875193;2972.2717934106067;3154.8895788647287;3395.1851555626718;3399.099238701746;3414.931701365984;4398.668705586045;4920.73646122784;4969.652124351297;5006.399232092136;5040.823571175028;4065.26825171469;4118.299889018874;4467.396901418299;4472.105578884236;4513.593776560093;4844;5023.648344615878;5105.6214821997855;5230.424653288135;5282.385219316463;3428.468587368962;3697.556293244828;3707.703383729322;3719.367707489733;3720.530390495766;4570.948681803204;4918;5216.660917040418;5717.914231286534;5723.971380143114;3071.0652289057753;3637.2543628556614;3782.5460944686815;3791.279656865187;3825.2349530093534;3785.7853155903554;3786.2995345861104;3790.8673196438544;3792.1846802937503;3820;4389.604935555752;4418.823247070145;4419.42547468827;4430.291153415438;4430.645548356124;5140.357455318085;5272.815451459181;5345.102488616563;5349.539211962541;5405.945940540623;1131.5304148778164;1219.8353222315052;1220.7304403420344;1235.5552001279532;1241.7019915220283;727.9199288078307;751.9699212031567;794.9761507154794;810.4893916832358;847.4703310430981;4874.512548745097;4989.176785830297;4999.825006124768;5000.924986125211;5109.616778741609;4962;5514.338279406416;5532.834014979557;5604.887902242014;5608.85977850557;4064.4919385076864;5058.9376230991165;5065.569426598707;5088.440271570124;5114.71869047206;2255.391044417998;2665.267051560836;2719.5722245821103;2783.554631258989;2786.8327900326044;4841.1285968526;5019.791291831582;5208.8437346879655;5438.824470211868;5439.3200849893765;5064.594832413398;5129.922716229559;5223.362202087921;5272.393674727378;5664.207011018379;5433.7554810034435;5465.508104270555;5800.796972105956;5809.721861190531;5923.7926672566255;4898.020395920901;5232;5578.804741834017;5710.543811328084;5738.237263071724;4713.552212539803;4755.952440475689;5179.430262671179;5382.650127741685;5514.2004409359615;5042.747862606929;5281.762320695655;5312.9734351328;5506.669599824023;5788.334341550775;3252.70725634694;3739.495168152265;3799.7910114943943;3807.6573108420375;3833.2525157594;5209.47905209476;5619.639751304544;5670.489655930986;5672.801451949162;5677.943220567741;4437.068215674615;4978.850634480971;5519.586031047607;5552.7778888843995;5561.4716601922755;4553.635709143195;4819;5313.2561441397465;5504.559635229252;5530.972345138249;4553.838771113345;4707.105649926503;5377.606964900738;5386.5152136307925;5463.72681365938;4945.703257804544;5121.411037730709;5271.499207575274;5383.461653834585;5539.91971565557;4701.918558731442;5206.791728330824;5209.479052094912;5274.89450210986;5304.867378315573 19:19:12 INFO - PROCESS | 1645 | |5;yui.html;684.808253688967;705.421554325453;711.7081996381485;740.400275776621;824.0976131136406;13790.793138102925;14365.784513232284;14503.984721069517;14725.852741472581;14855.851441485582;13425.261610611413;13507.662308442294;13605.591832245049;13610.591682249524;13612.183269003866;812.5287333346645;829.9294559962381;831.733845169546;831.8502669519484;834.0366876257901;656.1961597043631;681.5229339462371;687.7386593094617;805.4925396999882;826.1696994520498;866.5970323799432;880.6785523284019;881.1056777370974;882.9977974998391;884.6461415433813;872.7425409504211;873.0222151190644;873.1792115411556;873.2620935309685;875.4528419737663;509.35566508366946;524.7586110389226;525.1046964924832;647.8445173158456;648.2965981909633;11698;11747.7063073423;13507.66230844227;14049.578512644637;14062.789058164135;13480.865191348157;13651.38568764408;13896.722065558733;13909.79135312971;13934.930325348309;11021.173411994052;11096.00135987757;11103.666889993232;11140.832887506695;11422.828657570142;3586.7309951753723;3639.4176931690804;3673.3571624965525;3717.498137751396;3774.1696826698358;83647.3270534592;84016;84100;84470.57764711136;88821;10336.17310615149;10491.318064325795;10494.317869338469;10495.527701253463;11029.007389334998;20999.475013124793;21232.681509777365;21237.893810530848;21373.145074197168;21420.250291239732;7401.185869554345;7417.851642967111;7509.286617771303;7605.225251090235;7660.885086723703;4121.464209652786;4196.244675958357;4298.20483210607;4309.59058889405;4323.546027667113;3286.6713328666942;3335.7498187636024;3345.7657963942293;3379.1889946412684;3393.5418718473184;547.5838362844268;632.4655665962255;634.4226753654152;643.4562794438692;647.0714524657133;593.2999061107848;595.8440625187123;596.9015112506388;639.8144538083997;650.4373716735084;8686.78283042929;8896.822063558693;8969.50667713269;9036.8644470333;9173.633054677872;624.6127401011311;634.3656343656344;635.7584118035116;665.1486097794831;672.3108813466237;3816.961830381716;4007.8196481158416;4275.700700950966;4390.319500477431;4461.866144015685;74229.5154096915;76184.23815761882;87094.69357959635;94219.52890235643;123307;95943;105386;106488;108488.45755771328;108650;88331.55834220916;92434.14309783609;92490;93759.53120234492;94918.52540737252;8373.49759014461;8422.326213902996;8472.66109355619;8643.697470588499;8761.956190219009;49968.50031499638;57837.84324313574;58643.99999999829;59498;61218.38781612127;68454;73645.52708945898;74354.25645743473;76179.61910190413;78380.60809695916;10239.641612543524;11897.762044758883;12071.215371000857;12131.332776697014;12466.065045121471;13764.17414955106;13783.586492404842;13818.309084545934;13905.791413128609;13912.373943172379;12736.490540378281;12936;12979.480820767063;13074.607761767162;13107.672308192372;10692;12588.811167832673;12699.42852571655;13195.291107868761;13283.203007819562;12405;12910.289934053717;13314.267715275753;13372.665683357995;13457;10600.027871234945;10635.8936410638;11039.668809935714;11226.775464490827;11619;10531.473426328499;10631.840522392016;10731.356118632906;10793.784124317626;10943.507542160782 19:19:12 INFO - PROCESS | 1645 | __end_tp_report 19:19:12 INFO - PROCESS | 1645 | __start_cc_report 19:19:12 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1479 19:19:12 INFO - PROCESS | 1645 | __end_cc_report 19:19:12 INFO - PROCESS | 1645 | __startTimestamp1480216752126__endTimestamp 19:19:12 INFO - PROCESS | 1645 | 19:19:12 INFO - PROCESS | 1645 | ------- Summary: start ------- 19:19:12 INFO - PROCESS | 1645 | Number of tests: 6 19:19:12 INFO - PROCESS | 1645 | 19:19:12 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5610.56 Median:5785.88 stddev:637.39 (11.0%) stddev-sans-first:607.47 19:19:12 INFO - PROCESS | 1645 | Values: 3073.4 3334.6 3339.6 3372.4 3387.5 5481.0 5530.2 5547.8 5636.8 5653.7 5462.3 5542.8 5571.6 5577.7 5579.0 5065.8 5071.3 5082.3 5117.1 5157.6 5117.5 5178.2 5185.1 5192.4 5194.3 5097.0 5115.9 5120.1 5131.0 5173.0 4315.1 4506.8 4977.7 5151.6 5179.0 5001.5 5004.5 5057.5 5096.0 5146.4 5512.4 5547.0 5588.4 5589.9 5620.5 6143.5 6163.0 6165.4 6166.4 6166.5 5785.9 5823.2 6035.7 6215.7 6219.6 5495.9 5550.5 5581.6 5610.2 5674.1 6199.5 6209.5 6216.2 6222.8 6234.0 5805.9 5910.1 5926.4 5927.9 5934.3 5983.7 6025.4 6069.4 6070.3 6137.4 6038.4 6053.9 6054.3 6065.8 6075.9 6034.5 6104.5 6109.8 6156.4 6163.4 4838.1 4894.3 4899.4 4925.9 4929.2 4309.9 4392.5 4412.4 4441.2 4447.0 4690.9 5576.0 5629.5 5652.7 5663.2 6185.3 6191.4 6197.1 6207.8 6209.1 5658.6 5663.7 5684.6 5687.7 5705.2 5218.5 5274.9 5293.6 5330.2 5345.5 6187.7 6224.2 6278.1 6279.1 6303.7 6183.8 6192.5 6193.5 6219.5 6225.1 5328.9 6101.5 6244.0 6251.6 6258.8 5853.0 5899.4 5976.2 6093.6 6095.1 4983.4 6141.2 6170.8 6173.6 6209.3 5974.3 5989.8 6001.5 6002.5 6016.1 5626.4 5763.9 5816.1 5978.9 5983.9 5719.1 5785.3 5815.3 5860.2 5905.3 5959.6 5985.4 6008.9 6016.0 6029.0 5658.3 5809.3 5813.5 5815.2 5875.0 19:19:12 INFO - PROCESS | 1645 | 19:19:12 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:65140.19 Median:3560.62 stddev:144564.38 (4060.1%) stddev-sans-first:144888.37 19:19:12 INFO - PROCESS | 1645 | Values: 468.9 499.8 508.7 521.3 522.3 23593.3 38864.6 39776.4 39962.2 42196.4 40772.8 41098.0 41157.2 41198.2 41253.0 9263.4 9453.5 9458.9 9467.3 9486.4 8450.6 8673.9 11088.2 11331.0 11341.5 11174.3 11223.6 11225.5 11243.6 11282.4 11258.2 11323.0 11323.9 11326.4 11332.4 6882.9 7651.7 8865.9 10878.1 11192.9 31916.8 39350.6 39438.0 39445.0 39497.6 3211.5 3316.4 3318.1 3527.2 3594.0 28847.7 29543.6 30321.8 30366.7 30407.9 3162.8 3164.7 3218.4 3303.6 3315.1 330142.0 335468.0 337571.0 339013.0 340220.0 57045.0 57418.0 57433.6 57444.1 57460.7 59061.5 59231.1 59243.4 59260.1 59278.4 15115.4 15379.9 15391.3 15399.7 15399.9 10359.0 11797.4 11894.8 11896.2 11925.6 14117.9 14475.2 15755.8 15996.0 16225.2 6649.2 6731.8 6756.3 6791.7 6835.8 827.8 866.3 912.8 931.9 950.0 24911.6 28890.6 29125.4 29327.6 29477.9 1011.2 1011.3 1011.4 1016.4 1170.1 12918.9 12930.8 14929.2 15236.6 15430.6 627693.0 630711.0 630920.0 631485.0 866806.0 46411.5 54605.0 55887.7 56240.9 58929.7 1317.5 1332.5 1355.2 1357.2 1358.5 29341.9 29490.9 29838.0 30229.2 30440.4 41112.0 55230.7 55360.4 57458.7 57543.4 532952.0 538495.0 539773.0 540301.8 540929.0 24922.8 25218.5 25305.6 25315.2 25326.2 44652.0 44889.8 44951.6 45257.5 45794.8 37184.0 37283.3 38236.4 38502.8 38591.2 36769.3 37145.6 37354.8 37537.6 37756.6 36098.1 36412.0 37097.6 37115.3 37396.9 30728.8 31844.7 33497.5 33633.2 33784.8 21667.8 24572.5 24632.1 24688.4 25229.6 19:19:12 INFO - PROCESS | 1645 | 19:19:12 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:32865.59 Median:375.58 stddev:97347.94 (25919.3%) stddev-sans-first:97590.42 19:19:12 INFO - PROCESS | 1645 | Values: 351.6 369.2 371.3 379.9 396.2 11371.4 14487.6 15285.5 18017.8 19456.7 15250.7 18371.4 19255.0 19484.3 19515.7 5335.8 5684.3 5685.3 5687.1 5692.7 4682.5 5391.6 5494.8 5656.7 5745.5 5759.5 5760.3 5762.4 5765.9 5766.6 5530.5 5722.9 5779.4 5783.3 5787.0 4677.8 5575.6 5576.5 5578.4 5583.6 12211.0 12344.4 12531.2 12672.7 12688.0 2115.3 2119.0 2256.5 2296.3 2705.7 9342.4 9739.2 9801.3 10022.7 10109.8 1816.4 1820.3 1849.5 1885.4 1891.3 90201.0 106359.0 111023.4 114842.4 114902.0 10605.5 10792.9 10894.5 11049.9 11135.4 13667.5 13676.5 13682.0 13909.6 13974.7 7044.4 7261.4 7919.0 8042.3 8065.0 7723.2 7736.2 7741.8 7894.7 7904.7 3640.4 4197.0 4218.5 4278.4 4533.0 1378.3 1684.6 1774.0 1849.2 1896.5 840.3 884.2 891.7 955.0 969.6 17848.9 17993.9 19396.5 19403.9 19679.9 739.0 882.8 925.0 929.7 932.4 9644.4 9656.2 9977.5 10201.2 10216.2 576617.0 577785.0 586122.0 590359.0 592382.0 114053.0 117763.4 119411.2 122055.0 124361.4 939.4 954.9 955.3 959.2 960.8 15640.5 16779.0 16790.6 17212.7 17384.2 43464.0 43592.3 47792.5 49105.0 52503.0 70504.3 71612.0 72062.4 72760.5 73984.0 7409.9 7693.4 7741.9 7746.5 8022.4 10162.5 11854.0 12086.6 12091.8 12200.1 10332.9 10396.0 10600.3 10639.4 10792.0 10369.8 10414.5 10502.4 10614.9 10684.7 10349.2 10399.8 10819.9 10827.1 10896.9 6679.0 7570.3 7705.5 7788.8 7953.0 9061.0 10285.6 10419.6 10605.7 10706.6 19:19:12 INFO - PROCESS | 1645 | 19:19:12 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5248.22 Median:5096.19 stddev:2930.15 (57.5%) stddev-sans-first:2923.48 19:19:12 INFO - PROCESS | 1645 | Values: 1318.1 1339.2 1450.2 1590.4 1827.9 7237.9 7653.3 7766.2 8077.3 8109.9 8034.6 8100.2 8107.9 8113.6 8121.5 1953.7 2225.5 2260.4 2263.0 2263.9 2073.7 2208.6 2269.6 2284.5 2292.1 2254.1 2256.1 2259.3 2259.4 2261.2 2217.6 2262.3 2266.9 2270.4 2272.2 2253.8 2264.9 2284.3 2284.9 2285.5 8056.9 8140.3 8191.2 8195.8 8220.5 4944.9 5109.8 5109.9 5110.6 5112.5 3306.4 3332.8 3391.5 3402.7 3435.4 991.8 1042.0 1072.9 1074.3 1085.2 10558.5 10568.4 10596.6 10617.6 10634.3 4189.2 4446.0 4533.8 4549.4 4577.8 9030.9 9196.2 9199.7 9203.1 9205.7 5084.3 5093.6 5093.8 5095.9 5096.5 4540.9 4651.2 4675.9 4682.0 4702.5 3035.9 3201.0 3687.5 3730.5 3788.9 1235.7 1237.7 1241.0 1255.0 1255.8 737.5 757.3 760.8 763.1 834.6 5032.2 5075.9 5131.5 5213.7 5259.2 346.0 424.6 429.7 430.2 434.5 3109.2 3443.6 3448.6 3524.7 3541.8 9385.2 9688.8 9818.4 9845.4 9849.2 9824.6 9827.1 9846.8 9854.9 9874.3 7320.0 7518.7 7535.3 7667.3 7672.0 5127.8 5179.5 5180.6 5205.8 5261.1 8963.1 9027.1 9075.5 9123.7 9239.5 9127.0 9193.9 9245.1 9324.4 9332.5 6404.7 6625.5 6632.8 6752.4 6918.8 6602.4 7626.5 7649.4 7703.8 7728.5 6943.8 7001.8 7028.6 7066.1 7149.5 6762.4 6896.3 6899.7 6925.2 6963.6 6398.5 6545.1 6545.4 6567.6 6576.9 4421.6 4471.0 4487.7 4525.5 4592.5 4451.6 4520.5 4560.4 4564.4 4619.4 19:19:12 INFO - PROCESS | 1645 | 19:19:12 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4346.99 Median:4974.25 stddev:1344.73 (27.0%) stddev-sans-first:1313.37 19:19:12 INFO - PROCESS | 1645 | Values: 278.1 299.7 301.7 305.2 314.7 4196.9 5136.0 5206.8 5281.9 5316.1 5134.9 5153.6 5231.2 5247.8 5259.3 3717.9 3826.7 3871.8 3893.4 4027.4 3297.7 3915.4 3956.8 3989.4 3994.2 3725.3 3839.8 3881.4 3904.4 3959.0 3315.6 3568.8 3664.4 3924.6 3961.2 2972.3 3154.9 3395.2 3399.1 3414.9 4398.7 4920.7 4969.7 5006.4 5040.8 4065.3 4118.3 4467.4 4472.1 4513.6 4844.0 5023.6 5105.6 5230.4 5282.4 3428.5 3697.6 3707.7 3719.4 3720.5 4570.9 4918.0 5216.7 5717.9 5724.0 3071.1 3637.3 3782.5 3791.3 3825.2 3785.8 3786.3 3790.9 3792.2 3820.0 4389.6 4418.8 4419.4 4430.3 4430.6 5140.4 5272.8 5345.1 5349.5 5405.9 1131.5 1219.8 1220.7 1235.6 1241.7 727.9 752.0 795.0 810.5 847.5 4874.5 4989.2 4999.8 5000.9 5109.6 4962.0 5514.3 5532.8 5604.9 5608.9 4064.5 5058.9 5065.6 5088.4 5114.7 2255.4 2665.3 2719.6 2783.6 2786.8 4841.1 5019.8 5208.8 5438.8 5439.3 5064.6 5129.9 5223.4 5272.4 5664.2 5433.8 5465.5 5800.8 5809.7 5923.8 4898.0 5232.0 5578.8 5710.5 5738.2 4713.6 4756.0 5179.4 5382.7 5514.2 5042.7 5281.8 5313.0 5506.7 5788.3 3252.7 3739.5 3799.8 3807.7 3833.3 5209.5 5619.6 5670.5 5672.8 5677.9 4437.1 4978.9 5519.6 5552.8 5561.5 4553.6 4819.0 5313.3 5504.6 5531.0 4553.8 4707.1 5377.6 5386.5 5463.7 4945.7 5121.4 5271.5 5383.5 5539.9 4701.9 5206.8 5209.5 5274.9 5304.9 19:19:12 INFO - PROCESS | 1645 | 19:19:12 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:20435.31 Median:4303.90 stddev:29892.15 (694.5%) stddev-sans-first:29939.22 19:19:12 INFO - PROCESS | 1645 | Values: 684.8 705.4 711.7 740.4 824.1 13790.8 14365.8 14504.0 14725.9 14855.9 13425.3 13507.7 13605.6 13610.6 13612.2 812.5 829.9 831.7 831.9 834.0 656.2 681.5 687.7 805.5 826.2 866.6 880.7 881.1 883.0 884.6 872.7 873.0 873.2 873.3 875.5 509.4 524.8 525.1 647.8 648.3 11698.0 11747.7 13507.7 14049.6 14062.8 13480.9 13651.4 13896.7 13909.8 13934.9 11021.2 11096.0 11103.7 11140.8 11422.8 3586.7 3639.4 3673.4 3717.5 3774.2 83647.3 84016.0 84100.0 84470.6 88821.0 10336.2 10491.3 10494.3 10495.5 11029.0 20999.5 21232.7 21237.9 21373.1 21420.3 7401.2 7417.9 7509.3 7605.2 7660.9 4121.5 4196.2 4298.2 4309.6 4323.5 3286.7 3335.7 3345.8 3379.2 3393.5 547.6 632.5 634.4 643.5 647.1 593.3 595.8 596.9 639.8 650.4 8686.8 8896.8 8969.5 9036.9 9173.6 624.6 634.4 635.8 665.1 672.3 3817.0 4007.8 4275.7 4390.3 4461.9 74229.5 76184.2 87094.7 94219.5 123307.0 95943.0 105386.0 106488.0 108488.5 108650.0 88331.6 92434.1 92490.0 93759.5 94918.5 8373.5 8422.3 8472.7 8643.7 8762.0 49968.5 57837.8 58644.0 59498.0 61218.4 68454.0 73645.5 74354.3 76179.6 78380.6 10239.6 11897.8 12071.2 12131.3 12466.1 13764.2 13783.6 13818.3 13905.8 13912.4 12736.5 12936.0 12979.5 13074.6 13107.7 10692.0 12588.8 12699.4 13195.3 13283.2 12405.0 12910.3 13314.3 13372.7 13457.0 10600.0 10635.9 11039.7 11226.8 11619.0 10531.5 10631.8 10731.4 10793.8 10943.5 19:19:12 INFO - PROCESS | 1645 | -------- Summary: end -------- 19:19:12 INFO - PROCESS | 1645 | 19:19:12 INFO - TEST-INFO | 1645: exit 0 19:19:12 INFO - TEST-OK | dromaeo_css | took 1120578ms 19:19:12 INFO - TEST-START | kraken 19:19:12 INFO - operating with platform_type : mac_ 19:19:12 INFO - Initialising browser for kraken test... 19:19:12 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/tmpnsQU0n/profile http://localhost:49243/getInfo.html) 19:19:15 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 19:19:15 INFO - PROCESS | 1654 | colorDepth:24 19:19:15 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 19:19:15 INFO - PROCESS | 1654 | __metrics 19:19:15 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:19:15 INFO - PROCESS | 1654 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:19:16 INFO - TEST-INFO | 1654: exit 0 19:19:16 INFO - Browser initialized. 19:19:16 INFO - Running cycle 1/1 for kraken test... 19:19:16 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/tmpnsQU0n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:28 INFO - PROCESS | 1655 | RSS: Main: 244228096 19:19:28 INFO - PROCESS | 1655 | 19:19:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 19:19:32 INFO - PROCESS | 1655 | RSS: Main: 296714240 19:19:32 INFO - PROCESS | 1655 | 19:19:34 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 19:19:35 INFO - PROCESS | 1655 | RSS: Main: 298442752 19:19:35 INFO - PROCESS | 1655 | 19:19:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 19:19:39 INFO - PROCESS | 1655 | RSS: Main: 388718592 19:19:39 INFO - PROCESS | 1655 | 19:19:41 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 19:19:42 INFO - PROCESS | 1655 | RSS: Main: 291811328 19:19:42 INFO - PROCESS | 1655 | 19:19:44 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:19:44 INFO - PROCESS | 1655 | RSS: Main: 293830656 19:19:44 INFO - PROCESS | 1655 | 19:19:47 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 19:19:48 INFO - PROCESS | 1655 | RSS: Main: 334897152 19:19:48 INFO - PROCESS | 1655 | 19:19:51 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 19:19:52 INFO - PROCESS | 1655 | RSS: Main: 338022400 19:19:52 INFO - PROCESS | 1655 | 19:19:54 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 19:19:55 INFO - PROCESS | 1655 | RSS: Main: 334262272 19:19:55 INFO - PROCESS | 1655 | 19:19:56 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:19:57 INFO - PROCESS | 1655 | RSS: Main: 310362112 19:19:57 INFO - PROCESS | 1655 | 19:19:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:20:00 INFO - PROCESS | 1655 | RSS: Main: 313905152 19:20:00 INFO - PROCESS | 1655 | 19:20:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:20:02 INFO - PROCESS | 1655 | RSS: Main: 317165568 19:20:02 INFO - PROCESS | 1655 | 19:20:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:20:06 INFO - PROCESS | 1655 | RSS: Main: 333987840 19:20:06 INFO - PROCESS | 1655 | 19:20:09 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:10 INFO - PROCESS | 1655 | RSS: Main: 328056832 19:20:10 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 19:20:12 INFO - PROCESS | 1655 | RSS: Main: 372375552 19:20:12 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | __start_tp_report 19:20:12 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 19:20:12 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 19:20:12 INFO - PROCESS | 1655 | |i|pagename|runs| 19:20:12 INFO - PROCESS | 1655 | |0;ai-astar;114;114;115;115;115;118;158;167;113;114 19:20:12 INFO - PROCESS | 1655 | |1;audio-beat-detection;142;113;110;147;117;118;118;135;163;144 19:20:12 INFO - PROCESS | 1655 | |2;audio-dft;185;182;183;192;179;182;184;184;181;182 19:20:12 INFO - PROCESS | 1655 | |3;audio-fft;81;59;60;86;60;60;58;59;77;60 19:20:12 INFO - PROCESS | 1655 | |4;audio-oscillator;82;70;86;71;70;92;115;96;56;89 19:20:12 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;89;86;90;87;95;129;90;87;88;86 19:20:12 INFO - PROCESS | 1655 | |6;imaging-darkroom;98;97;97;98;119;110;150;164;97;101 19:20:12 INFO - PROCESS | 1655 | |7;imaging-desaturate;86;87;84;85;84;88;86;85;85;84 19:20:12 INFO - PROCESS | 1655 | |8;json-parse-financial;55;56;57;55;55;55;58;56;57;56 19:20:12 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;65;72;71;74;72;68;70;70;70;71 19:20:12 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;88;88;88;86;89;86;88;87;88;86 19:20:12 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;150;150;149;148;146;146;150;147;196;170 19:20:12 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;176;172;175;175;181;173;172;174;173;174 19:20:12 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;69;70;70;69;68;68;71;69;68;71 19:20:12 INFO - PROCESS | 1655 | __end_tp_report 19:20:12 INFO - PROCESS | 1655 | __start_cc_report 19:20:12 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2137 19:20:12 INFO - PROCESS | 1655 | __end_cc_report 19:20:12 INFO - PROCESS | 1655 | __startTimestamp1480216812312__endTimestamp 19:20:12 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | ------- Summary: start ------- 19:20:12 INFO - PROCESS | 1655 | Number of tests: 14 19:20:12 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:124.30 Median:115.00 stddev:20.29 (17.6%) stddev-sans-first:21.17 19:20:12 INFO - PROCESS | 1655 | Values: 114.0 114.0 115.0 115.0 115.0 118.0 158.0 167.0 113.0 114.0 19:20:12 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:130.70 Median:138.50 stddev:17.90 (12.9%) stddev-sans-first:18.51 19:20:12 INFO - PROCESS | 1655 | Values: 142.0 113.0 110.0 147.0 117.0 118.0 118.0 135.0 163.0 144.0 19:20:12 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:183.40 Median:183.50 stddev:3.47 (1.9%) stddev-sans-first:3.63 19:20:12 INFO - PROCESS | 1655 | Values: 185.0 182.0 183.0 192.0 179.0 182.0 184.0 184.0 181.0 182.0 19:20:12 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.00 stddev:10.81 (18.0%) stddev-sans-first:10.01 19:20:12 INFO - PROCESS | 1655 | Values: 81.0 59.0 60.0 86.0 60.0 60.0 58.0 59.0 77.0 60.0 19:20:12 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:82.70 Median:84.00 stddev:16.77 (20.0%) stddev-sans-first:17.78 19:20:12 INFO - PROCESS | 1655 | Values: 82.0 70.0 86.0 71.0 70.0 92.0 115.0 96.0 56.0 89.0 19:20:12 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:92.70 Median:88.50 stddev:13.03 (14.7%) stddev-sans-first:13.75 19:20:12 INFO - PROCESS | 1655 | Values: 89.0 86.0 90.0 87.0 95.0 129.0 90.0 87.0 88.0 86.0 19:20:12 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:113.10 Median:97.00 stddev:24.44 (25.2%) stddev-sans-first:25.31 19:20:12 INFO - PROCESS | 1655 | Values: 98.0 97.0 97.0 98.0 119.0 110.0 150.0 164.0 97.0 101.0 19:20:12 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:1.35 (1.6%) stddev-sans-first:1.41 19:20:12 INFO - PROCESS | 1655 | Values: 86.0 87.0 84.0 85.0 84.0 88.0 86.0 85.0 85.0 84.0 19:20:12 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.05 (1.9%) stddev-sans-first:1.05 19:20:12 INFO - PROCESS | 1655 | Values: 55.0 56.0 57.0 55.0 55.0 55.0 58.0 56.0 57.0 56.0 19:20:12 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:71.00 stddev:2.45 (3.5%) stddev-sans-first:1.69 19:20:12 INFO - PROCESS | 1655 | Values: 65.0 72.0 71.0 74.0 72.0 68.0 70.0 70.0 70.0 71.0 19:20:12 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:88.00 stddev:1.07 (1.2%) stddev-sans-first:1.12 19:20:12 INFO - PROCESS | 1655 | Values: 88.0 88.0 88.0 86.0 89.0 86.0 88.0 87.0 88.0 86.0 19:20:12 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:155.20 Median:150.00 stddev:15.96 (10.6%) stddev-sans-first:16.81 19:20:12 INFO - PROCESS | 1655 | Values: 150.0 150.0 149.0 148.0 146.0 146.0 150.0 147.0 196.0 170.0 19:20:12 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:174.50 stddev:2.64 (1.5%) stddev-sans-first:2.74 19:20:12 INFO - PROCESS | 1655 | Values: 176.0 172.0 175.0 175.0 181.0 173.0 172.0 174.0 173.0 174.0 19:20:12 INFO - PROCESS | 1655 | 19:20:12 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.16 (1.7%) stddev-sans-first:1.22 19:20:12 INFO - PROCESS | 1655 | Values: 69.0 70.0 70.0 69.0 68.0 68.0 71.0 69.0 68.0 71.0 19:20:12 INFO - PROCESS | 1655 | -------- Summary: end -------- 19:20:12 INFO - PROCESS | 1655 | 19:20:13 INFO - TEST-INFO | 1655: exit 0 19:20:13 INFO - TEST-OK | kraken | took 60737ms 19:20:13 INFO - SUITE-END | took 1181s 19:20:13 INFO - Completed test suite (00:19:41) 19:20:13 INFO - javascript benchmark 19:20:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3073.3545955349373, 3334.649861764514, 3339.5992480902282, 3372.376110419571, 3387.5257463955036, 5481.013417584833, 5530.170474428838, 5547.750351234194, 5636.830895073144, 5653.745581448834, 5462.262594549735, 5542.806001789938, 5571.582131340156, 5577.69322687253, 5578.967890940179, 5065.822696205633, 5071.340725705653, 5082.3138876251605, 5117.078925793356, 5157.6131790115705, 5117.539421452068, 5178.249153872686, 5185.066687996159, 5192.376914770233, 5194.324737784083, 5096.974515127437, 5115.923261151067, 5120.078385890538, 5130.9743451282875, 5172.974135129319, 4315.115401342733, 4506.842260520899, 4977.651564390494, 5151.5878729701535, 5179.0, 5001.474845141244, 5004.474530174352, 5057.49425057495, 5096.031753966771, 5146.3824341078935, 5512.448755124496, 5547.001539722848, 5588.441155884379, 5589.944100558983, 5620.4660557247, 6143.508519318444, 6162.969185154046, 6165.445109940127, 6166.352532984017, 6166.506679465632, 5785.88428231433, 5823.155642431866, 6035.7283922223605, 6215.68921553925, 6219.626822390671, 5495.873345964068, 5550.5282051026115, 5581.553475721932, 5610.242617246701, 5674.1488776683, 6199.473044791243, 6209.534284928648, 6216.160818289473, 6222.751089956351, 6234.0337247726675, 5805.912911306334, 5910.054391297372, 5926.377730338252, 5927.9407205928255, 5934.347221805598, 5983.730732117066, 6025.3974602540275, 6069.393060693896, 6070.332263451017, 6137.41694539018, 6038.365971572922, 6053.939460605337, 6054.334023257438, 6065.787697430657, 6075.878482430327, 6034.456898879122, 6104.4591554472245, 6109.829807539378, 6156.415140561639, 6163.3528479509905, 4838.056578967138, 4894.339264199288, 4899.436564795023, 4925.852224433273, 4929.186684197139, 4309.870703878826, 4392.538783427758, 4412.4043254160915, 4441.20058389493, 4446.9777651111535, 4690.882727931761, 5575.972120139373, 5629.465200805998, 5652.660840349592, 5663.150527420919, 6185.288691800501, 6191.380861913773, 6197.1324014637985, 6207.81376558704, 6209.0996805462955, 5658.575606829504, 5663.66018038919, 5684.6020778545935, 5687.744051517691, 5705.1727499512335, 5218.478152184751, 5274.92087618686, 5293.629445938747, 5330.200469929464, 5345.492178243061, 6187.659678717714, 6224.1597384352535, 6278.0896769967185, 6279.120923070683, 6303.653299068412, 6183.81448556544, 6192.473639740492, 6193.535484838565, 6219.533534984804, 6225.097360882737, 5328.920066198933, 6101.450869421773, 6244.0, 6251.624902505864, 6258.780942666985, 5852.970735146297, 5899.439553242435, 5976.193213916065, 6093.6039157454625, 6095.05526643371, 4983.426905905867, 6141.170941922784, 6170.845728856814, 6173.629582225081, 6209.285932117864, 5974.253218347707, 5989.790357337472, 6001.459868611846, 6002.549808764447, 6016.09758536223, 5626.381098079126, 5763.8559036024435, 5816.069428891357, 5978.940210597838, 5983.940160598512, 5719.056355701263, 5785.27684039495, 5815.302163740378, 5860.208871802252, 5905.261842269716, 5959.642421454727, 5985.40145985398, 6008.909866351921, 6016.007358785751, 6028.969855150696, 5658.292713410824, 5809.2738407699035, 5813.534917206698, 5815.214945982408, 5874.970625147018], "value": 5570.30133077099, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.8780916961589, 499.7726034654233, 508.71511953306145, 521.280632726837, 522.3288074823852, 23593.29220123397, 38864.61135388645, 39776.403353949645, 39962.2007559849, 42196.36705449413, 40772.79613601935, 41098.0, 41157.17685646285, 41198.17603647925, 41253.0, 9263.397879137869, 9453.527323633825, 9458.905410945905, 9467.337286389955, 9486.383385079982, 8450.57747112645, 8673.913260867404, 11088.2238243323, 11331.03686186671, 11341.546338146465, 11174.27367221128, 11223.60717374892, 11225.494852731606, 11243.550257989671, 11282.435878206057, 11258.155638327118, 11323.037541808957, 11323.886761132448, 11326.433678316092, 11332.376719280437, 6882.931170688279, 7651.732189373401, 8865.911340886638, 10878.075363594104, 11192.888071119267, 31916.840415798004, 39350.60649393498, 39438.0, 39445.0, 39497.60502394968, 3211.5022171563446, 3316.436205845012, 3318.1206980150278, 3527.206378564828, 3594.029612004744, 28847.703464947648, 29543.5568466471, 30321.848390758125, 30366.69633303661, 30407.935722249615, 3162.810231386124, 3164.746820254374, 3218.4045951499047, 3303.620083690382, 3315.1049216711353, 330142.0, 335468.0, 337571.0, 339013.0, 340219.97800220276, 57045.0, 57418.0, 57433.564160895476, 57444.13833792497, 57460.71269643625, 59061.45631262138, 59231.111533327035, 59243.407565923786, 59260.11109833356, 59278.40721592729, 15115.395384184729, 15379.923100384427, 15391.307391167424, 15399.692006159814, 15399.92300038515, 10359.0, 11797.410129493663, 11894.82157767634, 11896.16726829131, 11925.642230733092, 14117.858821411859, 14475.203863787592, 15755.763663545056, 15996.04023758555, 16225.188740562924, 6649.235337936103, 6731.831704207336, 6756.290589488131, 6791.728330866808, 6835.760748373783, 827.7640872351351, 866.2809867809702, 912.780932576177, 931.855562387831, 950.0, 24911.62632560513, 28890.566641500394, 29125.41749165047, 29327.560086598718, 29477.852610737238, 1011.1708399112804, 1011.2819897872446, 1011.4437059617181, 1016.4460369098858, 1170.145793570698, 12918.935405323102, 12930.806037909439, 14929.17889516087, 15236.619084522754, 15430.614234644, 627693.0, 630711.0, 630920.0, 631485.0, 866806.0, 46411.535884641395, 54605.0, 55887.720561396934, 56240.87518249612, 58929.70535147383, 1317.4795955597676, 1332.486992507872, 1355.1868878672717, 1357.18568858684, 1358.5041459867077, 29341.853290734263, 29490.85254573799, 29838.0, 30229.244268893453, 30440.41127044974, 41112.0, 55230.72384638212, 55360.44639553714, 57458.71270643787, 57543.42456575548, 532952.0, 538495.0, 539773.0, 540301.7607710973, 540929.0, 24922.750772492043, 25218.495630087662, 25305.62041569341, 25315.240542783748, 25326.240212793644, 44652.0, 44889.77555112204, 44951.62219617333, 45257.547424525335, 45794.771026144655, 37184.0, 37283.254334912606, 38236.42645360266, 38502.80748596239, 38591.228175435775, 36769.26461470809, 37145.628543714214, 37354.846717140375, 37537.624623753414, 37756.62243377641, 36098.111023519734, 36412.0, 37097.6290237105, 37115.25769484649, 37396.87809365724, 30728.846355768972, 31844.68155318417, 33497.49753753744, 33633.15917102092, 33784.831075844464, 21667.783322166575, 24572.50854982926, 24632.13787517428, 24688.382790429663, 25229.621555677048], "value": 19232.7236343889, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.5781062724731, 369.20989083361604, 371.2945403732909, 379.86704653371316, 396.18781497929257, 11371.431428428576, 14487.637809054779, 15285.541433756991, 18017.81982180178, 19456.70814937777, 15250.6949861003, 18371.448856534324, 19255.0, 19484.318048868292, 19515.707264391047, 5335.813246536362, 5684.261046064006, 5685.260916080924, 5687.090065589507, 5692.715364231793, 4682.484926658065, 5391.595630327722, 5494.80768173114, 5656.717164141776, 5745.540356771448, 5759.473739459047, 5760.308762948452, 5762.3949485304065, 5765.913511297334, 5766.625169363999, 5530.5299049581035, 5722.9141562876175, 5779.393163717791, 5783.334916484616, 5787.0, 4677.836275730368, 5575.637583557056, 5576.470235327637, 5578.414266501999, 5583.581231407661, 12211.023118150526, 12344.38278086092, 12531.18547294423, 12672.68318292041, 12688.04839637031, 2115.3442432845713, 2119.035838693391, 2256.4922892349255, 2296.3455415206586, 2705.702372738997, 9342.392744471656, 9739.220862331067, 9801.313908026441, 10022.699319020368, 10109.797804043952, 1816.4459839748872, 1820.2809890093472, 1849.519125027489, 1885.377825317642, 1891.3474851176322, 90201.0, 106359.0, 111023.44488277507, 114842.42578787135, 114902.0, 10605.522751476203, 10792.946035269773, 10894.509747061402, 11049.889501104886, 11135.387553684463, 13667.521636742666, 13676.52132175389, 13682.0, 13909.565825980615, 13974.720505589832, 7044.436445084381, 7261.41908647307, 7919.049714034353, 8042.316403105801, 8065.0, 7723.189065148191, 7736.187700291501, 7741.806454838674, 7894.723684671009, 7904.683812647545, 3640.381135207021, 4196.950762309422, 4218.451601291812, 4278.4010238566625, 4532.977335113369, 1378.2970684950747, 1684.61253911601, 1774.0, 1849.2418108575419, 1896.4689886831434, 840.3361344537869, 884.2218847414234, 891.7159290621485, 954.9952250238705, 969.6340928135468, 17848.91075544614, 17993.910030449762, 19396.450590320303, 19403.90298048529, 19679.90160049219, 738.9912769070288, 882.8455020371409, 924.9537523123817, 929.7164364868645, 932.4032619123766, 9644.39708825851, 9656.179224765974, 9977.45124018186, 10201.183905287558, 10216.233782466345, 576617.0, 577785.0, 586122.0, 590359.0, 592382.0, 114053.0, 117763.41118294524, 119411.2088318676, 122055.0, 124361.37819310845, 939.4081728510994, 954.8710924025306, 955.3360414511986, 959.2086528613921, 960.7805226289024, 15640.530784076042, 16779.0, 16790.58023549421, 17212.741808872626, 17384.15217738062, 43464.0, 43592.34611480767, 47792.522074778804, 49105.0, 52503.0, 70504.29495704977, 71612.0, 72062.42789449291, 72760.54478910498, 73984.0, 7409.925900740924, 7693.422993275415, 7741.883871741816, 7746.49647772893, 8022.398320126131, 10162.54268557902, 11854.0, 12086.576969806014, 12091.81862272049, 12200.14598978063, 10332.896671033193, 10396.0, 10600.25798194119, 10639.414832184304, 10792.003479356345, 10369.792604148026, 10414.47927603632, 10502.4223667699, 10614.946925265323, 10684.732881678021, 10349.172066234532, 10399.792004160026, 10819.891801082204, 10827.079698225423, 10896.891031089588, 6678.966605166943, 7570.318671319607, 7705.499142555716, 7788.766337009899, 7953.0, 9060.95469522648, 10285.640002600172, 10419.583216671248, 10605.734856628646, 10706.625268115578], "value": 8797.674460107426, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.1234479071418, 1339.189790176943, 1450.1734011613382, 1590.3956496531316, 1827.926882924683, 7237.878128890024, 7653.272939070786, 7766.184550622188, 8077.313428358597, 8109.918900811005, 8034.558099304536, 8100.230478104585, 8107.878381824277, 8113.63488643011, 8121.472104313216, 1953.716711076893, 2225.532638145987, 2260.367097212783, 2262.9773702262933, 2263.864168149908, 2073.657846455333, 2208.6245338292447, 2269.636858102704, 2284.543091381722, 2292.071710957065, 2254.0983606557343, 2256.1201131558705, 2259.3222033389916, 2259.412552736292, 2261.185973049701, 2217.6230040893006, 2262.298687406893, 2266.92065777697, 2270.3642979965634, 2272.2047283450906, 2253.8196944244423, 2264.932696310686, 2284.280451657739, 2284.862908225512, 2285.462916214688, 8056.919430805676, 8140.267375936194, 8191.221833925768, 8195.754127376129, 8220.547869867154, 4944.8763780905765, 5109.846704598868, 5109.897802043938, 5110.616703747197, 5112.488751124895, 3306.437905556061, 3332.8333583320737, 3391.5082313064468, 3402.659734026602, 3435.381631306364, 991.8214721350154, 1041.9895801041969, 1072.860528131338, 1074.2802322443981, 1085.1698450685233, 10558.472076396149, 10568.365898046142, 10596.62911798091, 10617.628383006559, 10634.255602107856, 4189.2459357315365, 4445.955540444619, 4533.778448560248, 4549.408576884984, 4577.771111444415, 9030.86453703195, 9196.172344489029, 9199.678011269574, 9203.079692030877, 9205.723828285161, 5084.33903592538, 5093.643444958817, 5093.796248150033, 5095.923561146586, 5096.464871188546, 4540.8637740867825, 4651.186042442559, 4675.906481870412, 4682.0, 4702.529747025338, 3035.8633861476287, 3201.0076876167996, 3687.502187204747, 3730.477733117366, 3788.9242215156096, 1235.6540168752583, 1237.696764292754, 1240.951396070319, 1255.0, 1255.767682978652, 737.4727070144764, 757.2768006553728, 760.8326168242978, 763.1262204775501, 834.6244190114352, 5032.169692000779, 5075.949240507622, 5131.486851314913, 5213.739313034409, 5259.184826351921, 345.9775114617542, 424.56482105841144, 429.74000729558793, 430.22774120453863, 434.5458995349804, 3109.191610181369, 3443.6039855416448, 3448.5689288838894, 3524.6827785499427, 3541.8229088545986, 9385.15533601979, 9688.806223875483, 9818.361806482555, 9845.409275443497, 9849.162821160282, 9824.557894894748, 9827.11555959967, 9846.803063938825, 9854.944967060233, 9874.308798384043, 7320.048393708784, 7518.661660225303, 7535.321821036024, 7667.309942105126, 7671.964284821589, 5127.820526281562, 5179.45615710345, 5180.637355385237, 5205.765740541609, 5261.079311120462, 8963.05887881763, 9027.052159523155, 9075.455472671661, 9123.726288211365, 9239.538023098952, 9127.0, 9193.908060919573, 9245.121713437213, 9324.440533568008, 9332.486713230837, 6404.711787969646, 6625.4699624029, 6632.801015969529, 6752.3922846944015, 6918.757843475454, 6602.382416308035, 7626.466147369631, 7649.388048956182, 7703.807404814925, 7728.497647652885, 6943.79168624942, 7001.824954376181, 7028.578285302899, 7066.116735408074, 7149.463790215651, 6762.357576030269, 6896.310368963063, 6899.689513971783, 6925.238223795479, 6963.61700106499, 6398.48812095022, 6545.083688283549, 6545.443637290884, 6567.605943643397, 6576.868462630625, 4421.646268298593, 4471.0, 4487.68586198976, 4525.50219475864, 4592.517785632461, 4451.577100175478, 4520.4575450946095, 4560.429946256718, 4564.350555697002, 4619.35329053926], "value": 4163.49546302629, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.14609149909785, 299.7437191201523, 301.6952877593631, 305.1684160662196, 314.7497739297257, 4196.916061678772, 5136.0, 5206.817761378353, 5281.86795330116, 5316.069687804638, 5134.948650513494, 5153.56194723449, 5231.2153177023465, 5247.842564723055, 5259.289995850559, 3717.925641487169, 3826.712996525258, 3871.845126194949, 3893.396523538842, 4027.41602467642, 3297.653746356634, 3915.39311406731, 3956.76259424434, 3989.40158976153, 3994.181192855472, 3725.2921944830396, 3839.7712731925794, 3881.3789793633023, 3904.414337849317, 3959.0, 3315.552400425936, 3568.839402226893, 3664.4320130379833, 3924.6075392460525, 3961.1681546875193, 2972.2717934106067, 3154.8895788647287, 3395.1851555626718, 3399.099238701746, 3414.931701365984, 4398.668705586045, 4920.73646122784, 4969.652124351297, 5006.399232092136, 5040.823571175028, 4065.26825171469, 4118.299889018874, 4467.396901418299, 4472.105578884236, 4513.593776560093, 4844.0, 5023.648344615878, 5105.6214821997855, 5230.424653288135, 5282.385219316463, 3428.468587368962, 3697.556293244828, 3707.703383729322, 3719.367707489733, 3720.530390495766, 4570.948681803204, 4918.0, 5216.660917040418, 5717.914231286534, 5723.971380143114, 3071.0652289057753, 3637.2543628556614, 3782.5460944686815, 3791.279656865187, 3825.2349530093534, 3785.7853155903554, 3786.2995345861104, 3790.8673196438544, 3792.1846802937503, 3820.0, 4389.604935555752, 4418.823247070145, 4419.42547468827, 4430.291153415438, 4430.645548356124, 5140.357455318085, 5272.815451459181, 5345.102488616563, 5349.539211962541, 5405.945940540623, 1131.5304148778164, 1219.8353222315052, 1220.7304403420344, 1235.5552001279532, 1241.7019915220283, 727.9199288078307, 751.9699212031567, 794.9761507154794, 810.4893916832358, 847.4703310430981, 4874.512548745097, 4989.176785830297, 4999.825006124768, 5000.924986125211, 5109.616778741609, 4962.0, 5514.338279406416, 5532.834014979557, 5604.887902242014, 5608.85977850557, 4064.4919385076864, 5058.9376230991165, 5065.569426598707, 5088.440271570124, 5114.71869047206, 2255.391044417998, 2665.267051560836, 2719.5722245821103, 2783.554631258989, 2786.8327900326044, 4841.1285968526, 5019.791291831582, 5208.8437346879655, 5438.824470211868, 5439.3200849893765, 5064.594832413398, 5129.922716229559, 5223.362202087921, 5272.393674727378, 5664.207011018379, 5433.7554810034435, 5465.508104270555, 5800.796972105956, 5809.721861190531, 5923.7926672566255, 4898.020395920901, 5232.0, 5578.804741834017, 5710.543811328084, 5738.237263071724, 4713.552212539803, 4755.952440475689, 5179.430262671179, 5382.650127741685, 5514.2004409359615, 5042.747862606929, 5281.762320695655, 5312.9734351328, 5506.669599824023, 5788.334341550775, 3252.70725634694, 3739.495168152265, 3799.7910114943943, 3807.6573108420375, 3833.2525157594, 5209.47905209476, 5619.639751304544, 5670.489655930986, 5672.801451949162, 5677.943220567741, 4437.068215674615, 4978.850634480971, 5519.586031047607, 5552.7778888843995, 5561.4716601922755, 4553.635709143195, 4819.0, 5313.2561441397465, 5504.559635229252, 5530.972345138249, 4553.838771113345, 4707.105649926503, 5377.606964900738, 5386.5152136307925, 5463.72681365938, 4945.703257804544, 5121.411037730709, 5271.499207575274, 5383.461653834585, 5539.91971565557, 4701.918558731442, 5206.791728330824, 5209.479052094912, 5274.89450210986, 5304.867378315573], "value": 3911.3069118863023, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.808253688967, 705.421554325453, 711.7081996381485, 740.400275776621, 824.0976131136406, 13790.793138102925, 14365.784513232284, 14503.984721069517, 14725.852741472581, 14855.851441485582, 13425.261610611413, 13507.662308442294, 13605.591832245049, 13610.591682249524, 13612.183269003866, 812.5287333346645, 829.9294559962381, 831.733845169546, 831.8502669519484, 834.0366876257901, 656.1961597043631, 681.5229339462371, 687.7386593094617, 805.4925396999882, 826.1696994520498, 866.5970323799432, 880.6785523284019, 881.1056777370974, 882.9977974998391, 884.6461415433813, 872.7425409504211, 873.0222151190644, 873.1792115411556, 873.2620935309685, 875.4528419737663, 509.35566508366946, 524.7586110389226, 525.1046964924832, 647.8445173158456, 648.2965981909633, 11698.0, 11747.7063073423, 13507.66230844227, 14049.578512644637, 14062.789058164135, 13480.865191348157, 13651.38568764408, 13896.722065558733, 13909.79135312971, 13934.930325348309, 11021.173411994052, 11096.00135987757, 11103.666889993232, 11140.832887506695, 11422.828657570142, 3586.7309951753723, 3639.4176931690804, 3673.3571624965525, 3717.498137751396, 3774.1696826698358, 83647.3270534592, 84016.0, 84100.0, 84470.57764711136, 88821.0, 10336.17310615149, 10491.318064325795, 10494.317869338469, 10495.527701253463, 11029.007389334998, 20999.475013124793, 21232.681509777365, 21237.893810530848, 21373.145074197168, 21420.250291239732, 7401.185869554345, 7417.851642967111, 7509.286617771303, 7605.225251090235, 7660.885086723703, 4121.464209652786, 4196.244675958357, 4298.20483210607, 4309.59058889405, 4323.546027667113, 3286.6713328666942, 3335.7498187636024, 3345.7657963942293, 3379.1889946412684, 3393.5418718473184, 547.5838362844268, 632.4655665962255, 634.4226753654152, 643.4562794438692, 647.0714524657133, 593.2999061107848, 595.8440625187123, 596.9015112506388, 639.8144538083997, 650.4373716735084, 8686.78283042929, 8896.822063558693, 8969.50667713269, 9036.8644470333, 9173.633054677872, 624.6127401011311, 634.3656343656344, 635.7584118035116, 665.1486097794831, 672.3108813466237, 3816.961830381716, 4007.8196481158416, 4275.700700950966, 4390.319500477431, 4461.866144015685, 74229.5154096915, 76184.23815761882, 87094.69357959635, 94219.52890235643, 123307.0, 95943.0, 105386.0, 106488.0, 108488.45755771328, 108650.0, 88331.55834220916, 92434.14309783609, 92490.0, 93759.53120234492, 94918.52540737252, 8373.49759014461, 8422.326213902996, 8472.66109355619, 8643.697470588499, 8761.956190219009, 49968.50031499638, 57837.84324313574, 58643.99999999829, 59498.0, 61218.38781612127, 68454.0, 73645.52708945898, 74354.25645743473, 76179.61910190413, 78380.60809695916, 10239.641612543524, 11897.762044758883, 12071.215371000857, 12131.332776697014, 12466.065045121471, 13764.17414955106, 13783.586492404842, 13818.309084545934, 13905.791413128609, 13912.373943172379, 12736.490540378281, 12936.0, 12979.480820767063, 13074.607761767162, 13107.672308192372, 10692.0, 12588.811167832673, 12699.42852571655, 13195.291107868761, 13283.203007819562, 12405.0, 12910.289934053717, 13314.267715275753, 13372.665683357995, 13457.0, 10600.027871234945, 10635.8936410638, 11039.668809935714, 11226.775464490827, 11619.0, 10531.473426328499, 10631.840522392016, 10731.356118632906, 10793.784124317626, 10943.507542160782], "value": 7192.207817481241, "unit": "score"}], "name": "dromaeo_css", "value": 6926.223467239896, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 115.0, 115.0, 118.0, 158.0, 167.0, 113.0, 114.0], "value": 124.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 113.0, 110.0, 147.0, 117.0, 118.0, 118.0, 135.0, 163.0, 144.0], "value": 130.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 183.0, 192.0, 179.0, 182.0, 184.0, 184.0, 181.0, 182.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 86.0, 60.0, 60.0, 58.0, 59.0, 77.0, 60.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 86.0, 71.0, 70.0, 92.0, 115.0, 96.0, 56.0, 89.0], "value": 82.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 87.0, 95.0, 129.0, 90.0, 87.0, 88.0, 86.0], "value": 92.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 97.0, 98.0, 119.0, 110.0, 150.0, 164.0, 97.0, 101.0], "value": 113.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 84.0, 85.0, 84.0, 88.0, 86.0, 85.0, 85.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 55.0, 55.0, 55.0, 58.0, 56.0, 57.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 71.0, 74.0, 72.0, 68.0, 70.0, 70.0, 70.0, 71.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 86.0, 89.0, 86.0, 88.0, 87.0, 88.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 148.0, 146.0, 146.0, 150.0, 147.0, 196.0, 170.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 172.0, 175.0, 175.0, 181.0, 173.0, 172.0, 174.0, 173.0, 174.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 69.0, 68.0, 68.0, 71.0, 69.0, 68.0, 71.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1491.0, "alertThreshold": 2.0}]} 19:20:14 INFO - Return code: 0 19:20:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:20:14 INFO - # TBPL SUCCESS # 19:20:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:20:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:20:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:20:14 INFO - 2016-11-26 19:20:14.117 screenresolution[1659:10239] starting screenresolution argv=screenresolution get 19:20:14 INFO - 2016-11-26 19:20:14.120 screenresolution[1659:10239] Display 0: 1600x1200x32@60 19:20:14 INFO - 2016-11-26 19:20:14.126 screenresolution[1660:10242] starting screenresolution argv=screenresolution list 19:20:14 INFO - Available Modes on Display 0 19:20:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:20:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:20:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:20:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:20:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:20:14 INFO - Intel Iris: 19:20:14 INFO - Chipset Model: Intel Iris 19:20:14 INFO - Type: GPU 19:20:14 INFO - Bus: Built-In 19:20:14 INFO - VRAM (Dynamic, Max): 1536 MB 19:20:14 INFO - Vendor: Intel (0x8086) 19:20:14 INFO - Device ID: 0x0a2e 19:20:14 INFO - Revision ID: 0x0009 19:20:14 INFO - Displays: 19:20:14 INFO - Display: 19:20:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:20:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:20:14 INFO - Display Serial Number: 1600x1200 60 19:20:14 INFO - Main Display: Yes 19:20:14 INFO - Mirror: Off 19:20:14 INFO - Online: Yes 19:20:14 INFO - Rotation: Supported 19:20:14 INFO - Return code: 0 19:20:14 INFO - Running post-action listener: _resource_record_post_action 19:20:14 INFO - [mozharness: 2016-11-27 03:20:14.361711Z] Finished run-tests step (success) 19:20:14 INFO - Running post-run listener: _resource_record_post_run 19:20:14 INFO - Total resource usage - Wall time: 1215s; CPU: 53.0%; Read bytes: 37577728; Write bytes: 694128640; Read time: 240; Write time: 2022 19:20:14 INFO - TinderboxPrint: CPU usage
53.5% 19:20:14 INFO - TinderboxPrint: I/O read bytes / time
37,577,728 / 240 19:20:14 INFO - TinderboxPrint: I/O write bytes / time
694,128,640 / 2,022 19:20:14 INFO - TinderboxPrint: CPU idle
2,262.4 (46.5%) 19:20:14 INFO - TinderboxPrint: CPU system
968.8 (19.9%) 19:20:14 INFO - TinderboxPrint: CPU user
1,630.5 (33.5%) 19:20:14 INFO - TinderboxPrint: Swap in / out
420,888,576 / 0 19:20:14 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 384551424; Write bytes: 385996800; Read time: 28900; Write time: 846 19:20:14 INFO - run-tests - Wall time: 1183s; CPU: 53.0%; Read bytes: 34411520; Write bytes: 306796544; Read time: 215; Write time: 1170 19:20:14 INFO - Running post-run listener: _upload_blobber_files 19:20:14 INFO - Blob upload gear active. 19:20:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:20:14 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 19:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:20:15 INFO - (blobuploader) - INFO - Open directory for files ... 19:20:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:20:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:20:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:16 INFO - (blobuploader) - INFO - Done attempting. 19:20:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:20:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:20:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:17 INFO - (blobuploader) - INFO - Done attempting. 19:20:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:20:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:20:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:19 INFO - (blobuploader) - INFO - Done attempting. 19:20:19 INFO - (blobuploader) - INFO - Iteration through files over. 19:20:19 INFO - Return code: 0 19:20:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:20:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:20:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/926b7092c2b1b55fbbbf9692e1044c1bda9e2ff4882cc0794433c58486e9789a32d89640070eb4ae518c82bb3709bfdd48633aace3377b4f2e8b89b3e4821b5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0902d1c3de41dbc219119198346f45d9b1369b03508280d3d97d6b3d624ce9af33a15be9efb22ad2d12f6480879713ca843183b1f402fb0ce5aab9f18183122f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c880279a7443ab6501f9efce29ffc17b2809687f5c6587f398d13ef7957f6c1a3ce6ffd8aa1d20841776a8f6eadedead55b317fb44f4bab61b147de12603541b"} 19:20:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:20:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:20:19 INFO - Contents: 19:20:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/926b7092c2b1b55fbbbf9692e1044c1bda9e2ff4882cc0794433c58486e9789a32d89640070eb4ae518c82bb3709bfdd48633aace3377b4f2e8b89b3e4821b5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0902d1c3de41dbc219119198346f45d9b1369b03508280d3d97d6b3d624ce9af33a15be9efb22ad2d12f6480879713ca843183b1f402fb0ce5aab9f18183122f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c880279a7443ab6501f9efce29ffc17b2809687f5c6587f398d13ef7957f6c1a3ce6ffd8aa1d20841776a8f6eadedead55b317fb44f4bab61b147de12603541b"} 19:20:19 INFO - Running post-run listener: copy_logs_to_upload_dir 19:20:19 INFO - Copying logs to upload dir... 19:20:19 INFO - mkdir: /builds/slave/test/build/upload/logs 19:20:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.424252 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-26 19:20:19.606912) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 19:20:19.610323) ========= 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.mz058ZFOOc/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.C901fE3sb3/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/926b7092c2b1b55fbbbf9692e1044c1bda9e2ff4882cc0794433c58486e9789a32d89640070eb4ae518c82bb3709bfdd48633aace3377b4f2e8b89b3e4821b5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0902d1c3de41dbc219119198346f45d9b1369b03508280d3d97d6b3d624ce9af33a15be9efb22ad2d12f6480879713ca843183b1f402fb0ce5aab9f18183122f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c880279a7443ab6501f9efce29ffc17b2809687f5c6587f398d13ef7957f6c1a3ce6ffd8aa1d20841776a8f6eadedead55b317fb44f4bab61b147de12603541b"} build_url:https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010959 build_url: 'https://queue.taskcluster.net/v1/task/W2Dyq8M2QTmb-h7Rii_DMQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/926b7092c2b1b55fbbbf9692e1044c1bda9e2ff4882cc0794433c58486e9789a32d89640070eb4ae518c82bb3709bfdd48633aace3377b4f2e8b89b3e4821b5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0902d1c3de41dbc219119198346f45d9b1369b03508280d3d97d6b3d624ce9af33a15be9efb22ad2d12f6480879713ca843183b1f402fb0ce5aab9f18183122f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c880279a7443ab6501f9efce29ffc17b2809687f5c6587f398d13ef7957f6c1a3ce6ffd8aa1d20841776a8f6eadedead55b317fb44f4bab61b147de12603541b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 19:20:19.647149) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 19:20:19.647440) ========= 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.mz058ZFOOc/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.C901fE3sb3/Listeners TMPDIR=/var/folders/h8/xgp20z9j4yg2ltsjq_3yvg_000000w/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.004903 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 19:20:19.695352) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 19:20:19.695625) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 19:20:19.695907) ========= ========= Total master_lag: 0.18 =========