builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0149 starttime: 1477435259.37 results: success (0) buildid: 20161025133924 builduid: 20c65cc1c7174e32992599da32a4b0d0 revision: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 15:40:59.372128) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 15:40:59.372594) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 15:40:59.372873) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 15:40:59.393350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 15:40:59.393705) ========= 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.Su7LIoRtcu/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.3ytK1Ofopv/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-25 15:40:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.13M=0.001s 2016-10-25 15:41:00 (8.13 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.603442 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 15:41:00.020069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 15:41:00.020410) ========= 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.Su7LIoRtcu/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.3ytK1Ofopv/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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.020629 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 15:41:00.072798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 15:41:00.073224) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 --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 b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Su7LIoRtcu/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.3ytK1Ofopv/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-25 15:41:00,149 truncating revision to first 12 chars 2016-10-25 15:41:00,149 Setting DEBUG logging. 2016-10-25 15:41:00,149 attempt 1/10 2016-10-25 15:41:00,149 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b1b18f25c0ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 15:41:01,416 unpacking tar archive at: mozilla-central-b1b18f25c0ea/testing/mozharness/ program finished with exit code 0 elapsedTime=1.530205 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 15:41:01.625639) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 15:41:01.626006) ========= script_repo_revision: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 15:41:01.626425) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 15:41:01.626709) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 15:41:01.646441) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-25 15:41:01.646851) ========= /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.Su7LIoRtcu/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.3ytK1Ofopv/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 15:41:01 INFO - MultiFileLogger online at 20161025 15:41:01 in /builds/slave/test 15:41:01 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 15:41:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:41:01 INFO - {'append_to_log': False, 15:41:01 INFO - 'base_work_dir': '/builds/slave/test', 15:41:01 INFO - 'blob_upload_branch': 'Firefox', 15:41:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:41:01 INFO - 'branch': 'Firefox', 15:41:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:41:01 INFO - 'config_files': ('talos/mac_config.py',), 15:41:01 INFO - 'default_actions': ('clobber', 15:41:01 INFO - 'read-buildbot-config', 15:41:01 INFO - 'download-and-extract', 15:41:01 INFO - 'populate-webroot', 15:41:01 INFO - 'create-virtualenv', 15:41:01 INFO - 'install', 15:41:01 INFO - 'run-tests'), 15:41:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:41:01 INFO - 'download_minidump_stackwalk': True, 15:41:01 INFO - 'download_symbols': 'ondemand', 15:41:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:41:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:41:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:41:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:41:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:41:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:41:01 INFO - 'installer_path': 'installer.exe', 15:41:01 INFO - 'log_level': 'info', 15:41:01 INFO - 'log_name': 'talos', 15:41:01 INFO - 'log_to_console': True, 15:41:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:41:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:41:01 INFO - 'opt_config_files': (), 15:41:01 INFO - 'pip_index': False, 15:41:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:41:01 INFO - 'cmd': ('bash', 15:41:01 INFO - '-c', 15:41:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:41:01 INFO - 'enabled': True, 15:41:01 INFO - 'halt_on_failure': False, 15:41:01 INFO - 'name': 'check_screen_resolution'},), 15:41:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:41:01 INFO - 'cmd': ('bash', 15:41:01 INFO - '-c', 15:41:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:41:01 INFO - 'enabled': True, 15:41:01 INFO - 'halt_on_failure': False, 15:41:01 INFO - 'name': 'check_screen_resolution'},), 15:41:01 INFO - 'run_cmd_checks_enabled': True, 15:41:01 INFO - 'sps_profile': False, 15:41:01 INFO - 'sps_profile_interval': 0, 15:41:01 INFO - 'suite': 'dromaeojs', 15:41:01 INFO - 'system_bits': '32', 15:41:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:41:01 INFO - 'title': 't-yosemite-r7-0149', 15:41:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:41:01 INFO - 'use_talos_json': True, 15:41:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:41:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:41:01 INFO - 'work_dir': 'build'} 15:41:01 INFO - [mozharness: 2016-10-25 22:41:01.849049Z] Running clobber step. 15:41:01 INFO - Running pre-action listener: _resource_record_pre_action 15:41:01 INFO - Running main action method: clobber 15:41:01 INFO - rmtree: /builds/slave/test/build 15:41:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:41:03 INFO - Running post-action listener: _resource_record_post_action 15:41:03 INFO - [mozharness: 2016-10-25 22:41:03.245612Z] Finished clobber step (success) 15:41:03 INFO - [mozharness: 2016-10-25 22:41:03.245744Z] Running read-buildbot-config step. 15:41:03 INFO - Running pre-action listener: _resource_record_pre_action 15:41:03 INFO - Running main action method: read_buildbot_config 15:41:03 INFO - Using buildbot properties: 15:41:03 INFO - { 15:41:03 INFO - "project": "", 15:41:03 INFO - "product": "firefox", 15:41:03 INFO - "script_repo_revision": "production", 15:41:03 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:41:03 INFO - "repository": "", 15:41:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:41:03 INFO - "buildid": "20161025133924", 15:41:03 INFO - "pgo_build": "False", 15:41:03 INFO - "basedir": "/builds/slave/test", 15:41:03 INFO - "buildnumber": 7, 15:41:03 INFO - "slavename": "t-yosemite-r7-0149", 15:41:03 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 15:41:03 INFO - "platform": "yosemite_r7", 15:41:03 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:41:03 INFO - "branch": "mozilla-central", 15:41:03 INFO - "repo_path": "mozilla-central", 15:41:03 INFO - "revision": "b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1", 15:41:03 INFO - "stage_platform": "macosx64", 15:41:03 INFO - "builduid": "20c65cc1c7174e32992599da32a4b0d0", 15:41:03 INFO - "slavebuilddir": "test" 15:41:03 INFO - } 15:41:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 15:41:03 INFO - Running post-action listener: _resource_record_post_action 15:41:03 INFO - [mozharness: 2016-10-25 22:41:03.249221Z] Finished read-buildbot-config step (success) 15:41:03 INFO - [mozharness: 2016-10-25 22:41:03.249333Z] Running download-and-extract step. 15:41:03 INFO - Running pre-action listener: _resource_record_pre_action 15:41:03 INFO - Running main action method: download_and_extract 15:41:03 INFO - mkdir: /builds/slave/test/build/tests 15:41:03 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')]} 15:41:03 INFO - trying https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 15:41:03 INFO - Downloading https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:41:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 15:41:04 INFO - Downloaded 1199 bytes. 15:41:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:41:04 INFO - Using the following test package requirements: 15:41:04 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:41:04 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:41:04 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 15:41:04 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:41:04 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 15:41:04 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:41:04 INFO - u'jsshell-mac.zip'], 15:41:04 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:41:04 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 15:41:04 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:41:04 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:41:04 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 15:41:04 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:41:04 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 15:41:04 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:41:04 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 15:41:04 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:41:04 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 15:41:04 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:41:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:41:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:41:04 INFO - Fetch https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:41:04 INFO - Http code: 200 15:41:04 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 15:41:04 INFO - x-amz-cf-id: pD6_5m44DrHQ2VVEiVjZ-GpdZuiAo3_1eV5GeqgKSKrQBn5VoASCVA== 15:41:04 INFO - x-amz-version-id: EoHNLiN01IVPoQzdmhKXnGPd16oY83M6 15:41:05 INFO - Expected file size: 16423381 15:41:05 INFO - Obtained file size: 16423381 15:41:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:41:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:41:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:41:12 INFO - Fetch https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:41:12 INFO - Http code: 200 15:41:12 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 15:41:12 INFO - x-amz-cf-id: hI58PxhQ7qQWLIHWUdhpc4DdAaM2ElgLa2vKjAbfeMXpNO2ltrDvuw== 15:41:12 INFO - x-amz-version-id: EoHNLiN01IVPoQzdmhKXnGPd16oY83M6 15:41:12 INFO - Expected file size: 16423381 15:41:12 INFO - Obtained file size: 16423381 15:41:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 15:41:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:41:19 INFO - Fetch https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 15:41:20 INFO - Http code: 200 15:41:20 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 15:41:20 INFO - x-amz-cf-id: Uw90O80d89jJb82fb4JxjHdIPig6HQqh3nyCjMDbILngYSipQKm3Hw== 15:41:20 INFO - x-amz-version-id: 8P3BeRDxU4bwbh8Bz4ye_ApwRI_kdXVg 15:41:20 INFO - Expected file size: 14409028 15:41:20 INFO - Obtained file size: 14409028 15:41:21 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')]} 15:41:21 INFO - trying https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:41:21 INFO - Downloading https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 15:41:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 15:41:24 INFO - Downloaded 111192727 bytes. 15:41:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:41:24 INFO - mkdir: /builds/slave/test/properties 15:41:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:41:24 INFO - Writing to file /builds/slave/test/properties/build_url 15:41:24 INFO - Contents: 15:41:24 INFO - build_url:https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:41:24 INFO - Running post-action listener: _resource_record_post_action 15:41:24 INFO - Running post-action listener: set_extra_try_arguments 15:41:24 INFO - [mozharness: 2016-10-25 22:41:24.730659Z] Finished download-and-extract step (success) 15:41:24 INFO - [mozharness: 2016-10-25 22:41:24.730781Z] Running populate-webroot step. 15:41:24 INFO - Running pre-action listener: _resource_record_pre_action 15:41:24 INFO - Running main action method: populate_webroot 15:41:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:41:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:41:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:41:24 INFO - '--tppagecycles', 15:41:24 INFO - '7'], 15:41:24 INFO - 'tests': ['tsvgm']}}, 15:41:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:41:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:41:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:41:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:41:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:41:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:41:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:41:24 INFO - 'talos_options': ['--disable-e10s'], 15:41:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:41:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:41:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:41:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:41:24 INFO - 'talos_options': ['--disable-e10s'], 15:41:24 INFO - 'tests': ['damp', 'tps']}, 15:41:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:41:24 INFO - 'tests': ['damp', 'tps']}, 15:41:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:41:24 INFO - 'tests': ['dromaeo_dom']}, 15:41:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:41:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:41:24 INFO - 'tests': ['basic_compositor_video']}, 15:41:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:41:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:41:24 INFO - 'tests': ['a11yr', 15:41:24 INFO - 'ts_paint', 15:41:24 INFO - 'tpaint', 15:41:24 INFO - 'sessionrestore', 15:41:24 INFO - 'sessionrestore_no_auto_restore', 15:41:24 INFO - 'tabpaint']}, 15:41:24 INFO - 'other-e10s': {'tests': ['a11yr', 15:41:24 INFO - 'ts_paint', 15:41:24 INFO - 'tpaint', 15:41:24 INFO - 'sessionrestore', 15:41:24 INFO - 'sessionrestore_no_auto_restore', 15:41:24 INFO - 'tabpaint']}, 15:41:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:41:24 INFO - 'ts_paint', 15:41:24 INFO - 'tpaint', 15:41:24 INFO - 'sessionrestore', 15:41:24 INFO - 'sessionrestore_no_auto_restore', 15:41:24 INFO - 'tabpaint']}, 15:41:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:41:24 INFO - 'ts_paint', 15:41:24 INFO - 'tpaint', 15:41:24 INFO - 'sessionrestore', 15:41:24 INFO - 'sessionrestore_no_auto_restore', 15:41:24 INFO - 'tabpaint']}, 15:41:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:41:24 INFO - 'tests': ['a11yr', 15:41:24 INFO - 'ts_paint', 15:41:24 INFO - 'tpaint', 15:41:24 INFO - 'sessionrestore', 15:41:24 INFO - 'sessionrestore_no_auto_restore', 15:41:24 INFO - 'tabpaint']}, 15:41:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:41:24 INFO - 'tests': ['a11yr', 15:41:24 INFO - 'ts_paint', 15:41:24 INFO - 'tpaint', 15:41:24 INFO - 'sessionrestore', 15:41:24 INFO - 'sessionrestore_no_auto_restore', 15:41:24 INFO - 'tabpaint']}, 15:41:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:41:24 INFO - 'tests': ['tsvgx', 15:41:24 INFO - 'tsvgr_opacity', 15:41:24 INFO - 'tart', 15:41:24 INFO - 'tscrollx', 15:41:24 INFO - 'cart']}, 15:41:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:41:24 INFO - 'tsvgr_opacity', 15:41:24 INFO - 'tart', 15:41:24 INFO - 'tscrollx', 15:41:24 INFO - 'cart']}, 15:41:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:41:24 INFO - 'talos_options': ['--disable-e10s'], 15:41:24 INFO - 'tests': ['tp5o']}, 15:41:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:41:24 INFO - 'tests': ['tp5o']}, 15:41:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:41:24 INFO - 'talos_options': ['--disable-e10s', 15:41:24 INFO - '--xperf_path', 15:41:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:41:24 INFO - 'tests': ['tp5n']}, 15:41:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:41:24 INFO - 'talos_options': ['--xperf_path', 15:41:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:41:24 INFO - 'tests': ['tp5n']}}, 15:41:24 INFO - 'talos.zip': {'path': '', 15:41:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:41:24 INFO - Running post-action listener: _resource_record_post_action 15:41:24 INFO - [mozharness: 2016-10-25 22:41:24.749632Z] Finished populate-webroot step (success) 15:41:24 INFO - [mozharness: 2016-10-25 22:41:24.749756Z] Running create-virtualenv step. 15:41:24 INFO - Running pre-action listener: _resource_record_pre_action 15:41:24 INFO - Running main action method: create_virtualenv 15:41:24 INFO - Creating virtualenv /builds/slave/test/build/venv 15:41:24 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 15:41:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:41:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:41:24 INFO - Using real prefix '/tools/python27' 15:41:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:41:25 INFO - Installing distribute.............................................................................................................................................................................................done. 15:41:28 INFO - Installing pip.................done. 15:41:28 INFO - Return code: 0 15:41:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:41:28 INFO - Reading from file tmpfile_stdout 15:41:28 INFO - Output received: 15:41:28 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) 15:41:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:41:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:41:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10432b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d31ca4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10413fd30>, '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 0x103f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104137b20>, '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.Su7LIoRtcu/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.3ytK1Ofopv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 15:41:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:41:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Su7LIoRtcu/Render', 15:41:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:41:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:41:28 INFO - 'HOME': '/Users/cltbld', 15:41:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:41:28 INFO - 'LOGNAME': 'cltbld', 15:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:28 INFO - 'MOZ_NO_REMOTE': '1', 15:41:28 INFO - 'NO_EM_RESTART': '1', 15:41:28 INFO - 'PAGER': '/bin/cat', 15:41:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:28 INFO - 'PWD': '/builds/slave/test', 15:41:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:41:28 INFO - 'SHELL': '/bin/bash', 15:41:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ytK1Ofopv/Listeners', 15:41:28 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 15:41:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:41:28 INFO - 'USER': 'cltbld', 15:41:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:41:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:28 INFO - 'XPC_FLAGS': '0x0', 15:41:28 INFO - 'XPC_SERVICE_NAME': '0', 15:41:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:29 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 15:41:29 INFO - Cleaning up... 15:41:29 INFO - Return code: 0 15:41:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:41: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')]} 15:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41: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')]} 15:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41: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', '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 0x10432b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d31ca4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10413fd30>, '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 0x103f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104137b20>, '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.Su7LIoRtcu/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.3ytK1Ofopv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 15:41: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:41: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 psutil>=3.1.1 15:41:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Su7LIoRtcu/Render', 15:41:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:41:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:41:29 INFO - 'HOME': '/Users/cltbld', 15:41:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:41:29 INFO - 'LOGNAME': 'cltbld', 15:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:29 INFO - 'MOZ_NO_REMOTE': '1', 15:41:29 INFO - 'NO_EM_RESTART': '1', 15:41:29 INFO - 'PAGER': '/bin/cat', 15:41:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:29 INFO - 'PWD': '/builds/slave/test', 15:41:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:41:29 INFO - 'SHELL': '/bin/bash', 15:41:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ytK1Ofopv/Listeners', 15:41:29 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 15:41:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:41:29 INFO - 'USER': 'cltbld', 15:41:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:41:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:29 INFO - 'XPC_FLAGS': '0x0', 15:41:29 INFO - 'XPC_SERVICE_NAME': '0', 15:41:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:29 INFO - Downloading/unpacking psutil>=3.1.1 15:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:41:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:41:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:41:33 INFO - Installing collected packages: psutil 15:41:33 INFO - Running setup.py install for psutil 15:41:33 INFO - building 'psutil._psutil_osx' extension 15:41: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 15:41: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:41: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:41:33 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 15:41:33 INFO - building 'psutil._psutil_posix' extension 15:41:33 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 15:41:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:41:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:41:33 INFO - ^ 15:41:33 INFO - 1 warning generated. 15:41:33 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 15:41:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:41:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:41:34 INFO - Successfully installed psutil 15:41:34 INFO - Cleaning up... 15:41:34 INFO - Return code: 0 15:41:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:41:34 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')]} 15:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:34 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')]} 15:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:34 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 0x10432b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d31ca4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10413fd30>, '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 0x103f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104137b20>, '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.Su7LIoRtcu/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.3ytK1Ofopv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 15:41:34 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 15:41:34 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 15:41:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Su7LIoRtcu/Render', 15:41:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:41:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:41:34 INFO - 'HOME': '/Users/cltbld', 15:41:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:41:34 INFO - 'LOGNAME': 'cltbld', 15:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:34 INFO - 'MOZ_NO_REMOTE': '1', 15:41:34 INFO - 'NO_EM_RESTART': '1', 15:41:34 INFO - 'PAGER': '/bin/cat', 15:41:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:34 INFO - 'PWD': '/builds/slave/test', 15:41:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:41:34 INFO - 'SHELL': '/bin/bash', 15:41:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ytK1Ofopv/Listeners', 15:41:34 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 15:41:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:41:34 INFO - 'USER': 'cltbld', 15:41:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:41:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:34 INFO - 'XPC_FLAGS': '0x0', 15:41:34 INFO - 'XPC_SERVICE_NAME': '0', 15:41:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:41:34 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 15:41:34 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 15:41:34 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 15:41:34 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 15:41:34 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 15:41:34 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 15:41:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:41:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:41:37 INFO - Installing collected packages: mozsystemmonitor 15:41:37 INFO - Running setup.py install for mozsystemmonitor 15:41:37 INFO - Successfully installed mozsystemmonitor 15:41:37 INFO - Cleaning up... 15:41:37 INFO - Return code: 0 15:41:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:37 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 0x10432b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d31ca4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10413fd30>, '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 0x103f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104137b20>, '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.Su7LIoRtcu/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.3ytK1Ofopv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 15:41:37 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 15:41:37 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 15:41:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Su7LIoRtcu/Render', 15:41:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:41:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:41:37 INFO - 'HOME': '/Users/cltbld', 15:41:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:41:37 INFO - 'LOGNAME': 'cltbld', 15:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:37 INFO - 'MOZ_NO_REMOTE': '1', 15:41:37 INFO - 'NO_EM_RESTART': '1', 15:41:37 INFO - 'PAGER': '/bin/cat', 15:41:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:37 INFO - 'PWD': '/builds/slave/test', 15:41:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:41:37 INFO - 'SHELL': '/bin/bash', 15:41:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ytK1Ofopv/Listeners', 15:41:37 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 15:41:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:41:37 INFO - 'USER': 'cltbld', 15:41:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:41:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:37 INFO - 'XPC_FLAGS': '0x0', 15:41:37 INFO - 'XPC_SERVICE_NAME': '0', 15:41:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:37 INFO - Downloading/unpacking jsonschema==2.5.1 15:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:41:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:41: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 15:41: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 15:41: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 15:41: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 15:41: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 15:41: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 15:41:40 INFO - Downloading functools32-3.2.3-2.tar.gz 15:41:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:41:40 INFO - warning: no files found matching '*.txt' 15:41:40 INFO - no previously-included directories found matching 'build' 15:41:40 INFO - no previously-included directories found matching 'dist' 15:41:40 INFO - no previously-included directories found matching '.git*' 15:41:40 INFO - Installing collected packages: jsonschema, functools32 15:41:40 INFO - Running setup.py install for functools32 15:41:40 INFO - warning: no files found matching '*.txt' 15:41:40 INFO - no previously-included directories found matching 'build' 15:41:40 INFO - no previously-included directories found matching 'dist' 15:41:40 INFO - no previously-included directories found matching '.git*' 15:41:40 INFO - Successfully installed jsonschema functools32 15:41:40 INFO - Cleaning up... 15:41:40 INFO - Return code: 0 15:41:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:41:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:40 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 0x10432b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d31ca4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10413fd30>, '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 0x103f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104137b20>, '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.Su7LIoRtcu/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.3ytK1Ofopv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 15:41:40 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 15:41:40 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 15:41:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Su7LIoRtcu/Render', 15:41:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:41:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:41:40 INFO - 'HOME': '/Users/cltbld', 15:41:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:41:40 INFO - 'LOGNAME': 'cltbld', 15:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:40 INFO - 'MOZ_NO_REMOTE': '1', 15:41:40 INFO - 'NO_EM_RESTART': '1', 15:41:40 INFO - 'PAGER': '/bin/cat', 15:41:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:40 INFO - 'PWD': '/builds/slave/test', 15:41:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:41:40 INFO - 'SHELL': '/bin/bash', 15:41:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ytK1Ofopv/Listeners', 15:41:40 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 15:41:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:41:40 INFO - 'USER': 'cltbld', 15:41:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:41:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:40 INFO - 'XPC_FLAGS': '0x0', 15:41:40 INFO - 'XPC_SERVICE_NAME': '0', 15:41:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:41:41 INFO - Cleaning up... 15:41:41 INFO - Return code: 0 15:41:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10432b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d31ca4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10413fd30>, '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 0x103f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104137b20>, '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.Su7LIoRtcu/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.3ytK1Ofopv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 15:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:41:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Su7LIoRtcu/Render', 15:41:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:41:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:41:41 INFO - 'HOME': '/Users/cltbld', 15:41:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:41:41 INFO - 'LOGNAME': 'cltbld', 15:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:41 INFO - 'MOZ_NO_REMOTE': '1', 15:41:41 INFO - 'NO_EM_RESTART': '1', 15:41:41 INFO - 'PAGER': '/bin/cat', 15:41:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:41 INFO - 'PWD': '/builds/slave/test', 15:41:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:41:41 INFO - 'SHELL': '/bin/bash', 15:41:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ytK1Ofopv/Listeners', 15:41:41 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 15:41:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:41:41 INFO - 'USER': 'cltbld', 15:41:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:41:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:41 INFO - 'XPC_FLAGS': '0x0', 15:41:41 INFO - 'XPC_SERVICE_NAME': '0', 15:41:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:41 INFO - Downloading/unpacking blobuploader==1.2.4 15:41:41 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 15:41:41 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 15:41:41 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 15:41:41 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 15:41:41 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 15:41:41 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 15:41:43 INFO - Downloading blobuploader-1.2.4.tar.gz 15:41:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:41:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:41: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 15:41: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 15:41: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 15:41: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 15:41: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 15:41: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 15:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:41:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:41:44 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 15:41:44 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 15:41:44 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 15:41:44 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 15:41:44 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 15:41:44 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 15:41:44 INFO - Downloading docopt-0.6.1.tar.gz 15:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:41:45 INFO - Installing collected packages: blobuploader, requests, docopt 15:41:45 INFO - Running setup.py install for blobuploader 15:41:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:41:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:41:45 INFO - Running setup.py install for requests 15:41:45 INFO - Running setup.py install for docopt 15:41:45 INFO - Successfully installed blobuploader requests docopt 15:41:45 INFO - Cleaning up... 15:41:45 INFO - Return code: 0 15:41:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:45 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 0x10432b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d31ca4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10413fd30>, '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 0x103f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104137b20>, '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.Su7LIoRtcu/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.3ytK1Ofopv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 15:41:45 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 15:41:45 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 15:41:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Su7LIoRtcu/Render', 15:41:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:41:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:41:45 INFO - 'HOME': '/Users/cltbld', 15:41:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:41:45 INFO - 'LOGNAME': 'cltbld', 15:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:45 INFO - 'MOZ_NO_REMOTE': '1', 15:41:45 INFO - 'NO_EM_RESTART': '1', 15:41:45 INFO - 'PAGER': '/bin/cat', 15:41:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:45 INFO - 'PWD': '/builds/slave/test', 15:41:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:41:45 INFO - 'SHELL': '/bin/bash', 15:41:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ytK1Ofopv/Listeners', 15:41:45 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 15:41:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:41:45 INFO - 'USER': 'cltbld', 15:41:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:41:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:45 INFO - 'XPC_FLAGS': '0x0', 15:41:45 INFO - 'XPC_SERVICE_NAME': '0', 15:41:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:41:46 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-xlIZNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:41:46 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-dlRIF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:41:46 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-gLiRzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:41:46 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-hbBcot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:41:46 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-dSxc4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:41:46 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-LMLpFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:41:46 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-HbKE6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:41:46 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Zs52tN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:41:46 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Bl7Lc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:41:47 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-BeP0Iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:41:47 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-y238c2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:41:47 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-TQDWOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:41:47 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-LWt0RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:41:47 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-DPG3EA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:41:47 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Sbe6qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:41:47 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-MsFuMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:41:47 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-YXKNfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:41:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:41:47 INFO - Running setup.py install for manifestparser 15:41:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:41:48 INFO - Running setup.py install for mozcrash 15:41:48 INFO - Running setup.py install for mozdebug 15:41:48 INFO - Running setup.py install for mozdevice 15:41:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:41:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:41:48 INFO - Running setup.py install for mozfile 15:41:48 INFO - Running setup.py install for mozhttpd 15:41:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:41:48 INFO - Running setup.py install for mozinfo 15:41:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:41:48 INFO - Running setup.py install for mozInstall 15:41:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:41:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:41:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:41:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:41:49 INFO - Running setup.py install for mozleak 15:41:49 INFO - Running setup.py install for mozlog 15:41:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:41:49 INFO - Running setup.py install for moznetwork 15:41:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:41:49 INFO - Running setup.py install for mozprocess 15:41:49 INFO - Running setup.py install for mozprofile 15:41:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:41:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:41:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:41:49 INFO - Running setup.py install for mozrunner 15:41:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:41:50 INFO - Running setup.py install for mozscreenshot 15:41:50 INFO - Running setup.py install for moztest 15:41:50 INFO - Running setup.py install for mozversion 15:41:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:41:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:41:50 INFO - Cleaning up... 15:41:50 INFO - Return code: 0 15:41:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:41:50 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')]} 15:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:50 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')]} 15:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:50 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 0x10432b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d31ca4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10413fd30>, '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 0x103f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104137b20>, '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.Su7LIoRtcu/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.3ytK1Ofopv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 15:41:50 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 15:41:50 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 15:41:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Su7LIoRtcu/Render', 15:41:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:41:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:41:50 INFO - 'HOME': '/Users/cltbld', 15:41:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:41:50 INFO - 'LOGNAME': 'cltbld', 15:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:50 INFO - 'MOZ_NO_REMOTE': '1', 15:41:50 INFO - 'NO_EM_RESTART': '1', 15:41:50 INFO - 'PAGER': '/bin/cat', 15:41:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:50 INFO - 'PWD': '/builds/slave/test', 15:41:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:41:50 INFO - 'SHELL': '/bin/bash', 15:41:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ytK1Ofopv/Listeners', 15:41:50 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 15:41:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:41:50 INFO - 'USER': 'cltbld', 15:41:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:41:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:50 INFO - 'XPC_FLAGS': '0x0', 15:41:50 INFO - 'XPC_SERVICE_NAME': '0', 15:41:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:41:50 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-g1jtfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:41:50 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)) 15:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:41:50 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-FXfDXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:41:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:41:50 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-bcy2MJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:41:51 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)) 15:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:41:51 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-VrZRCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:41:51 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-zP8HQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:41:51 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)) 15:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:41:51 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-AqhBc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:41:51 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)) 15:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:41:51 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Av6TE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:41:51 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)) 15:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:41:51 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-0aOqgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:41:51 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)) 15:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:41:51 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-izO_66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:41:51 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)) 15:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:41:51 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-ap7nHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:41:51 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)) 15:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:41:51 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-0Sj0Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:41:51 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)) 15:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:41:51 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-6TGMts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:41:52 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)) 15:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:41:52 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-_l06K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:41:52 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)) 15:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:41:52 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-z1Rn34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:41:52 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-jhn6Lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:41:52 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)) 15:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:41:52 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-Kfztrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:41:52 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)) 15:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:41:52 INFO - Running setup.py (path:/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/pip-cSK0DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:41:52 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)) 15:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:41:52 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)) 15:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:41:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:41:52 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 15:41:52 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 15:41:52 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 15:41:52 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 15:41:52 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 15:41:52 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 15:41:55 INFO - Downloading blessings-1.6.tar.gz 15:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:41:55 INFO - Installing collected packages: blessings 15:41:55 INFO - Running setup.py install for blessings 15:41:55 INFO - Successfully installed blessings 15:41:55 INFO - Cleaning up... 15:41:55 INFO - Return code: 0 15:41:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:41:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:41:55 INFO - Reading from file tmpfile_stdout 15:41:55 INFO - Current package versions: 15:41:55 INFO - blessings == 1.6 15:41:55 INFO - blobuploader == 1.2.4 15:41:55 INFO - docopt == 0.6.1 15:41:55 INFO - functools32 == 3.2.3-2 15:41:55 INFO - jsonschema == 2.5.1 15:41:55 INFO - manifestparser == 1.1 15:41:55 INFO - mozInstall == 1.12 15:41:55 INFO - mozcrash == 0.17 15:41:55 INFO - mozdebug == 0.1 15:41:55 INFO - mozdevice == 0.48 15:41:55 INFO - mozfile == 1.2 15:41:55 INFO - mozhttpd == 0.7 15:41:55 INFO - mozinfo == 0.9 15:41:55 INFO - mozleak == 0.1 15:41:55 INFO - mozlog == 3.4 15:41:55 INFO - moznetwork == 0.27 15:41:55 INFO - mozprocess == 0.23 15:41:55 INFO - mozprofile == 0.28 15:41:55 INFO - mozrunner == 6.12 15:41:55 INFO - mozscreenshot == 0.1 15:41:55 INFO - mozsystemmonitor == 0.3 15:41:55 INFO - moztest == 0.7 15:41:55 INFO - mozversion == 1.4 15:41:55 INFO - psutil == 3.1.1 15:41:55 INFO - requests == 1.2.3 15:41:55 INFO - wsgiref == 0.1.2 15:41:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:41:55 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')]} 15:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:55 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')]} 15:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:55 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 0x10432b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d31ca4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10413fd30>, '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 0x103f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104137b20>, '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.Su7LIoRtcu/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.3ytK1Ofopv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 15:41:55 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 15:41:55 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 15:41:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Su7LIoRtcu/Render', 15:41:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:41:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:41:55 INFO - 'HOME': '/Users/cltbld', 15:41:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:41:55 INFO - 'LOGNAME': 'cltbld', 15:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:55 INFO - 'MOZ_NO_REMOTE': '1', 15:41:55 INFO - 'NO_EM_RESTART': '1', 15:41:55 INFO - 'PAGER': '/bin/cat', 15:41:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:55 INFO - 'PWD': '/builds/slave/test', 15:41:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:41:55 INFO - 'SHELL': '/bin/bash', 15:41:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ytK1Ofopv/Listeners', 15:41:55 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 15:41:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:41:55 INFO - 'USER': 'cltbld', 15:41:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:41:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:55 INFO - 'XPC_FLAGS': '0x0', 15:41:55 INFO - 'XPC_SERVICE_NAME': '0', 15:41:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:55 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)) 15:41:55 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)) 15:41:55 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)) 15:41:55 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)) 15:41:55 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)) 15:41:55 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)) 15:41:55 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)) 15:41:55 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)) 15:41:55 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)) 15:41:55 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)) 15:41:55 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)) 15:41:55 INFO - Cleaning up... 15:41:55 INFO - Return code: 0 15:41:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:41:55 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')]} 15:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:55 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')]} 15:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:55 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 0x10432b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d31ca4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10413fd30>, '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 0x103f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104137b20>, '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.Su7LIoRtcu/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.3ytK1Ofopv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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 15:41:55 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 15:41:55 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 15:41:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Su7LIoRtcu/Render', 15:41:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:41:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:41:55 INFO - 'HOME': '/Users/cltbld', 15:41:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:41:55 INFO - 'LOGNAME': 'cltbld', 15:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:55 INFO - 'MOZ_NO_REMOTE': '1', 15:41:55 INFO - 'NO_EM_RESTART': '1', 15:41:55 INFO - 'PAGER': '/bin/cat', 15:41:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:55 INFO - 'PWD': '/builds/slave/test', 15:41:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:41:55 INFO - 'SHELL': '/bin/bash', 15:41:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ytK1Ofopv/Listeners', 15:41:55 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 15:41:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:41:55 INFO - 'USER': 'cltbld', 15:41:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:41:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:55 INFO - 'XPC_FLAGS': '0x0', 15:41:55 INFO - 'XPC_SERVICE_NAME': '0', 15:41:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:41:56 INFO - Cleaning up... 15:41:56 INFO - Return code: 0 15:41:56 INFO - Running post-action listener: _resource_record_post_action 15:41:56 INFO - Running post-action listener: _start_resource_monitoring 15:41:56 INFO - Starting resource monitoring. 15:41:56 INFO - [mozharness: 2016-10-25 22:41:56.277470Z] Finished create-virtualenv step (success) 15:41:56 INFO - [mozharness: 2016-10-25 22:41:56.278499Z] Running install step. 15:41:56 INFO - Running pre-action listener: _resource_record_pre_action 15:41:56 INFO - Running main action method: install 15:41:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:41:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:41:56 INFO - Reading from file tmpfile_stdout 15:41:56 INFO - Detecting whether we're running mozinstall >=1.0... 15:41:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:41:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:41:56 INFO - Reading from file tmpfile_stdout 15:41:56 INFO - Output received: 15:41:56 INFO - Usage: mozinstall [options] installer 15:41:56 INFO - Options: 15:41:56 INFO - -h, --help show this help message and exit 15:41:56 INFO - -d DEST, --destination=DEST 15:41:56 INFO - Directory to install application into. [default: 15:41:56 INFO - "/builds/slave/test"] 15:41:56 INFO - --app=APP Application being installed. [default: firefox] 15:41:56 INFO - mkdir: /builds/slave/test/build/application 15:41:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:41:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:42:30 INFO - Reading from file tmpfile_stdout 15:42:30 INFO - Output received: 15:42:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:42:30 INFO - Running post-action listener: _resource_record_post_action 15:42:30 INFO - [mozharness: 2016-10-25 22:42:30.804126Z] Finished install step (success) 15:42:30 INFO - [mozharness: 2016-10-25 22:42:30.804281Z] Running run-tests step. 15:42:30 INFO - Running pre-action listener: _resource_record_pre_action 15:42:30 INFO - Running main action method: run_tests 15:42:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:42:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:42:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:42:30 INFO - 2016-10-25 15:42:30.818 screenresolution[1945:14149] starting screenresolution argv=screenresolution get 15:42:30 INFO - 2016-10-25 15:42:30.820 screenresolution[1945:14149] Display 0: 1600x1200x32@60 15:42:30 INFO - 2016-10-25 15:42:30.826 screenresolution[1946:14151] starting screenresolution argv=screenresolution list 15:42:30 INFO - Available Modes on Display 0 15:42:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:42:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:42:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:42:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:42:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:42:31 INFO - Intel Iris: 15:42:31 INFO - Chipset Model: Intel Iris 15:42:31 INFO - Type: GPU 15:42:31 INFO - Bus: Built-In 15:42:31 INFO - VRAM (Dynamic, Max): 1536 MB 15:42:31 INFO - Vendor: Intel (0x8086) 15:42:31 INFO - Device ID: 0x0a2e 15:42:31 INFO - Revision ID: 0x0009 15:42:31 INFO - Displays: 15:42:31 INFO - Display: 15:42:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:42:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:42:31 INFO - Display Serial Number: 1600x1200 60 15:42:31 INFO - Main Display: Yes 15:42:31 INFO - Mirror: Off 15:42:31 INFO - Online: Yes 15:42:31 INFO - Rotation: Supported 15:42:31 INFO - Return code: 0 15:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:42:31 INFO - Python 2.7.3 15:42:31 INFO - Return code: 0 15:42:31 INFO - grabbing minidump binary from tooltool 15:42: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')]} 15:42: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 0x10413fd30>, '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 0x103f65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104137b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:42: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 15:42: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 15:42: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 15:42:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:42:31 INFO - Return code: 0 15:42:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:42:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:42:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:42:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:42:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:42: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/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0149', '--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 15:42: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/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0149 --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 15:42:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Su7LIoRtcu/Render', 15:42:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:42:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:42:31 INFO - 'HOME': '/Users/cltbld', 15:42:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:42:31 INFO - 'LOGNAME': 'cltbld', 15:42:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:42:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:31 INFO - 'MOZ_NO_REMOTE': '1', 15:42:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:42:31 INFO - 'NO_EM_RESTART': '1', 15:42:31 INFO - 'PAGER': '/bin/cat', 15:42:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:31 INFO - 'PWD': '/builds/slave/test', 15:42:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:42:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:42:31 INFO - 'SHELL': '/bin/bash', 15:42:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3ytK1Ofopv/Listeners', 15:42:31 INFO - 'TMPDIR': '/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/', 15:42:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:42:31 INFO - 'USER': 'cltbld', 15:42:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:42:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:31 INFO - 'XPC_FLAGS': '0x0', 15:42:31 INFO - 'XPC_SERVICE_NAME': '0', 15:42:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:42: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/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0149', '--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 15:42:31 INFO - mozversion application_buildid: 20161025133924 15:42:31 INFO - mozversion application_changeset: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 15:42:31 INFO - mozversion application_display_name: Nightly 15:42:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:42:31 INFO - mozversion application_name: Firefox 15:42:31 INFO - mozversion application_remotingname: firefox 15:42:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:42:31 INFO - mozversion application_vendor: Mozilla 15:42:31 INFO - mozversion application_version: 52.0a1 15:42:31 INFO - mozversion platform_buildid: 20161025133924 15:42:31 INFO - mozversion platform_changeset: b1b18f25c0ea69d9ee57c4198d577dfcd0129ce1 15:42:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:42:31 INFO - mozversion platform_version: 52.0a1 15:42:31 INFO - using testdate: 1477435351 15:42:31 INFO - actual date: 1477435351 15:42:31 INFO - starting webserver on 'localhost:50665' 15:42:31 INFO - SUITE-START | Running 2 tests 15:42:31 INFO - TEST-START | dromaeo_css 15:42:31 INFO - operating with platform_type : mac_ 15:42:31 INFO - Initialising browser for dromaeo_css test... 15:42:31 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpv5Rnmg/profile http://localhost:50665/getInfo.html) 15:42:33 INFO - PROCESS | 1956 | __metrics Screen width/height:1600/1200 15:42:33 INFO - PROCESS | 1956 | colorDepth:24 15:42:33 INFO - PROCESS | 1956 | Browser inner width/height: 1024/689 15:42:33 INFO - PROCESS | 1956 | __metrics 15:42:33 INFO - PROCESS | 1956 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:42:33 INFO - PROCESS | 1956 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:42:34 INFO - TEST-INFO | 1956: exit 0 15:42:34 INFO - Browser initialized. 15:42:34 INFO - Running cycle 1/1 for dromaeo_css test... 15:42:34 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpv5Rnmg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:42:46 INFO - PROCESS | 1958 | RSS: Main: 231362560 15:42:46 INFO - PROCESS | 1958 | 15:43:37 INFO - PROCESS | 1958 | 1477435417758 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] 15:45:49 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:50665/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50665/tests/dromaeo/cssquery-ext.html) 15:45:52 INFO - PROCESS | 1958 | RSS: Main: 457699328 15:45:52 INFO - PROCESS | 1958 | 15:48:55 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:50665/tests/dromaeo/cssquery-ext.html (next: http://localhost:50665/tests/dromaeo/cssquery-jquery.html) 15:48:56 INFO - PROCESS | 1958 | RSS: Main: 369037312 15:48:56 INFO - PROCESS | 1958 | 15:51:58 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:50665/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50665/tests/dromaeo/cssquery-mootools.html) 15:51:59 INFO - PROCESS | 1958 | RSS: Main: 339603456 15:51:59 INFO - PROCESS | 1958 | 15:55:01 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:50665/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50665/tests/dromaeo/cssquery-prototype.html) 15:55:02 INFO - PROCESS | 1958 | RSS: Main: 346857472 15:55:02 INFO - PROCESS | 1958 | 15:58:05 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:50665/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50665/tests/dromaeo/cssquery-yui.html) 15:58:06 INFO - PROCESS | 1958 | RSS: Main: 335163392 15:58:06 INFO - PROCESS | 1958 | 16:01:09 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:50665/tests/dromaeo/cssquery-yui.html (next: http://localhost:50665/tests/dromaeo/cssquery-dojo.html) 16:01:09 INFO - PROCESS | 1958 | RSS: Main: 410402816 16:01:09 INFO - PROCESS | 1958 | 16:01:09 INFO - PROCESS | 1958 | __start_tp_report 16:01:09 INFO - PROCESS | 1958 | _x_x_mozilla_page_load 16:01:09 INFO - PROCESS | 1958 | _x_x_mozilla_page_load_details 16:01:09 INFO - PROCESS | 1958 | |i|pagename|runs| 16:01:09 INFO - PROCESS | 1958 | |0;dojo.html;3302.950455743164;3304.3060957198995;3312.403767321882;3349.447341188704;3372.6458721834206;5638.984982703112;5715.971420142899;5742.712864356776;5749.223854779603;5754.2519472468575;4852.733099679516;5689.687067211302;5714.77140914364;5836.533077353812;5841.269841269841;5089.287499750038;5148.588112950955;5196.58427325815;5221.399539053001;5241.161414173733;5265.8946821063555;5275;5291;5311.2298716686255;5332.520073193412;5229.111051121318;5254.08053590624;5267.183586544092;5279.128943724281;5319.9202011969855;5145.588352931794;5156.871078223037;5214.921776173361;5220.791168353299;5259.474052594748;5189.766460509249;5195.662281951699;5203.791848326063;5217.660852044605;5270.5520030797425;5744.597878148531;5747.856303592402;5767.798127065575;5774.884502309972;5784.826455206308;6109.755609775603;6132.6614613216525;6167.506599472032;6213.5339849511465;6267.5299352548745;6218.4714299284615;6278.623282603013;6322.399372059647;6326.715297811609;6330.936690633081;5830.125481177814;5847.532197424196;5848.9707551462825;5854.765809367663;5920.437558431942;5806.361300256968;6119.4798442132915;6136.764169924236;6210.968945155245;6285.622862628257;6119.653521814353;6156.384361563808;6163.1679723237685;6167.629942203393;6180.289266734293;6286.49708023357;6286.717097730613;6289.811305660837;6295.622262664255;6302.527310451735;5994.610350327215;6101.297630694255;6104.307579233822;6228.941080016318;6234.1583886175695;6143.447089761943;6234.37656234382;6245.375462453719;6283.937160628427;6291.056341548804;4940.407151141886;4942.283368911488;4946.480619534897;4949.7772600233075;4968.677035992649;4454.020115574568;4506.909861802746;4511.593956543927;4520.412346395014;4531.252343363374;5650.576206784425;5757.539396848242;5790.131480277992;5791.478766910998;5847.239858818411;6261.060840873905;6297.622142671455;6316.368363163647;6318.684065796691;6319.6208227506495;5871.207387002785;5902.1146827976145;5906.8818623627285;5912.852178695567;5942.851428714231;5318.202269659505;5349;5364.490373414519;5370.70461124634;5420.891582168335;6187.195664563668;6289;6297.622142671455;6298.559100863079;6315.842103947254;6316.494680425463;6322.33615470369;6333.841653958688;6335.683215839282;6339.461145802658;6214.161088253028;6223.128761973418;6250.781222657185;6266.404691554295;6289.993601023814;5398.541124004503;5983.9401605983385;6122.367660829107;6250.968745156245;6253.437190652863;6265.373462653881;6305.211848518935;6312.905306420315;6316.242050953915;6334.144890439732;5838.299404071538;6029.758809647565;6088.330283668882;6095.207623008981;6098.847528811815;5946.643201407929;6031.728572214173;6038.3357830637715;6039.547033972557;6041.909371359521;5823.4467725566;5874.060150375919;5889.087191485327;5896.528277737856;5905.645661260338;5990.161377407254;6021.2473440819895;6022.1870047543025;6031.336552979256;6037.245344331958;5859.267591551056;5866.823995280149;5869.295684517714;5869.7945571904775;5877.911831322448 16:01:09 INFO - PROCESS | 1958 | |1;ext.html;480.3659169895739;509.62287906948853;517.0305676855895;523.1107117899569;554.8708378449855;29743.107706768777;38490.61509384909;39661.801690991575;39679.801600992025;42084.57915420845;41071;41462.58537414625;41519.16961660765;41524.961875953115;41842.581574184325;8114.107448180695;8550.871736923951;8748.8687669685;9629.855552166724;9684.273679474067;8627.741167764978;8757.25563327118;8757.868631970525;8760.561971901412;8764.56177191141;11283.66149015531;11529.884701153007;11554.595589154382;11707.121965852553;11721.941390293037;11493.482793274281;11576.59481918133;11584.362860042695;11587.768244635145;11594.188406811527;8546.359023073295;8791.252743516809;9454.385464944757;11355.432228388547;11393.658190254306;31508.527372089437;31745.365092698015;31769;38383;39124;2922.4447355002694;3042.3002709376747;3254.844530191795;3337.182390314364;3623.8548071999912;29237.707622923925;29960.801567937255;30833;30834;30914.227144321347;3109.518024706174;3166.129314438525;3229.9031029069165;3256.397566450214;3293.7035666790102;472924.63537682436;475030;475100;476970;477748;57714;58039;58167;58198.41801582015;58263.70868145632;61608.45978850475;61638;61660.38339616636;61682.69158654268;61734;15695.607609809618;15982.041077535385;16006;16012.11933343654;16046.197690115447;12449.688757781129;12542.24746515212;12542.68643283907;12561.183523070971;12567.874321256853;13835.03154779176;14190.432382704783;14244.501442449464;15124.848751512343;15887.046777193405;6666.366695163952;6904.719074174044;7141.82145446368;7308.159561650372;7385.963070184722;879.5909901895649;976.2336565795958;1025.6717850287837;1049.2550289294686;1054.288355360129;28833.423331533253;28932.42135157285;29207;29577.55633665497;29665.703342966724;1059.7138772531373;1060.2419270221828;1093.512822561316;1137.7155711072232;1205.3671822293365;14114.22371769542;14887.553373398816;14928.32822522989;15344.92585519003;15364.923175384052;601000;604780;606352;606641;606986;48452.757736211795;49386.506134938194;56389.7180514103;59125;59809;1299.9870001300055;1336.2583766009764;1343.7514059898754;1343.946242150303;1349.8582648821732;29721.554176687798;29844.85077574598;29903.442506212177;30121.548176776927;30297.148942735108;48568.51431485781;49006;49090.01819963652;49243;49307.50692493029;612859;618123;629276;795752;795794;24695;24852.751472485044;24946.501069978134;25161.496770064863;25198;44655;44720.77639611781;44728.77635611801;45437.31844022409;45441.63675089752;33731.662683373834;36202.8189859049;36339.63660363468;37762.43356349712;37842.81078594589;36582.8170859144;36741.08147296339;37594.624053760206;37605.05987350229;37658.05854853541;36562.8171859139;36844;37069.25861482809;38554.421683675326;38815.41776873293;31830.885918992724;32267.51598726068;33680.15799604932;33693.66306337003;33846.83076584601;24307.513849723262;24746.752532474446;24807.25578232656;25183.496330073664;25310.240692779247 16:01:09 INFO - PROCESS | 1958 | |2;jquery.html;340.0919544815343;350.49703675226067;372.51572955158287;375.18959048455343;403.10108458138353;14833.554993350202;15011;15848.049117052971;20201.59596808063;20461.48846278844;19925;20256.392308230777;20857;20994.95025248739;21179;5545.556355491572;5704.458076482728;6009.699515024253;6019.518438524908;6024.1566180734735;5513.393526712059;5915.792947246847;5982.192404025466;5987.401259873999;5987.580869339148;5635.464630860082;5776.740046697909;5935.436133567304;5939.316978547457;5950.107483877431;5022.17134172861;5777.826665200051;5844.941550584504;5852.297724273072;5854.619449735754;4865.635077369211;5068.797248110071;5089.083964886319;5095.363079615048;5140.357455318085;25189.24432267035;25450;25604.97580096794;25626.359341016625;25653.102141425148;2356.882155892216;2386.284114765581;2492.526419980216;2633.0652618320414;2803.4252978139434;14652;15342.156181410019;15905.284262208113;16132.838671613252;16187;1532.785410042595;1589.2212815720213;1769.9911500442415;1858.6189831084596;1889.763779527559;115235;118467;118715;118898.40550797277;119732;10223.795524089477;10501.264911456125;10824.13406927444;10909.290896091728;11250.831237531444;12310.692232694255;13345.932325413944;13600.455981760817;13628.523001694894;13629.522966696119;8167.79580510492;8214.178582141738;8228.177182281725;8373.874391884126;8389.07720150783;8206.22040906113;8208.384371172186;8226.917730822735;8399;8412.990441147102;6339.207599050119;6424.293327733945;6461.424924206151;6479.611223326616;6497.350264973559;1583.2875206157275;1824.5447300554792;1854.313903855582;1855.9536011599548;1859.841913437346;843.3337663245967;965.7826988927435;966.7003228999033;991.9008099190023;996.5415908681942;20570.897145514475;22035.338939831832;22050.44873878134;22073;22096.668549971764;959.2469911119738;964.344245912786;964.7057647417605;970.427447805798;981.4454833019321;10727.946360268148;10970.890291097146;11429.314241145557;11548.711282217844;11562.421878906021;577051;579511;579984;585452;598207;76660;79405;85491.57254213688;95010.72237301906;116698.24952625718;874.2918236228548;922.4557511068367;975.0834215837091;976.4385478349835;981.2983716642635;14228.715425691635;16221;19258.518537036125;19545.315913942944;19631.803681962996;40749.38875916805;50182.247266291764;52011;52155.696107597614;52707;73937.26062739304;75923;76285.61857190679;77908;80787.59606201931;6540.738370465128;7480.812979675552;8049.476784009021;8111.675532978851;8283.58582070882;12236.211210463032;12663.683407914876;13028.739425211632;13129.080964332405;13142.671433214246;10698.14414846826;10702;11043.39261340634;11125.499352528994;11278.323300601991;10851.945740271249;10881.945590271998;10932.125429965425;11156.944215278872;11338;10540.314879532805;11237.3257604544;11529.538818447503;11631.6510504685;11664.241824281395;7938.293266947634;8050.355971522381;8188.086334383339;8225.629846656795;8248.793780155544;10371.377717336682;10540.683779486628;10685;10927.781444370909;11097.278676885977 16:01:09 INFO - PROCESS | 1958 | |3;mootools.html;1540.699563585101;1560.2666746629084;1805.9367922122728;1899.3637131560927;1961.0586918279234;8412.831743365137;8940.061293564171;8943.552822358888;8948.686795962143;8951.328650351217;7700.88448673269;7955.045394552647;7965.920340796591;8062.879056814152;8686.174813392734;2106.915723371067;2137.946551336221;2139.433050241679;2235.441139715071;2317.3627252505526;2321.791038806507;2322.1175953137868;2323.744388117306;2330.3707998840305;2335.74306826249;2262.886855657219;2300.907963681451;2316.9652455213186;2321.2688003279;2329.4642232286583;2279.3048120323297;2307.065638416436;2313.652952057205;2315.1896836107394;2315.872627005514;2251.144565065265;2274.1358283852032;2294.265834932822;2297.2993237062688;2301.7813307735737;8130.780382942547;8258.917410825876;8675.56622168889;8807.339449541247;8823.735287941372;5170.1469257572835;5340.599455040888;5343.064963631349;5349.465053494659;5362;3086.27472543952;3507.3511400391008;3527.8412471438846;3543.450765131409;3632.8546858125906;1046.2362475393006;1049.979000419995;1056.746380868586;1077.2889892670878;1083.6694808083532;9998.45008524531;11283.37941413222;11500.539978400853;11513.481893314822;11533.538658453735;4356.346548017759;4548.7725613719185;4602.378678878308;4666.300054991779;4670.252759558454;9757.853632195523;9777.657781977596;9780.168685661656;9787.706368808947;9807.362521436227;5302.70835104073;5305.336832895888;5313.07021271276;5313.44208858072;5318;4686.507916668769;4805.927911081337;4853;4858.004109157614;4876.366072410635;3533.780845608261;3659.5425571803526;3665.248624032067;3740.0462881964927;3749.4000959846294;1241.0567968343944;1247.2516490105863;1247.906407019459;1264.2919964819546;1269.6698858296725;834.7478781827259;844.3450836360679;875.2385424680441;924.6687347003414;948.9667861624948;5584.46947539983;5688.744006519716;5737.598368114275;5817.418258174233;5872.265966754156;930.8603709443502;936.1153709744226;947.554649314821;957.1577012229194;978.5303054533864;3246.896055341148;3418.4701371287492;3773.962260377416;3841.7118716096406;3907.4529565860803;9973.002699730114;10485.3184543006;10632.734181645366;10642.361458312525;10666.893331066745;10318.690439286833;10525.315854469434;10598.152147828156;10606.15150787935;10611.204159688054;8233.423660343838;8389.286910612665;8407.53758543286;8408.579571021424;8415.663373465115;5436.40199578054;5561.6663000220115;5598.496135347838;5640.435956404491;5674.602777805514;9945.453000085065;9955;9961.601535938482;9964;10011.199104071802;9873.802523949624;9893.35693179941;10005.799884002425;10133.391996480235;10277.537510811882;6775.1531058617675;6903.447724182154;6997.965010174917;7002;7008.719651213894;7318.414526837947;7601.581912994618;7604.353629941517;8058.435909486514;8152.673893044212;7390.260973902567;7418.295261950106;7432.2567743225245;7505.324520793155;7519.285667861544;7293.52592081513;7305.561666300039;7307.890381644173;7356.190819009797;7393.371563417169;6854.725810967506;6872.965635171992;6876.656167191521;6943.51395402317;6963.025176475398;4890.6087512998165;4896.628943895715;4898.33872427232;4930.753462326941;5055.292259083658;4838.355398470479;4969;4985.401751789808;5056.317397151338;5116.4627714090975 16:01:09 INFO - PROCESS | 1958 | |4;prototype.html;301.6229712858926;306.59529421164075;310.6412094031393;315.1538120147403;319.69628852590046;5319.734013299339;5342.305500284967;5356.089464790985;5393.78424863006;5407.242985981966;4569.565891240335;4751.809927602892;4817.6627636065405;5239.449857764927;5369.999350483895;3744.8314825832904;3885.825137868803;3919.627635374635;3964.2071585682834;3992.441058251847;3580.5703315602163;3955.6439920407156;4013.4983127109113;4071.104357041461;4088.9386659200136;3765.4916586260915;3944.6055394460614;3995.1210733638554;3995.840166393341;4003.819828107742;3638.308721342963;3724.5902950675404;4011.418344340069;4017.658499027586;4034.5072323240443;3033.3023404616843;3467.271872906693;3468.265867066467;3497.440409534462;3497.5278337424375;4441.844535441244;5148.407933087706;5187.118189907725;5188.896222075575;5216.756794578368;4423.380726698265;4570.674504393722;4580.625812256343;4587.42657167854;4604.723716576983;5441.700706461143;5453.345598528163;5459.69971651559;5535.474129957647;5580.469855363734;3374.7682096035014;3762.6425489578446;3767.924641507182;3813.237352529505;3823;5568.610197286192;5764.625299355613;5787.565932555075;5801.361850196475;5818.2145410369485;3873.2640798248244;3873.5545412277947;3884.8834534964;3930.8945932712836;3934.6655534279334;3396.352768907078;3621.9637803621627;3835.1179228777537;3953.2488827122756;3960.7821569813937;3640.526731524885;4425.159219748238;4428.468583769968;4623.86128416148;4644.7213167210075;4940.728259945738;5200.557952574073;5546.614955569064;5608.383077861432;5622.313306008181;1300.7138429545485;1324.317976242236;1324.9072564920364;1338.3174580963778;1342.2282187742087;755.3051192902543;788.5451342273496;801.7372638095023;803.5058439059936;806.5482132162202;4334.41485399467;4905.190643543775;4954.826581069645;5089.770960306795;5245.737713114329;5014.849554513297;5721.656700597978;5735.3977832327;5747.195392645033;5765.769369225184;4613.838515651936;4616.538346165424;4924.778384972685;5254.894902101936;5286.60350473716;2583.6641236639116;2848.658161020691;2903.027485792241;2967.7683761238845;2968.1095671298526;4845.63657725672;5142.922856157161;5867.853303667357;5883.911741323884;5890.969080410911;4392.780360981938;5276.657017293864;5757.65454072757;5783.392743761929;5812.273465816773;5622.522085622686;5624.971875140598;5789.1026890831145;5794.62334948227;5837.416258374298;4926.926096108633;5314.707691077027;5549.805756798492;5578.414266501959;5651.717414129195;4899.706017638953;5221.530062294411;5488.62784303924;5552.666839989613;5633.971830140823;4872.731999739906;5322.574194064543;5375.758090885998;5782.190493331022;5796.362400135898;3880.7865567394065;3944.6252606002386;3961.3859851723028;3972.6226008529143;3975.5030621172355;4971.65198436106;5253.343332083489;5595.748191331481;5711.200431939449;5778.711064446845;4576.58810707038;5425.701586412785;5459.153831156177;5483.972580137074;5550.833474995757;4623.214053610827;5310.522053015247;5470.070088085115;5494.587905907153;5504.311961004874;4774.949511107551;5346.812861549827;5386.353637563518;5387.010209333857;5401.813594464322;4266;4487.955120448753;5186.2479940409185;5390.541803946709;5407.918881216706;5010.549050585465;5374.973125134349;5375.838724838261;5402;5411.729413529387 16:01:09 INFO - PROCESS | 1958 | |5;yui.html;682.3768965260364;708.4049398505255;726.6439444672109;733.952293100948;736.8047467421131;14647.267636618166;15294.617634559141;15306.234688265598;15324.999999999985;15659.765103523441;13795.862041379583;13902.304884755773;13903.443862245498;13905.721885562283;13926.094803837743;708.9361957423831;722.8229083874459;723.4646361692362;868.9913100868989;875.5403413208085;888.0054339140172;893.9687110951118;903.4714691905243;905.6105874473974;907.8910530736321;956.4882787708577;957.4159762544842;957.5643082397493;959.122403001253;960.5437417226797;736.1240124252123;758.116793935065;951.3103000324778;951.5432592355673;952.1383148250844;679.8708245433352;702.367868917978;704.4294121761338;707.5224223649017;708.5713143548131;14634.780478292834;14646.707065858729;14659.926700366537;14680.70638587233;14687.265636718228;13555.186688798703;13669;13701;13710.177389356571;13777.035607507478;12187.634370968884;12251.326177060258;12290.324032178227;12552.246865188117;12889.548865789746;4452.755098469583;4522.570355816225;4546.54534546546;4565.155446242423;4611.7694115294435;93435.06564934399;96514;96643;96675.033249668;100058;10659.949219296617;10916.345019298868;10945;10983;11371.260868043717;21394.35816925495;21488.462788430414;21546;21577.892110539346;21593.35219943404;7614.2766437188375;7679.961600191963;7705.537667739954;7778.8833167502535;7882.408819338572;4254.404383386328;4271.658267338606;4338.110687309094;4350.195213885378;4479.910401791946;3406.7785593936314;3480.199554102571;3517.7009954153673;3523.207278362348;3525;521.6244304101041;583.439897698206;596.2546816479401;657.9046038324416;659.8515334049896;486.91478991176405;547.904116779562;574.3538519165938;595.8361450601119;672.3545396419395;7299.817504562428;9005.594748236344;9052.683156089506;9053.913530376398;9177.265818734486;527.6677087274257;564.6301672404581;609.9878002439926;630.4641055103126;655.9081728558006;4294.463192100988;4403;4415.62467190286;4429.512753597101;4476.6418686505;104649;104904;105005.94994050114;107053.4647326774;108248;64555;64839.37901552499;84342.57828710818;90137.54931225302;93740;81615;83885.58057209675;83997.58001210078;84964;85911.5704421474;8016.679332826855;8053.395995300259;8057.395695322757;8073.434859559775;8286.254237118688;52515;53396;54367;54720.631984200714;54811.72594137004;73338;77760.61119694365;77856.61071694606;78530;79044.60477697574;11290.15323850698;11429.885701142883;11478.713032173928;11611.187216894736;12121.030317574396;12273.877261227273;12302.569410070604;12357.876421235673;12553.748925021266;12865.356732163167;10408.427536485566;11794.882051179378;11806.143698374844;12070.879291206975;12323.198992065487;11628.476718547516;11833.408329583313;11979.401029948642;12058.095642826998;12331.69170770738;11840;11862.81756800321;11884.34636095023;11893.524259029542;11979.101567382655;9455.957907461661;9555.18780903631;9707.320487565803;9945.30382873192;10074.042965918226;9350.532473376168;9875.703728888146;9932.205423565953;10019.649312274036;10038.347507411994 16:01:09 INFO - PROCESS | 1958 | __end_tp_report 16:01:09 INFO - PROCESS | 1958 | __start_cc_report 16:01:09 INFO - PROCESS | 1958 | _x_x_mozilla_cycle_collect,2831 16:01:09 INFO - PROCESS | 1958 | __end_cc_report 16:01:09 INFO - PROCESS | 1958 | __startTimestamp1477436469769__endTimestamp 16:01:09 INFO - PROCESS | 1958 | 16:01:09 INFO - PROCESS | 1958 | ------- Summary: start ------- 16:01:09 INFO - PROCESS | 1958 | Number of tests: 6 16:01:09 INFO - PROCESS | 1958 | 16:01:09 INFO - PROCESS | 1958 | [#0] dojo.html Cycles:165 Average:5745.59 Median:5902.11 stddev:634.17 (10.7%) stddev-sans-first:606.48 16:01:09 INFO - PROCESS | 1958 | Values: 3303.0 3304.3 3312.4 3349.4 3372.6 5639.0 5716.0 5742.7 5749.2 5754.3 4852.7 5689.7 5714.8 5836.5 5841.3 5089.3 5148.6 5196.6 5221.4 5241.2 5265.9 5275.0 5291.0 5311.2 5332.5 5229.1 5254.1 5267.2 5279.1 5319.9 5145.6 5156.9 5214.9 5220.8 5259.5 5189.8 5195.7 5203.8 5217.7 5270.6 5744.6 5747.9 5767.8 5774.9 5784.8 6109.8 6132.7 6167.5 6213.5 6267.5 6218.5 6278.6 6322.4 6326.7 6330.9 5830.1 5847.5 5849.0 5854.8 5920.4 5806.4 6119.5 6136.8 6211.0 6285.6 6119.7 6156.4 6163.2 6167.6 6180.3 6286.5 6286.7 6289.8 6295.6 6302.5 5994.6 6101.3 6104.3 6228.9 6234.2 6143.4 6234.4 6245.4 6283.9 6291.1 4940.4 4942.3 4946.5 4949.8 4968.7 4454.0 4506.9 4511.6 4520.4 4531.3 5650.6 5757.5 5790.1 5791.5 5847.2 6261.1 6297.6 6316.4 6318.7 6319.6 5871.2 5902.1 5906.9 5912.9 5942.9 5318.2 5349.0 5364.5 5370.7 5420.9 6187.2 6289.0 6297.6 6298.6 6315.8 6316.5 6322.3 6333.8 6335.7 6339.5 6214.2 6223.1 6250.8 6266.4 6290.0 5398.5 5983.9 6122.4 6251.0 6253.4 6265.4 6305.2 6312.9 6316.2 6334.1 5838.3 6029.8 6088.3 6095.2 6098.8 5946.6 6031.7 6038.3 6039.5 6041.9 5823.4 5874.1 5889.1 5896.5 5905.6 5990.2 6021.2 6022.2 6031.3 6037.2 5859.3 5866.8 5869.3 5869.8 5877.9 16:01:09 INFO - PROCESS | 1958 | 16:01:09 INFO - PROCESS | 1958 | [#1] ext.html Cycles:180 Average:71203.75 Median:19981.75 stddev:160608.41 (803.8%) stddev-sans-first:160971.18 16:01:09 INFO - PROCESS | 1958 | Values: 480.4 509.6 517.0 523.1 554.9 29743.1 38490.6 39661.8 39679.8 42084.6 41071.0 41462.6 41519.2 41525.0 41842.6 8114.1 8550.9 8748.9 9629.9 9684.3 8627.7 8757.3 8757.9 8760.6 8764.6 11283.7 11529.9 11554.6 11707.1 11721.9 11493.5 11576.6 11584.4 11587.8 11594.2 8546.4 8791.3 9454.4 11355.4 11393.7 31508.5 31745.4 31769.0 38383.0 39124.0 2922.4 3042.3 3254.8 3337.2 3623.9 29237.7 29960.8 30833.0 30834.0 30914.2 3109.5 3166.1 3229.9 3256.4 3293.7 472924.6 475030.0 475100.0 476970.0 477748.0 57714.0 58039.0 58167.0 58198.4 58263.7 61608.5 61638.0 61660.4 61682.7 61734.0 15695.6 15982.0 16006.0 16012.1 16046.2 12449.7 12542.2 12542.7 12561.2 12567.9 13835.0 14190.4 14244.5 15124.8 15887.0 6666.4 6904.7 7141.8 7308.2 7386.0 879.6 976.2 1025.7 1049.3 1054.3 28833.4 28932.4 29207.0 29577.6 29665.7 1059.7 1060.2 1093.5 1137.7 1205.4 14114.2 14887.6 14928.3 15344.9 15364.9 601000.0 604780.0 606352.0 606641.0 606986.0 48452.8 49386.5 56389.7 59125.0 59809.0 1300.0 1336.3 1343.8 1343.9 1349.9 29721.6 29844.9 29903.4 30121.5 30297.1 48568.5 49006.0 49090.0 49243.0 49307.5 612859.0 618123.0 629276.0 795752.0 795794.0 24695.0 24852.8 24946.5 25161.5 25198.0 44655.0 44720.8 44728.8 45437.3 45441.6 33731.7 36202.8 36339.6 37762.4 37842.8 36582.8 36741.1 37594.6 37605.1 37658.1 36562.8 36844.0 37069.3 38554.4 38815.4 31830.9 32267.5 33680.2 33693.7 33846.8 24307.5 24746.8 24807.3 25183.5 25310.2 16:01:09 INFO - PROCESS | 1958 | 16:01:09 INFO - PROCESS | 1958 | [#2] jquery.html Cycles:180 Average:33517.97 Median:1571.76 stddev:96806.33 (6159.1%) stddev-sans-first:97045.84 16:01:09 INFO - PROCESS | 1958 | Values: 340.1 350.5 372.5 375.2 403.1 14833.6 15011.0 15848.0 20201.6 20461.5 19925.0 20256.4 20857.0 20995.0 21179.0 5545.6 5704.5 6009.7 6019.5 6024.2 5513.4 5915.8 5982.2 5987.4 5987.6 5635.5 5776.7 5935.4 5939.3 5950.1 5022.2 5777.8 5844.9 5852.3 5854.6 4865.6 5068.8 5089.1 5095.4 5140.4 25189.2 25450.0 25605.0 25626.4 25653.1 2356.9 2386.3 2492.5 2633.1 2803.4 14652.0 15342.2 15905.3 16132.8 16187.0 1532.8 1589.2 1770.0 1858.6 1889.8 115235.0 118467.0 118715.0 118898.4 119732.0 10223.8 10501.3 10824.1 10909.3 11250.8 12310.7 13345.9 13600.5 13628.5 13629.5 8167.8 8214.2 8228.2 8373.9 8389.1 8206.2 8208.4 8226.9 8399.0 8413.0 6339.2 6424.3 6461.4 6479.6 6497.4 1583.3 1824.5 1854.3 1856.0 1859.8 843.3 965.8 966.7 991.9 996.5 20570.9 22035.3 22050.4 22073.0 22096.7 959.2 964.3 964.7 970.4 981.4 10727.9 10970.9 11429.3 11548.7 11562.4 577051.0 579511.0 579984.0 585452.0 598207.0 76660.0 79405.0 85491.6 95010.7 116698.2 874.3 922.5 975.1 976.4 981.3 14228.7 16221.0 19258.5 19545.3 19631.8 40749.4 50182.2 52011.0 52155.7 52707.0 73937.3 75923.0 76285.6 77908.0 80787.6 6540.7 7480.8 8049.5 8111.7 8283.6 12236.2 12663.7 13028.7 13129.1 13142.7 10698.1 10702.0 11043.4 11125.5 11278.3 10851.9 10881.9 10932.1 11156.9 11338.0 10540.3 11237.3 11529.5 11631.7 11664.2 7938.3 8050.4 8188.1 8225.6 8248.8 10371.4 10540.7 10685.0 10927.8 11097.3 16:01:09 INFO - PROCESS | 1958 | 16:01:09 INFO - PROCESS | 1958 | [#3] mootools.html Cycles:180 Average:5597.23 Median:5086.39 stddev:3134.95 (61.6%) stddev-sans-first:3128.92 16:01:09 INFO - PROCESS | 1958 | Values: 1540.7 1560.3 1805.9 1899.4 1961.1 8412.8 8940.1 8943.6 8948.7 8951.3 7700.9 7955.0 7965.9 8062.9 8686.2 2106.9 2137.9 2139.4 2235.4 2317.4 2321.8 2322.1 2323.7 2330.4 2335.7 2262.9 2300.9 2317.0 2321.3 2329.5 2279.3 2307.1 2313.7 2315.2 2315.9 2251.1 2274.1 2294.3 2297.3 2301.8 8130.8 8258.9 8675.6 8807.3 8823.7 5170.1 5340.6 5343.1 5349.5 5362.0 3086.3 3507.4 3527.8 3543.5 3632.9 1046.2 1050.0 1056.7 1077.3 1083.7 9998.5 11283.4 11500.5 11513.5 11533.5 4356.3 4548.8 4602.4 4666.3 4670.3 9757.9 9777.7 9780.2 9787.7 9807.4 5302.7 5305.3 5313.1 5313.4 5318.0 4686.5 4805.9 4853.0 4858.0 4876.4 3533.8 3659.5 3665.2 3740.0 3749.4 1241.1 1247.3 1247.9 1264.3 1269.7 834.7 844.3 875.2 924.7 949.0 5584.5 5688.7 5737.6 5817.4 5872.3 930.9 936.1 947.6 957.2 978.5 3246.9 3418.5 3774.0 3841.7 3907.5 9973.0 10485.3 10632.7 10642.4 10666.9 10318.7 10525.3 10598.2 10606.2 10611.2 8233.4 8389.3 8407.5 8408.6 8415.7 5436.4 5561.7 5598.5 5640.4 5674.6 9945.5 9955.0 9961.6 9964.0 10011.2 9873.8 9893.4 10005.8 10133.4 10277.5 6775.2 6903.4 6998.0 7002.0 7008.7 7318.4 7601.6 7604.4 8058.4 8152.7 7390.3 7418.3 7432.3 7505.3 7519.3 7293.5 7305.6 7307.9 7356.2 7393.4 6854.7 6873.0 6876.7 6943.5 6963.0 4890.6 4896.6 4898.3 4930.8 5055.3 4838.4 4969.0 4985.4 5056.3 5116.5 16:01:09 INFO - PROCESS | 1958 | 16:01:09 INFO - PROCESS | 1958 | [#4] prototype.html Cycles:180 Average:4455.53 Median:4963.24 stddev:1361.09 (27.4%) stddev-sans-first:1328.72 16:01:09 INFO - PROCESS | 1958 | Values: 301.6 306.6 310.6 315.2 319.7 5319.7 5342.3 5356.1 5393.8 5407.2 4569.6 4751.8 4817.7 5239.4 5370.0 3744.8 3885.8 3919.6 3964.2 3992.4 3580.6 3955.6 4013.5 4071.1 4088.9 3765.5 3944.6 3995.1 3995.8 4003.8 3638.3 3724.6 4011.4 4017.7 4034.5 3033.3 3467.3 3468.3 3497.4 3497.5 4441.8 5148.4 5187.1 5188.9 5216.8 4423.4 4570.7 4580.6 4587.4 4604.7 5441.7 5453.3 5459.7 5535.5 5580.5 3374.8 3762.6 3767.9 3813.2 3823.0 5568.6 5764.6 5787.6 5801.4 5818.2 3873.3 3873.6 3884.9 3930.9 3934.7 3396.4 3622.0 3835.1 3953.2 3960.8 3640.5 4425.2 4428.5 4623.9 4644.7 4940.7 5200.6 5546.6 5608.4 5622.3 1300.7 1324.3 1324.9 1338.3 1342.2 755.3 788.5 801.7 803.5 806.5 4334.4 4905.2 4954.8 5089.8 5245.7 5014.8 5721.7 5735.4 5747.2 5765.8 4613.8 4616.5 4924.8 5254.9 5286.6 2583.7 2848.7 2903.0 2967.8 2968.1 4845.6 5142.9 5867.9 5883.9 5891.0 4392.8 5276.7 5757.7 5783.4 5812.3 5622.5 5625.0 5789.1 5794.6 5837.4 4926.9 5314.7 5549.8 5578.4 5651.7 4899.7 5221.5 5488.6 5552.7 5634.0 4872.7 5322.6 5375.8 5782.2 5796.4 3880.8 3944.6 3961.4 3972.6 3975.5 4971.7 5253.3 5595.7 5711.2 5778.7 4576.6 5425.7 5459.2 5484.0 5550.8 4623.2 5310.5 5470.1 5494.6 5504.3 4774.9 5346.8 5386.4 5387.0 5401.8 4266.0 4488.0 5186.2 5390.5 5407.9 5010.5 5375.0 5375.8 5402.0 5411.7 16:01:09 INFO - PROCESS | 1958 | 16:01:09 INFO - PROCESS | 1958 | [#5] yui.html Cycles:180 Average:20197.78 Median:26518.31 stddev:29466.84 (111.1%) stddev-sans-first:29513.07 16:01:09 INFO - PROCESS | 1958 | Values: 682.4 708.4 726.6 734.0 736.8 14647.3 15294.6 15306.2 15325.0 15659.8 13795.9 13902.3 13903.4 13905.7 13926.1 708.9 722.8 723.5 869.0 875.5 888.0 894.0 903.5 905.6 907.9 956.5 957.4 957.6 959.1 960.5 736.1 758.1 951.3 951.5 952.1 679.9 702.4 704.4 707.5 708.6 14634.8 14646.7 14659.9 14680.7 14687.3 13555.2 13669.0 13701.0 13710.2 13777.0 12187.6 12251.3 12290.3 12552.2 12889.5 4452.8 4522.6 4546.5 4565.2 4611.8 93435.1 96514.0 96643.0 96675.0 100058.0 10659.9 10916.3 10945.0 10983.0 11371.3 21394.4 21488.5 21546.0 21577.9 21593.4 7614.3 7680.0 7705.5 7778.9 7882.4 4254.4 4271.7 4338.1 4350.2 4479.9 3406.8 3480.2 3517.7 3523.2 3525.0 521.6 583.4 596.3 657.9 659.9 486.9 547.9 574.4 595.8 672.4 7299.8 9005.6 9052.7 9053.9 9177.3 527.7 564.6 610.0 630.5 655.9 4294.5 4403.0 4415.6 4429.5 4476.6 104649.0 104904.0 105005.9 107053.5 108248.0 64555.0 64839.4 84342.6 90137.5 93740.0 81615.0 83885.6 83997.6 84964.0 85911.6 8016.7 8053.4 8057.4 8073.4 8286.3 52515.0 53396.0 54367.0 54720.6 54811.7 73338.0 77760.6 77856.6 78530.0 79044.6 11290.2 11429.9 11478.7 11611.2 12121.0 12273.9 12302.6 12357.9 12553.7 12865.4 10408.4 11794.9 11806.1 12070.9 12323.2 11628.5 11833.4 11979.4 12058.1 12331.7 11840.0 11862.8 11884.3 11893.5 11979.1 9456.0 9555.2 9707.3 9945.3 10074.0 9350.5 9875.7 9932.2 10019.6 10038.3 16:01:09 INFO - PROCESS | 1958 | -------- Summary: end -------- 16:01:09 INFO - PROCESS | 1958 | 16:01:10 INFO - TEST-INFO | 1958: exit 0 16:01:10 INFO - TEST-OK | dromaeo_css | took 1118955ms 16:01:10 INFO - TEST-START | kraken 16:01:10 INFO - operating with platform_type : mac_ 16:01:10 INFO - Initialising browser for kraken test... 16:01:10 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpcEYA6B/profile http://localhost:50665/getInfo.html) 16:01:12 INFO - PROCESS | 1961 | __metrics Screen width/height:1600/1200 16:01:12 INFO - PROCESS | 1961 | colorDepth:24 16:01:12 INFO - PROCESS | 1961 | Browser inner width/height: 1024/689 16:01:12 INFO - PROCESS | 1961 | __metrics 16:01:12 INFO - PROCESS | 1961 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:01:12 INFO - PROCESS | 1961 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:01:13 INFO - TEST-INFO | 1961: exit 0 16:01:13 INFO - Browser initialized. 16:01:13 INFO - Running cycle 1/1 for kraken test... 16:01:13 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/T/tmpcEYA6B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:01:25 INFO - PROCESS | 1962 | RSS: Main: 231317504 16:01:25 INFO - PROCESS | 1962 | 16:01:28 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50665/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50665/tests/kraken/driver.html?testName=audio-beat-detection) 16:01:29 INFO - PROCESS | 1962 | RSS: Main: 290795520 16:01:29 INFO - PROCESS | 1962 | 16:01:32 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50665/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50665/tests/kraken/driver.html?testName=audio-dft) 16:01:32 INFO - PROCESS | 1962 | RSS: Main: 292876288 16:01:32 INFO - PROCESS | 1962 | 16:01:36 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50665/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50665/tests/kraken/driver.html?testName=audio-fft) 16:01:36 INFO - PROCESS | 1962 | RSS: Main: 384151552 16:01:36 INFO - PROCESS | 1962 | 16:01:38 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50665/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50665/tests/kraken/driver.html?testName=audio-oscillator) 16:01:39 INFO - PROCESS | 1962 | RSS: Main: 285003776 16:01:39 INFO - PROCESS | 1962 | 16:01:41 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50665/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50665/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:01:42 INFO - PROCESS | 1962 | RSS: Main: 289234944 16:01:42 INFO - PROCESS | 1962 | 16:01:44 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50665/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50665/tests/kraken/driver.html?testName=imaging-darkroom) 16:01:45 INFO - PROCESS | 1962 | RSS: Main: 326070272 16:01:45 INFO - PROCESS | 1962 | 16:01:48 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50665/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50665/tests/kraken/driver.html?testName=imaging-desaturate) 16:01:48 INFO - PROCESS | 1962 | RSS: Main: 328347648 16:01:48 INFO - PROCESS | 1962 | 16:01:51 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50665/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50665/tests/kraken/driver.html?testName=json-parse-financial) 16:01:52 INFO - PROCESS | 1962 | RSS: Main: 326565888 16:01:52 INFO - PROCESS | 1962 | 16:01:53 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50665/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50665/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:01:54 INFO - PROCESS | 1962 | RSS: Main: 302211072 16:01:54 INFO - PROCESS | 1962 | 16:01:56 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50665/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50665/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:01:57 INFO - PROCESS | 1962 | RSS: Main: 307908608 16:01:57 INFO - PROCESS | 1962 | 16:01:59 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50665/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50665/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:01:59 INFO - PROCESS | 1962 | RSS: Main: 309596160 16:01:59 INFO - PROCESS | 1962 | 16:02:02 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50665/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50665/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:02:03 INFO - PROCESS | 1962 | RSS: Main: 316637184 16:02:03 INFO - PROCESS | 1962 | 16:02:06 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50665/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50665/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:02:07 INFO - PROCESS | 1962 | RSS: Main: 316735488 16:02:07 INFO - PROCESS | 1962 | 16:02:08 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:50665/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50665/tests/kraken/driver.html?testName=ai-astar) 16:02:09 INFO - PROCESS | 1962 | RSS: Main: 360431616 16:02:09 INFO - PROCESS | 1962 | 16:02:09 INFO - PROCESS | 1962 | __start_tp_report 16:02:09 INFO - PROCESS | 1962 | _x_x_mozilla_page_load 16:02:09 INFO - PROCESS | 1962 | _x_x_mozilla_page_load_details 16:02:09 INFO - PROCESS | 1962 | |i|pagename|runs| 16:02:09 INFO - PROCESS | 1962 | |0;ai-astar;135;165;117;118;111;112;112;112;110;112 16:02:09 INFO - PROCESS | 1962 | |1;audio-beat-detection;147;110;116;159;141;144;132;112;143;111 16:02:09 INFO - PROCESS | 1962 | |2;audio-dft;184;185;184;184;185;197;224;220;180;184 16:02:09 INFO - PROCESS | 1962 | |3;audio-fft;80;59;59;88;62;59;57;58;81;58 16:02:09 INFO - PROCESS | 1962 | |4;audio-oscillator;87;68;91;68;67;69;92;67;60;77 16:02:09 INFO - PROCESS | 1962 | |5;imaging-gaussian-blur;88;86;87;84;88;84;88;86;88;84 16:02:09 INFO - PROCESS | 1962 | |6;imaging-darkroom;94;93;94;94;93;96;93;93;93;96 16:02:09 INFO - PROCESS | 1962 | |7;imaging-desaturate;82;78;78;114;129;122;86;83;74;124 16:02:09 INFO - PROCESS | 1962 | |8;json-parse-financial;59;55;55;56;55;55;54;54;55;54 16:02:09 INFO - PROCESS | 1962 | |9;json-stringify-tinderbox;70;65;69;83;75;72;71;71;71;70 16:02:09 INFO - PROCESS | 1962 | |10;stanford-crypto-aes;91;86;86;86;86;85;84;86;84;86 16:02:09 INFO - PROCESS | 1962 | |11;stanford-crypto-ccm;145;145;146;146;146;144;148;145;179;148 16:02:09 INFO - PROCESS | 1962 | |12;stanford-crypto-pbkdf2;172;172;172;172;171;166;225;236;191;170 16:02:09 INFO - PROCESS | 1962 | |13;stanford-crypto-sha256-iterative;69;69;67;68;69;67;69;69;68;69 16:02:09 INFO - PROCESS | 1962 | __end_tp_report 16:02:09 INFO - PROCESS | 1962 | __start_cc_report 16:02:09 INFO - PROCESS | 1962 | _x_x_mozilla_cycle_collect,2016 16:02:09 INFO - PROCESS | 1962 | __end_cc_report 16:02:09 INFO - PROCESS | 1962 | __startTimestamp1477436529200__endTimestamp 16:02:09 INFO - PROCESS | 1962 | 16:02:09 INFO - PROCESS | 1962 | ------- Summary: start ------- 16:02:09 INFO - PROCESS | 1962 | Number of tests: 14 16:02:09 INFO - PROCESS | 1962 | 16:02:09 INFO - PROCESS | 1962 | [#0] ai-astar Cycles:10 Average:120.40 Median:114.50 stddev:17.32 (15.1%) stddev-sans-first:17.54 16:02:09 INFO - PROCESS | 1962 | Values: 135.0 165.0 117.0 118.0 111.0 112.0 112.0 112.0 110.0 112.0 16:02:09 INFO - PROCESS | 1962 | 16:02:09 INFO - PROCESS | 1962 | [#1] audio-beat-detection Cycles:10 Average:131.50 Median:142.00 stddev:17.88 (12.6%) stddev-sans-first:18.07 16:02:09 INFO - PROCESS | 1962 | Values: 147.0 110.0 116.0 159.0 141.0 144.0 132.0 112.0 143.0 111.0 16:02:09 INFO - PROCESS | 1962 | 16:02:09 INFO - PROCESS | 1962 | [#2] audio-dft Cycles:10 Average:192.70 Median:185.00 stddev:16.08 (8.7%) stddev-sans-first:16.74 16:02:09 INFO - PROCESS | 1962 | Values: 184.0 185.0 184.0 184.0 185.0 197.0 224.0 220.0 180.0 184.0 16:02:09 INFO - PROCESS | 1962 | 16:02:09 INFO - PROCESS | 1962 | [#3] audio-fft Cycles:10 Average:66.10 Median:60.50 stddev:11.91 (19.7%) stddev-sans-first:11.52 16:02:09 INFO - PROCESS | 1962 | Values: 80.0 59.0 59.0 88.0 62.0 59.0 57.0 58.0 81.0 58.0 16:02:09 INFO - PROCESS | 1962 | 16:02:09 INFO - PROCESS | 1962 | [#4] audio-oscillator Cycles:10 Average:74.60 Median:73.00 stddev:11.44 (15.7%) stddev-sans-first:11.22 16:02:09 INFO - PROCESS | 1962 | Values: 87.0 68.0 91.0 68.0 67.0 69.0 92.0 67.0 60.0 77.0 16:02:09 INFO - PROCESS | 1962 | 16:02:09 INFO - PROCESS | 1962 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.50 stddev:1.77 (2.0%) stddev-sans-first:1.76 16:02:09 INFO - PROCESS | 1962 | Values: 88.0 86.0 87.0 84.0 88.0 84.0 88.0 86.0 88.0 84.0 16:02:09 INFO - PROCESS | 1962 | 16:02:09 INFO - PROCESS | 1962 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:1.20 (1.3%) stddev-sans-first:1.27 16:02:09 INFO - PROCESS | 1962 | Values: 94.0 93.0 94.0 94.0 93.0 96.0 93.0 93.0 93.0 96.0 16:02:09 INFO - PROCESS | 1962 | 16:02:09 INFO - PROCESS | 1962 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:78.00 stddev:22.26 (28.5%) stddev-sans-first:22.94 16:02:09 INFO - PROCESS | 1962 | Values: 82.0 78.0 78.0 114.0 129.0 122.0 86.0 83.0 74.0 124.0 16:02:09 INFO - PROCESS | 1962 | 16:02:09 INFO - PROCESS | 1962 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:1.48 (2.7%) stddev-sans-first:0.67 16:02:09 INFO - PROCESS | 1962 | Values: 59.0 55.0 55.0 56.0 55.0 55.0 54.0 54.0 55.0 54.0 16:02:09 INFO - PROCESS | 1962 | 16:02:09 INFO - PROCESS | 1962 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:71.00 stddev:4.69 (6.6%) stddev-sans-first:4.94 16:02:09 INFO - PROCESS | 1962 | Values: 70.0 65.0 69.0 83.0 75.0 72.0 71.0 71.0 71.0 70.0 16:02:09 INFO - PROCESS | 1962 | 16:02:09 INFO - PROCESS | 1962 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:1.94 (2.3%) stddev-sans-first:0.88 16:02:09 INFO - PROCESS | 1962 | Values: 91.0 86.0 86.0 86.0 86.0 85.0 84.0 86.0 84.0 86.0 16:02:09 INFO - PROCESS | 1962 | 16:02:09 INFO - PROCESS | 1962 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:146.00 stddev:10.55 (7.2%) stddev-sans-first:11.08 16:02:09 INFO - PROCESS | 1962 | Values: 145.0 145.0 146.0 146.0 146.0 144.0 148.0 145.0 179.0 148.0 16:02:09 INFO - PROCESS | 1962 | 16:02:09 INFO - PROCESS | 1962 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.70 Median:172.00 stddev:25.15 (14.6%) stddev-sans-first:26.26 16:02:09 INFO - PROCESS | 1962 | Values: 172.0 172.0 172.0 172.0 171.0 166.0 225.0 236.0 191.0 170.0 16:02:09 INFO - PROCESS | 1962 | 16:02:09 INFO - PROCESS | 1962 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:0.84 (1.2%) stddev-sans-first:0.87 16:02:09 INFO - PROCESS | 1962 | Values: 69.0 69.0 67.0 68.0 69.0 67.0 69.0 69.0 68.0 69.0 16:02:09 INFO - PROCESS | 1962 | -------- Summary: end -------- 16:02:09 INFO - PROCESS | 1962 | 16:02:10 INFO - TEST-INFO | 1962: exit 0 16:02:10 INFO - TEST-OK | kraken | took 59755ms 16:02:10 INFO - SUITE-END | took 1178s 16:02:10 INFO - Completed test suite (00:19:38) 16:02:10 INFO - javascript benchmark 16:02:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3302.950455743164, 3304.3060957198995, 3312.403767321882, 3349.447341188704, 3372.6458721834206, 5638.984982703112, 5715.971420142899, 5742.712864356776, 5749.223854779603, 5754.2519472468575, 4852.733099679516, 5689.687067211302, 5714.77140914364, 5836.533077353812, 5841.269841269841, 5089.287499750038, 5148.588112950955, 5196.58427325815, 5221.399539053001, 5241.161414173733, 5265.8946821063555, 5275.0, 5291.0, 5311.2298716686255, 5332.520073193412, 5229.111051121318, 5254.08053590624, 5267.183586544092, 5279.128943724281, 5319.9202011969855, 5145.588352931794, 5156.871078223037, 5214.921776173361, 5220.791168353299, 5259.474052594748, 5189.766460509249, 5195.662281951699, 5203.791848326063, 5217.660852044605, 5270.5520030797425, 5744.597878148531, 5747.856303592402, 5767.798127065575, 5774.884502309972, 5784.826455206308, 6109.755609775603, 6132.6614613216525, 6167.506599472032, 6213.5339849511465, 6267.5299352548745, 6218.4714299284615, 6278.623282603013, 6322.399372059647, 6326.715297811609, 6330.936690633081, 5830.125481177814, 5847.532197424196, 5848.9707551462825, 5854.765809367663, 5920.437558431942, 5806.361300256968, 6119.4798442132915, 6136.764169924236, 6210.968945155245, 6285.622862628257, 6119.653521814353, 6156.384361563808, 6163.1679723237685, 6167.629942203393, 6180.289266734293, 6286.49708023357, 6286.717097730613, 6289.811305660837, 6295.622262664255, 6302.527310451735, 5994.610350327215, 6101.297630694255, 6104.307579233822, 6228.941080016318, 6234.1583886175695, 6143.447089761943, 6234.37656234382, 6245.375462453719, 6283.937160628427, 6291.056341548804, 4940.407151141886, 4942.283368911488, 4946.480619534897, 4949.7772600233075, 4968.677035992649, 4454.020115574568, 4506.909861802746, 4511.593956543927, 4520.412346395014, 4531.252343363374, 5650.576206784425, 5757.539396848242, 5790.131480277992, 5791.478766910998, 5847.239858818411, 6261.060840873905, 6297.622142671455, 6316.368363163647, 6318.684065796691, 6319.6208227506495, 5871.207387002785, 5902.1146827976145, 5906.8818623627285, 5912.852178695567, 5942.851428714231, 5318.202269659505, 5349.0, 5364.490373414519, 5370.70461124634, 5420.891582168335, 6187.195664563668, 6289.0, 6297.622142671455, 6298.559100863079, 6315.842103947254, 6316.494680425463, 6322.33615470369, 6333.841653958688, 6335.683215839282, 6339.461145802658, 6214.161088253028, 6223.128761973418, 6250.781222657185, 6266.404691554295, 6289.993601023814, 5398.541124004503, 5983.9401605983385, 6122.367660829107, 6250.968745156245, 6253.437190652863, 6265.373462653881, 6305.211848518935, 6312.905306420315, 6316.242050953915, 6334.144890439732, 5838.299404071538, 6029.758809647565, 6088.330283668882, 6095.207623008981, 6098.847528811815, 5946.643201407929, 6031.728572214173, 6038.3357830637715, 6039.547033972557, 6041.909371359521, 5823.4467725566, 5874.060150375919, 5889.087191485327, 5896.528277737856, 5905.645661260338, 5990.161377407254, 6021.2473440819895, 6022.1870047543025, 6031.336552979256, 6037.245344331958, 5859.267591551056, 5866.823995280149, 5869.295684517714, 5869.7945571904775, 5877.911831322448], "value": 5704.740224674946, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.3659169895739, 509.62287906948853, 517.0305676855895, 523.1107117899569, 554.8708378449855, 29743.107706768777, 38490.61509384909, 39661.801690991575, 39679.801600992025, 42084.57915420845, 41071.0, 41462.58537414625, 41519.16961660765, 41524.961875953115, 41842.581574184325, 8114.107448180695, 8550.871736923951, 8748.8687669685, 9629.855552166724, 9684.273679474067, 8627.741167764978, 8757.25563327118, 8757.868631970525, 8760.561971901412, 8764.56177191141, 11283.66149015531, 11529.884701153007, 11554.595589154382, 11707.121965852553, 11721.941390293037, 11493.482793274281, 11576.59481918133, 11584.362860042695, 11587.768244635145, 11594.188406811527, 8546.359023073295, 8791.252743516809, 9454.385464944757, 11355.432228388547, 11393.658190254306, 31508.527372089437, 31745.365092698015, 31769.0, 38383.0, 39124.0, 2922.4447355002694, 3042.3002709376747, 3254.844530191795, 3337.182390314364, 3623.8548071999912, 29237.707622923925, 29960.801567937255, 30833.0, 30834.0, 30914.227144321347, 3109.518024706174, 3166.129314438525, 3229.9031029069165, 3256.397566450214, 3293.7035666790102, 472924.63537682436, 475030.0, 475100.0, 476970.0, 477748.0, 57714.0, 58039.0, 58167.0, 58198.41801582015, 58263.70868145632, 61608.45978850475, 61638.0, 61660.38339616636, 61682.69158654268, 61734.0, 15695.607609809618, 15982.041077535385, 16006.0, 16012.11933343654, 16046.197690115447, 12449.688757781129, 12542.24746515212, 12542.68643283907, 12561.183523070971, 12567.874321256853, 13835.03154779176, 14190.432382704783, 14244.501442449464, 15124.848751512343, 15887.046777193405, 6666.366695163952, 6904.719074174044, 7141.82145446368, 7308.159561650372, 7385.963070184722, 879.5909901895649, 976.2336565795958, 1025.6717850287837, 1049.2550289294686, 1054.288355360129, 28833.423331533253, 28932.42135157285, 29207.0, 29577.55633665497, 29665.703342966724, 1059.7138772531373, 1060.2419270221828, 1093.512822561316, 1137.7155711072232, 1205.3671822293365, 14114.22371769542, 14887.553373398816, 14928.32822522989, 15344.92585519003, 15364.923175384052, 601000.0, 604780.0, 606352.0, 606641.0, 606986.0, 48452.757736211795, 49386.506134938194, 56389.7180514103, 59125.0, 59809.0, 1299.9870001300055, 1336.2583766009764, 1343.7514059898754, 1343.946242150303, 1349.8582648821732, 29721.554176687798, 29844.85077574598, 29903.442506212177, 30121.548176776927, 30297.148942735108, 48568.51431485781, 49006.0, 49090.01819963652, 49243.0, 49307.50692493029, 612859.0, 618123.0, 629276.0, 795752.0, 795794.0, 24695.0, 24852.751472485044, 24946.501069978134, 25161.496770064863, 25198.0, 44655.0, 44720.77639611781, 44728.77635611801, 45437.31844022409, 45441.63675089752, 33731.662683373834, 36202.8189859049, 36339.63660363468, 37762.43356349712, 37842.81078594589, 36582.8170859144, 36741.08147296339, 37594.624053760206, 37605.05987350229, 37658.05854853541, 36562.8171859139, 36844.0, 37069.25861482809, 38554.421683675326, 38815.41776873293, 31830.885918992724, 32267.51598726068, 33680.15799604932, 33693.66306337003, 33846.83076584601, 24307.513849723262, 24746.752532474446, 24807.25578232656, 25183.496330073664, 25310.240692779247], "value": 19598.948009369764, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.0919544815343, 350.49703675226067, 372.51572955158287, 375.18959048455343, 403.10108458138353, 14833.554993350202, 15011.0, 15848.049117052971, 20201.59596808063, 20461.48846278844, 19925.0, 20256.392308230777, 20857.0, 20994.95025248739, 21179.0, 5545.556355491572, 5704.458076482728, 6009.699515024253, 6019.518438524908, 6024.1566180734735, 5513.393526712059, 5915.792947246847, 5982.192404025466, 5987.401259873999, 5987.580869339148, 5635.464630860082, 5776.740046697909, 5935.436133567304, 5939.316978547457, 5950.107483877431, 5022.17134172861, 5777.826665200051, 5844.941550584504, 5852.297724273072, 5854.619449735754, 4865.635077369211, 5068.797248110071, 5089.083964886319, 5095.363079615048, 5140.357455318085, 25189.24432267035, 25450.0, 25604.97580096794, 25626.359341016625, 25653.102141425148, 2356.882155892216, 2386.284114765581, 2492.526419980216, 2633.0652618320414, 2803.4252978139434, 14652.0, 15342.156181410019, 15905.284262208113, 16132.838671613252, 16187.0, 1532.785410042595, 1589.2212815720213, 1769.9911500442415, 1858.6189831084596, 1889.763779527559, 115235.0, 118467.0, 118715.0, 118898.40550797277, 119732.0, 10223.795524089477, 10501.264911456125, 10824.13406927444, 10909.290896091728, 11250.831237531444, 12310.692232694255, 13345.932325413944, 13600.455981760817, 13628.523001694894, 13629.522966696119, 8167.79580510492, 8214.178582141738, 8228.177182281725, 8373.874391884126, 8389.07720150783, 8206.22040906113, 8208.384371172186, 8226.917730822735, 8399.0, 8412.990441147102, 6339.207599050119, 6424.293327733945, 6461.424924206151, 6479.611223326616, 6497.350264973559, 1583.2875206157275, 1824.5447300554792, 1854.313903855582, 1855.9536011599548, 1859.841913437346, 843.3337663245967, 965.7826988927435, 966.7003228999033, 991.9008099190023, 996.5415908681942, 20570.897145514475, 22035.338939831832, 22050.44873878134, 22073.0, 22096.668549971764, 959.2469911119738, 964.344245912786, 964.7057647417605, 970.427447805798, 981.4454833019321, 10727.946360268148, 10970.890291097146, 11429.314241145557, 11548.711282217844, 11562.421878906021, 577051.0, 579511.0, 579984.0, 585452.0, 598207.0, 76660.0, 79405.0, 85491.57254213688, 95010.72237301906, 116698.24952625718, 874.2918236228548, 922.4557511068367, 975.0834215837091, 976.4385478349835, 981.2983716642635, 14228.715425691635, 16221.0, 19258.518537036125, 19545.315913942944, 19631.803681962996, 40749.38875916805, 50182.247266291764, 52011.0, 52155.696107597614, 52707.0, 73937.26062739304, 75923.0, 76285.61857190679, 77908.0, 80787.59606201931, 6540.738370465128, 7480.812979675552, 8049.476784009021, 8111.675532978851, 8283.58582070882, 12236.211210463032, 12663.683407914876, 13028.739425211632, 13129.080964332405, 13142.671433214246, 10698.14414846826, 10702.0, 11043.39261340634, 11125.499352528994, 11278.323300601991, 10851.945740271249, 10881.945590271998, 10932.125429965425, 11156.944215278872, 11338.0, 10540.314879532805, 11237.3257604544, 11529.538818447503, 11631.6510504685, 11664.241824281395, 7938.293266947634, 8050.355971522381, 8188.086334383339, 8225.629846656795, 8248.793780155544, 10371.377717336682, 10540.683779486628, 10685.0, 10927.781444370909, 11097.278676885977], "value": 9506.205731528762, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1540.699563585101, 1560.2666746629084, 1805.9367922122728, 1899.3637131560927, 1961.0586918279234, 8412.831743365137, 8940.061293564171, 8943.552822358888, 8948.686795962143, 8951.328650351217, 7700.88448673269, 7955.045394552647, 7965.920340796591, 8062.879056814152, 8686.174813392734, 2106.915723371067, 2137.946551336221, 2139.433050241679, 2235.441139715071, 2317.3627252505526, 2321.791038806507, 2322.1175953137868, 2323.744388117306, 2330.3707998840305, 2335.74306826249, 2262.886855657219, 2300.907963681451, 2316.9652455213186, 2321.2688003279, 2329.4642232286583, 2279.3048120323297, 2307.065638416436, 2313.652952057205, 2315.1896836107394, 2315.872627005514, 2251.144565065265, 2274.1358283852032, 2294.265834932822, 2297.2993237062688, 2301.7813307735737, 8130.780382942547, 8258.917410825876, 8675.56622168889, 8807.339449541247, 8823.735287941372, 5170.1469257572835, 5340.599455040888, 5343.064963631349, 5349.465053494659, 5362.0, 3086.27472543952, 3507.3511400391008, 3527.8412471438846, 3543.450765131409, 3632.8546858125906, 1046.2362475393006, 1049.979000419995, 1056.746380868586, 1077.2889892670878, 1083.6694808083532, 9998.45008524531, 11283.37941413222, 11500.539978400853, 11513.481893314822, 11533.538658453735, 4356.346548017759, 4548.7725613719185, 4602.378678878308, 4666.300054991779, 4670.252759558454, 9757.853632195523, 9777.657781977596, 9780.168685661656, 9787.706368808947, 9807.362521436227, 5302.70835104073, 5305.336832895888, 5313.07021271276, 5313.44208858072, 5318.0, 4686.507916668769, 4805.927911081337, 4853.0, 4858.004109157614, 4876.366072410635, 3533.780845608261, 3659.5425571803526, 3665.248624032067, 3740.0462881964927, 3749.4000959846294, 1241.0567968343944, 1247.2516490105863, 1247.906407019459, 1264.2919964819546, 1269.6698858296725, 834.7478781827259, 844.3450836360679, 875.2385424680441, 924.6687347003414, 948.9667861624948, 5584.46947539983, 5688.744006519716, 5737.598368114275, 5817.418258174233, 5872.265966754156, 930.8603709443502, 936.1153709744226, 947.554649314821, 957.1577012229194, 978.5303054533864, 3246.896055341148, 3418.4701371287492, 3773.962260377416, 3841.7118716096406, 3907.4529565860803, 9973.002699730114, 10485.3184543006, 10632.734181645366, 10642.361458312525, 10666.893331066745, 10318.690439286833, 10525.315854469434, 10598.152147828156, 10606.15150787935, 10611.204159688054, 8233.423660343838, 8389.286910612665, 8407.53758543286, 8408.579571021424, 8415.663373465115, 5436.40199578054, 5561.6663000220115, 5598.496135347838, 5640.435956404491, 5674.602777805514, 9945.453000085065, 9955.0, 9961.601535938482, 9964.0, 10011.199104071802, 9873.802523949624, 9893.35693179941, 10005.799884002425, 10133.391996480235, 10277.537510811882, 6775.1531058617675, 6903.447724182154, 6997.965010174917, 7002.0, 7008.719651213894, 7318.414526837947, 7601.581912994618, 7604.353629941517, 8058.435909486514, 8152.673893044212, 7390.260973902567, 7418.295261950106, 7432.2567743225245, 7505.324520793155, 7519.285667861544, 7293.52592081513, 7305.561666300039, 7307.890381644173, 7356.190819009797, 7393.371563417169, 6854.725810967506, 6872.965635171992, 6876.656167191521, 6943.51395402317, 6963.025176475398, 4890.6087512998165, 4896.628943895715, 4898.33872427232, 4930.753462326941, 5055.292259083658, 4838.355398470479, 4969.0, 4985.401751789808, 5056.317397151338, 5116.4627714090975], "value": 4506.061119554869, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.6229712858926, 306.59529421164075, 310.6412094031393, 315.1538120147403, 319.69628852590046, 5319.734013299339, 5342.305500284967, 5356.089464790985, 5393.78424863006, 5407.242985981966, 4569.565891240335, 4751.809927602892, 4817.6627636065405, 5239.449857764927, 5369.999350483895, 3744.8314825832904, 3885.825137868803, 3919.627635374635, 3964.2071585682834, 3992.441058251847, 3580.5703315602163, 3955.6439920407156, 4013.4983127109113, 4071.104357041461, 4088.9386659200136, 3765.4916586260915, 3944.6055394460614, 3995.1210733638554, 3995.840166393341, 4003.819828107742, 3638.308721342963, 3724.5902950675404, 4011.418344340069, 4017.658499027586, 4034.5072323240443, 3033.3023404616843, 3467.271872906693, 3468.265867066467, 3497.440409534462, 3497.5278337424375, 4441.844535441244, 5148.407933087706, 5187.118189907725, 5188.896222075575, 5216.756794578368, 4423.380726698265, 4570.674504393722, 4580.625812256343, 4587.42657167854, 4604.723716576983, 5441.700706461143, 5453.345598528163, 5459.69971651559, 5535.474129957647, 5580.469855363734, 3374.7682096035014, 3762.6425489578446, 3767.924641507182, 3813.237352529505, 3823.0, 5568.610197286192, 5764.625299355613, 5787.565932555075, 5801.361850196475, 5818.2145410369485, 3873.2640798248244, 3873.5545412277947, 3884.8834534964, 3930.8945932712836, 3934.6655534279334, 3396.352768907078, 3621.9637803621627, 3835.1179228777537, 3953.2488827122756, 3960.7821569813937, 3640.526731524885, 4425.159219748238, 4428.468583769968, 4623.86128416148, 4644.7213167210075, 4940.728259945738, 5200.557952574073, 5546.614955569064, 5608.383077861432, 5622.313306008181, 1300.7138429545485, 1324.317976242236, 1324.9072564920364, 1338.3174580963778, 1342.2282187742087, 755.3051192902543, 788.5451342273496, 801.7372638095023, 803.5058439059936, 806.5482132162202, 4334.41485399467, 4905.190643543775, 4954.826581069645, 5089.770960306795, 5245.737713114329, 5014.849554513297, 5721.656700597978, 5735.3977832327, 5747.195392645033, 5765.769369225184, 4613.838515651936, 4616.538346165424, 4924.778384972685, 5254.894902101936, 5286.60350473716, 2583.6641236639116, 2848.658161020691, 2903.027485792241, 2967.7683761238845, 2968.1095671298526, 4845.63657725672, 5142.922856157161, 5867.853303667357, 5883.911741323884, 5890.969080410911, 4392.780360981938, 5276.657017293864, 5757.65454072757, 5783.392743761929, 5812.273465816773, 5622.522085622686, 5624.971875140598, 5789.1026890831145, 5794.62334948227, 5837.416258374298, 4926.926096108633, 5314.707691077027, 5549.805756798492, 5578.414266501959, 5651.717414129195, 4899.706017638953, 5221.530062294411, 5488.62784303924, 5552.666839989613, 5633.971830140823, 4872.731999739906, 5322.574194064543, 5375.758090885998, 5782.190493331022, 5796.362400135898, 3880.7865567394065, 3944.6252606002386, 3961.3859851723028, 3972.6226008529143, 3975.5030621172355, 4971.65198436106, 5253.343332083489, 5595.748191331481, 5711.200431939449, 5778.711064446845, 4576.58810707038, 5425.701586412785, 5459.153831156177, 5483.972580137074, 5550.833474995757, 4623.214053610827, 5310.522053015247, 5470.070088085115, 5494.587905907153, 5504.311961004874, 4774.949511107551, 5346.812861549827, 5386.353637563518, 5387.010209333857, 5401.813594464322, 4266.0, 4487.955120448753, 5186.2479940409185, 5390.541803946709, 5407.918881216706, 5010.549050585465, 5374.973125134349, 5375.838724838261, 5402.0, 5411.729413529387], "value": 4018.18239512105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.3768965260364, 708.4049398505255, 726.6439444672109, 733.952293100948, 736.8047467421131, 14647.267636618166, 15294.617634559141, 15306.234688265598, 15324.999999999985, 15659.765103523441, 13795.862041379583, 13902.304884755773, 13903.443862245498, 13905.721885562283, 13926.094803837743, 708.9361957423831, 722.8229083874459, 723.4646361692362, 868.9913100868989, 875.5403413208085, 888.0054339140172, 893.9687110951118, 903.4714691905243, 905.6105874473974, 907.8910530736321, 956.4882787708577, 957.4159762544842, 957.5643082397493, 959.122403001253, 960.5437417226797, 736.1240124252123, 758.116793935065, 951.3103000324778, 951.5432592355673, 952.1383148250844, 679.8708245433352, 702.367868917978, 704.4294121761338, 707.5224223649017, 708.5713143548131, 14634.780478292834, 14646.707065858729, 14659.926700366537, 14680.70638587233, 14687.265636718228, 13555.186688798703, 13669.0, 13701.0, 13710.177389356571, 13777.035607507478, 12187.634370968884, 12251.326177060258, 12290.324032178227, 12552.246865188117, 12889.548865789746, 4452.755098469583, 4522.570355816225, 4546.54534546546, 4565.155446242423, 4611.7694115294435, 93435.06564934399, 96514.0, 96643.0, 96675.033249668, 100058.0, 10659.949219296617, 10916.345019298868, 10945.0, 10983.0, 11371.260868043717, 21394.35816925495, 21488.462788430414, 21546.0, 21577.892110539346, 21593.35219943404, 7614.2766437188375, 7679.961600191963, 7705.537667739954, 7778.8833167502535, 7882.408819338572, 4254.404383386328, 4271.658267338606, 4338.110687309094, 4350.195213885378, 4479.910401791946, 3406.7785593936314, 3480.199554102571, 3517.7009954153673, 3523.207278362348, 3525.0, 521.6244304101041, 583.439897698206, 596.2546816479401, 657.9046038324416, 659.8515334049896, 486.91478991176405, 547.904116779562, 574.3538519165938, 595.8361450601119, 672.3545396419395, 7299.817504562428, 9005.594748236344, 9052.683156089506, 9053.913530376398, 9177.265818734486, 527.6677087274257, 564.6301672404581, 609.9878002439926, 630.4641055103126, 655.9081728558006, 4294.463192100988, 4403.0, 4415.62467190286, 4429.512753597101, 4476.6418686505, 104649.0, 104904.0, 105005.94994050114, 107053.4647326774, 108248.0, 64555.0, 64839.37901552499, 84342.57828710818, 90137.54931225302, 93740.0, 81615.0, 83885.58057209675, 83997.58001210078, 84964.0, 85911.5704421474, 8016.679332826855, 8053.395995300259, 8057.395695322757, 8073.434859559775, 8286.254237118688, 52515.0, 53396.0, 54367.0, 54720.631984200714, 54811.72594137004, 73338.0, 77760.61119694365, 77856.61071694606, 78530.0, 79044.60477697574, 11290.15323850698, 11429.885701142883, 11478.713032173928, 11611.187216894736, 12121.030317574396, 12273.877261227273, 12302.569410070604, 12357.876421235673, 12553.748925021266, 12865.356732163167, 10408.427536485566, 11794.882051179378, 11806.143698374844, 12070.879291206975, 12323.198992065487, 11628.476718547516, 11833.408329583313, 11979.401029948642, 12058.095642826998, 12331.69170770738, 11840.0, 11862.81756800321, 11884.34636095023, 11893.524259029542, 11979.101567382655, 9455.957907461661, 9555.18780903631, 9707.320487565803, 9945.30382873192, 10074.042965918226, 9350.532473376168, 9875.703728888146, 9932.205423565953, 10019.649312274036, 10038.347507411994], "value": 7227.19338454253, "unit": "score"}], "name": "dromaeo_css", "value": 7198.1317579224, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 165.0, 117.0, 118.0, 111.0, 112.0, 112.0, 112.0, 110.0, 112.0], "value": 120.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 110.0, 116.0, 159.0, 141.0, 144.0, 132.0, 112.0, 143.0, 111.0], "value": 131.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 184.0, 184.0, 185.0, 197.0, 224.0, 220.0, 180.0, 184.0], "value": 192.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 88.0, 62.0, 59.0, 57.0, 58.0, 81.0, 58.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 68.0, 91.0, 68.0, 67.0, 69.0, 92.0, 67.0, 60.0, 77.0], "value": 74.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 84.0, 88.0, 84.0, 88.0, 86.0, 88.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 93.0, 96.0, 93.0, 93.0, 93.0, 96.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 78.0, 114.0, 129.0, 122.0, 86.0, 83.0, 74.0, 124.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 55.0, 56.0, 55.0, 55.0, 54.0, 54.0, 55.0, 54.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 69.0, 83.0, 75.0, 72.0, 71.0, 71.0, 71.0, 70.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 86.0, 86.0, 86.0, 85.0, 84.0, 86.0, 84.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 144.0, 148.0, 145.0, 179.0, 148.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 172.0, 172.0, 171.0, 166.0, 225.0, 236.0, 191.0, 170.0], "value": 184.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 68.0, 69.0, 67.0, 69.0, 69.0, 68.0, 69.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1477.7000000000003, "alertThreshold": 2.0}]} 16:02:10 INFO - Return code: 0 16:02:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:02:10 INFO - # TBPL SUCCESS # 16:02:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:02:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:02:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:02:10 INFO - 2016-10-25 16:02:10.512 screenresolution[1966:16274] starting screenresolution argv=screenresolution get 16:02:10 INFO - 2016-10-25 16:02:10.514 screenresolution[1966:16274] Display 0: 1600x1200x32@60 16:02:10 INFO - 2016-10-25 16:02:10.520 screenresolution[1967:16277] starting screenresolution argv=screenresolution list 16:02:10 INFO - Available Modes on Display 0 16:02:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:02:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:02:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:02:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:02:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:02:10 INFO - Intel Iris: 16:02:10 INFO - Chipset Model: Intel Iris 16:02:10 INFO - Type: GPU 16:02:10 INFO - Bus: Built-In 16:02:10 INFO - VRAM (Dynamic, Max): 1536 MB 16:02:10 INFO - Vendor: Intel (0x8086) 16:02:10 INFO - Device ID: 0x0a2e 16:02:10 INFO - Revision ID: 0x0009 16:02:10 INFO - Displays: 16:02:10 INFO - Display: 16:02:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:02:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:02:10 INFO - Display Serial Number: 1600x1200 60 16:02:10 INFO - Main Display: Yes 16:02:10 INFO - Mirror: Off 16:02:10 INFO - Online: Yes 16:02:10 INFO - Rotation: Supported 16:02:10 INFO - Return code: 0 16:02:10 INFO - Running post-action listener: _resource_record_post_action 16:02:10 INFO - [mozharness: 2016-10-25 23:02:10.764584Z] Finished run-tests step (success) 16:02:10 INFO - Running post-run listener: _resource_record_post_run 16:02:10 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 1445888; Write bytes: 706033664; Read time: 11; Write time: 2018 16:02:10 INFO - TinderboxPrint: CPU usage
53.7% 16:02:10 INFO - TinderboxPrint: I/O read bytes / time
1,445,888 / 11 16:02:10 INFO - TinderboxPrint: I/O write bytes / time
706,033,664 / 2,018 16:02:10 INFO - TinderboxPrint: CPU idle
2,249.1 (46.3%) 16:02:10 INFO - TinderboxPrint: CPU system
974.2 (20.1%) 16:02:10 INFO - TinderboxPrint: CPU user
1,630.4 (33.6%) 16:02:10 INFO - TinderboxPrint: Swap in / out
405,159,936 / 0 16:02:10 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 395053568; Write bytes: 390518784; Read time: 29351; Write time: 787 16:02:10 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 524288; Write bytes: 297209856; Read time: 6; Write time: 1182 16:02:11 INFO - Running post-run listener: _upload_blobber_files 16:02:11 INFO - Blob upload gear active. 16:02:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:02:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:02:11 INFO - (blobuploader) - INFO - Open directory for files ... 16:02:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:02:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:02:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:02:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:02:12 INFO - (blobuploader) - INFO - Done attempting. 16:02:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:02:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:02:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:02:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:02:13 INFO - (blobuploader) - INFO - Done attempting. 16:02:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:02:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:02:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:02:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:02:15 INFO - (blobuploader) - INFO - Done attempting. 16:02:15 INFO - (blobuploader) - INFO - Iteration through files over. 16:02:15 INFO - Return code: 0 16:02:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:02:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:02:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcaa1b2742475d85a0c5d27127e6078e40cc17382565b620510c4d478ffcf57cf1abac0e4270990595b8fbc2955da307053f74cac042747bfe1d12cc7dd606f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91227e14847420439680926ef3423f23494818e5e47959167278d4e849f2c5e44f6213380202e0bc9b1f7078f8f18a1e914112aeea0f7092cd09953f0919155a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3c7e0ecd348aa169590846abc6dfcb3028960384302c635a6ee04033f2d7d19313613476f377602d1a21b343b2856e53c4019c9e73f8b50366f8f7ef39b9761"} 16:02:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:02:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:02:15 INFO - Contents: 16:02:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcaa1b2742475d85a0c5d27127e6078e40cc17382565b620510c4d478ffcf57cf1abac0e4270990595b8fbc2955da307053f74cac042747bfe1d12cc7dd606f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91227e14847420439680926ef3423f23494818e5e47959167278d4e849f2c5e44f6213380202e0bc9b1f7078f8f18a1e914112aeea0f7092cd09953f0919155a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3c7e0ecd348aa169590846abc6dfcb3028960384302c635a6ee04033f2d7d19313613476f377602d1a21b343b2856e53c4019c9e73f8b50366f8f7ef39b9761"} 16:02:15 INFO - Running post-run listener: copy_logs_to_upload_dir 16:02:15 INFO - Copying logs to upload dir... 16:02:15 INFO - mkdir: /builds/slave/test/build/upload/logs 16:02:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.308952 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-25 16:02:15.993383) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 16:02:15.996511) ========= 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.Su7LIoRtcu/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.3ytK1Ofopv/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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/dcaa1b2742475d85a0c5d27127e6078e40cc17382565b620510c4d478ffcf57cf1abac0e4270990595b8fbc2955da307053f74cac042747bfe1d12cc7dd606f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91227e14847420439680926ef3423f23494818e5e47959167278d4e849f2c5e44f6213380202e0bc9b1f7078f8f18a1e914112aeea0f7092cd09953f0919155a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3c7e0ecd348aa169590846abc6dfcb3028960384302c635a6ee04033f2d7d19313613476f377602d1a21b343b2856e53c4019c9e73f8b50366f8f7ef39b9761"} build_url:https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/QilNyJ_2SEW_U6kChDIwTA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcaa1b2742475d85a0c5d27127e6078e40cc17382565b620510c4d478ffcf57cf1abac0e4270990595b8fbc2955da307053f74cac042747bfe1d12cc7dd606f6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91227e14847420439680926ef3423f23494818e5e47959167278d4e849f2c5e44f6213380202e0bc9b1f7078f8f18a1e914112aeea0f7092cd09953f0919155a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3c7e0ecd348aa169590846abc6dfcb3028960384302c635a6ee04033f2d7d19313613476f377602d1a21b343b2856e53c4019c9e73f8b50366f8f7ef39b9761"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 16:02:16.028787) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 16:02:16.029144) ========= 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.Su7LIoRtcu/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.3ytK1Ofopv/Listeners TMPDIR=/var/folders/4g/xr8x86t14y5glqkjysh4fh1c00000w/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.005283 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 16:02:16.079398) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 16:02:16.079898) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 16:02:16.080381) ========= ========= Total master_lag: 0.18 =========