builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0137 starttime: 1477975527.23 results: success (0) buildid: 20161031193403 builduid: 609919d2cac74787a66e824960e5faee revision: 2c773b97167252cedcba0be0c7af9d4cab192ef5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 21:45:27.231486) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 21:45:27.231887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 21:45:27.232155) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 21:45:27.268269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:45:27.268553) ========= 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.q5RwsXJB9m/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.qFQZbc4esW/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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-31 21:45:27-- 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% 168M=0s 2016-10-31 21:45:27 (168 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.575211 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:45:27.886910) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:45:27.887213) ========= 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.q5RwsXJB9m/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.qFQZbc4esW/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.029051 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:45:27.939676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:45:27.940049) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2c773b97167252cedcba0be0c7af9d4cab192ef5 --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 2c773b97167252cedcba0be0c7af9d4cab192ef5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.q5RwsXJB9m/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.qFQZbc4esW/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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-31 21:45:28,020 truncating revision to first 12 chars 2016-10-31 21:45:28,020 Setting DEBUG logging. 2016-10-31 21:45:28,020 attempt 1/10 2016-10-31 21:45:28,020 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2c773b971672?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 21:45:28,712 unpacking tar archive at: mozilla-central-2c773b971672/testing/mozharness/ program finished with exit code 0 elapsedTime=0.931387 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:45:28.896576) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 21:45:28.899895) ========= script_repo_revision: 2c773b97167252cedcba0be0c7af9d4cab192ef5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 21:45:28.900282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 21:45:28.900543) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 21:45:28.925821) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-31 21:45:28.926099) ========= /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.q5RwsXJB9m/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.qFQZbc4esW/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 21:45:29 INFO - MultiFileLogger online at 20161031 21:45:29 in /builds/slave/test 21:45:29 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 21:45:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:45:29 INFO - {'append_to_log': False, 21:45:29 INFO - 'base_work_dir': '/builds/slave/test', 21:45:29 INFO - 'blob_upload_branch': 'Firefox', 21:45:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:45:29 INFO - 'branch': 'Firefox', 21:45:29 INFO - 'buildbot_json_path': 'buildprops.json', 21:45:29 INFO - 'config_files': ('talos/mac_config.py',), 21:45:29 INFO - 'default_actions': ('clobber', 21:45:29 INFO - 'read-buildbot-config', 21:45:29 INFO - 'download-and-extract', 21:45:29 INFO - 'populate-webroot', 21:45:29 INFO - 'create-virtualenv', 21:45:29 INFO - 'install', 21:45:29 INFO - 'run-tests'), 21:45:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:45:29 INFO - 'download_minidump_stackwalk': True, 21:45:29 INFO - 'download_symbols': 'ondemand', 21:45:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:45:29 INFO - 'tooltool.py': '/tools/tooltool.py', 21:45:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:45:29 INFO - '/tools/misc-python/virtualenv.py')}, 21:45:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:45:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:45:29 INFO - 'installer_path': 'installer.exe', 21:45:29 INFO - 'log_level': 'info', 21:45:29 INFO - 'log_name': 'talos', 21:45:29 INFO - 'log_to_console': True, 21:45:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:45:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:45:29 INFO - 'opt_config_files': (), 21:45:29 INFO - 'pip_index': False, 21:45:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:45:29 INFO - 'cmd': ('bash', 21:45:29 INFO - '-c', 21:45:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:45:29 INFO - 'enabled': True, 21:45:29 INFO - 'halt_on_failure': False, 21:45:29 INFO - 'name': 'check_screen_resolution'},), 21:45:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:45:29 INFO - 'cmd': ('bash', 21:45:29 INFO - '-c', 21:45:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:45:29 INFO - 'enabled': True, 21:45:29 INFO - 'halt_on_failure': False, 21:45:29 INFO - 'name': 'check_screen_resolution'},), 21:45:29 INFO - 'run_cmd_checks_enabled': True, 21:45:29 INFO - 'sps_profile': False, 21:45:29 INFO - 'sps_profile_interval': 0, 21:45:29 INFO - 'suite': 'dromaeojs', 21:45:29 INFO - 'system_bits': '32', 21:45:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:45:29 INFO - 'title': 't-yosemite-r7-0137', 21:45:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:45:29 INFO - 'use_talos_json': True, 21:45:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:45:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:45:29 INFO - 'work_dir': 'build'} 21:45:29 INFO - [mozharness: 2016-11-01 04:45:29.136117Z] Running clobber step. 21:45:29 INFO - Running pre-action listener: _resource_record_pre_action 21:45:29 INFO - Running main action method: clobber 21:45:29 INFO - rmtree: /builds/slave/test/build 21:45:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:45:31 INFO - Running post-action listener: _resource_record_post_action 21:45:31 INFO - [mozharness: 2016-11-01 04:45:31.251347Z] Finished clobber step (success) 21:45:31 INFO - [mozharness: 2016-11-01 04:45:31.251456Z] Running read-buildbot-config step. 21:45:31 INFO - Running pre-action listener: _resource_record_pre_action 21:45:31 INFO - Running main action method: read_buildbot_config 21:45:31 INFO - Using buildbot properties: 21:45:31 INFO - { 21:45:31 INFO - "project": "", 21:45:31 INFO - "product": "firefox", 21:45:31 INFO - "script_repo_revision": "production", 21:45:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:45:31 INFO - "repository": "", 21:45:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:45:31 INFO - "buildid": "20161031193403", 21:45:31 INFO - "pgo_build": "False", 21:45:31 INFO - "basedir": "/builds/slave/test", 21:45:31 INFO - "buildnumber": 18, 21:45:31 INFO - "slavename": "t-yosemite-r7-0137", 21:45:31 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 21:45:31 INFO - "platform": "yosemite_r7", 21:45:31 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:45:31 INFO - "branch": "mozilla-central", 21:45:31 INFO - "repo_path": "mozilla-central", 21:45:31 INFO - "revision": "2c773b97167252cedcba0be0c7af9d4cab192ef5", 21:45:31 INFO - "stage_platform": "macosx64", 21:45:31 INFO - "builduid": "609919d2cac74787a66e824960e5faee", 21:45:31 INFO - "slavebuilddir": "test" 21:45:31 INFO - } 21:45:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 21:45:31 INFO - Running post-action listener: _resource_record_post_action 21:45:31 INFO - [mozharness: 2016-11-01 04:45:31.254346Z] Finished read-buildbot-config step (success) 21:45:31 INFO - [mozharness: 2016-11-01 04:45:31.254448Z] Running download-and-extract step. 21:45:31 INFO - Running pre-action listener: _resource_record_pre_action 21:45:31 INFO - Running main action method: download_and_extract 21:45:31 INFO - mkdir: /builds/slave/test/build/tests 21:45: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')]} 21:45:31 INFO - trying https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 21:45:31 INFO - Downloading https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/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 21:45:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/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 21:45:32 INFO - Downloaded 1199 bytes. 21:45:32 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 21:45:32 INFO - Using the following test package requirements: 21:45:32 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:45:32 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:45:32 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 21:45:32 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:45:32 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 21:45:32 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:45:32 INFO - u'jsshell-mac.zip'], 21:45:32 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:45:32 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 21:45:32 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:45:32 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:45:32 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 21:45:32 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:45:32 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 21:45:32 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:45:32 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 21:45:32 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:45:32 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 21:45:32 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:45:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:45:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:45:32 INFO - Fetch https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:45:32 INFO - Http code: 200 21:45:32 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 21:45:32 INFO - x-amz-cf-id: 6U2Go3B8U7Peu9imSbAAAD_AA9GZXCwm1tLLGox58DhLn-3D2R4pTg== 21:45:32 INFO - x-amz-version-id: 2HQVOQfEmXPbBIRvqb1m270.niisftIW 21:45:33 INFO - Expected file size: 16404931 21:45:33 INFO - Obtained file size: 16404931 21:45:39 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 21:45:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:45:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:45:39 INFO - Fetch https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:45:40 INFO - Http code: 200 21:45:40 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 21:45:40 INFO - x-amz-cf-id: d7kYWsDuDeMyKaMzGdTZI-e4nlNZdXTAXYnRiuApeFGY4HsIPB7TtQ== 21:45:40 INFO - x-amz-version-id: 2HQVOQfEmXPbBIRvqb1m270.niisftIW 21:45:40 INFO - Expected file size: 16404931 21:45:40 INFO - Obtained file size: 16404931 21:45:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 21:45:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:45:46 INFO - Fetch https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 21:45:47 INFO - Http code: 200 21:45:47 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 21:45:47 INFO - x-amz-cf-id: 2WIN-z4tt7bcDejne7BWkeTWiFqdG_FY-95dMAD4X3NQbxqnBZh6Jw== 21:45:47 INFO - x-amz-version-id: SMCWGVLn36oszstmpk507auvu_VcY3Aq 21:45:47 INFO - Expected file size: 14409038 21:45:47 INFO - Obtained file size: 14409038 21:45:47 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')]} 21:45:47 INFO - trying https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:45:47 INFO - Downloading https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 21:45:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/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 21:45:50 INFO - Downloaded 112093022 bytes. 21:45:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:45:50 INFO - mkdir: /builds/slave/test/properties 21:45:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:45:50 INFO - Writing to file /builds/slave/test/properties/build_url 21:45:50 INFO - Contents: 21:45:50 INFO - build_url:https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:45:52 INFO - Running post-action listener: _resource_record_post_action 21:45:52 INFO - Running post-action listener: set_extra_try_arguments 21:45:52 INFO - [mozharness: 2016-11-01 04:45:52.277849Z] Finished download-and-extract step (success) 21:45:52 INFO - [mozharness: 2016-11-01 04:45:52.277970Z] Running populate-webroot step. 21:45:52 INFO - Running pre-action listener: _resource_record_pre_action 21:45:52 INFO - Running main action method: populate_webroot 21:45:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:45:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:45:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:45:52 INFO - '--tppagecycles', 21:45:52 INFO - '7'], 21:45:52 INFO - 'tests': ['tsvgm']}}, 21:45:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:45:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:45:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:45:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:45:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:45:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:45:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:52 INFO - 'talos_options': ['--disable-e10s'], 21:45:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:45:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:45:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:52 INFO - 'talos_options': ['--disable-e10s'], 21:45:52 INFO - 'tests': ['damp', 'tps']}, 21:45:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:52 INFO - 'tests': ['damp', 'tps']}, 21:45:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:45:52 INFO - 'tests': ['dromaeo_dom']}, 21:45:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:45:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:45:52 INFO - 'tests': ['basic_compositor_video']}, 21:45:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:45:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:45:52 INFO - 'tests': ['a11yr', 21:45:52 INFO - 'ts_paint', 21:45:52 INFO - 'tpaint', 21:45:52 INFO - 'sessionrestore', 21:45:52 INFO - 'sessionrestore_no_auto_restore', 21:45:52 INFO - 'tabpaint']}, 21:45:52 INFO - 'other-e10s': {'tests': ['a11yr', 21:45:52 INFO - 'ts_paint', 21:45:52 INFO - 'tpaint', 21:45:52 INFO - 'sessionrestore', 21:45:52 INFO - 'sessionrestore_no_auto_restore', 21:45:52 INFO - 'tabpaint']}, 21:45:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:45:52 INFO - 'ts_paint', 21:45:52 INFO - 'tpaint', 21:45:52 INFO - 'sessionrestore', 21:45:52 INFO - 'sessionrestore_no_auto_restore', 21:45:52 INFO - 'tabpaint']}, 21:45:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:45:52 INFO - 'ts_paint', 21:45:52 INFO - 'tpaint', 21:45:52 INFO - 'sessionrestore', 21:45:52 INFO - 'sessionrestore_no_auto_restore', 21:45:52 INFO - 'tabpaint']}, 21:45:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:45:52 INFO - 'tests': ['a11yr', 21:45:52 INFO - 'ts_paint', 21:45:52 INFO - 'tpaint', 21:45:52 INFO - 'sessionrestore', 21:45:52 INFO - 'sessionrestore_no_auto_restore', 21:45:52 INFO - 'tabpaint']}, 21:45:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:45:52 INFO - 'tests': ['a11yr', 21:45:52 INFO - 'ts_paint', 21:45:52 INFO - 'tpaint', 21:45:52 INFO - 'sessionrestore', 21:45:52 INFO - 'sessionrestore_no_auto_restore', 21:45:52 INFO - 'tabpaint']}, 21:45:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:45:52 INFO - 'tests': ['tsvgx', 21:45:52 INFO - 'tsvgr_opacity', 21:45:52 INFO - 'tart', 21:45:52 INFO - 'tscrollx', 21:45:52 INFO - 'cart']}, 21:45:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:45:52 INFO - 'tsvgr_opacity', 21:45:52 INFO - 'tart', 21:45:52 INFO - 'tscrollx', 21:45:52 INFO - 'cart']}, 21:45:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:52 INFO - 'talos_options': ['--disable-e10s'], 21:45:52 INFO - 'tests': ['tp5o']}, 21:45:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:52 INFO - 'tests': ['tp5o']}, 21:45:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:52 INFO - 'talos_options': ['--disable-e10s', 21:45:52 INFO - '--xperf_path', 21:45:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:45:52 INFO - 'tests': ['tp5n']}, 21:45:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:52 INFO - 'talos_options': ['--xperf_path', 21:45:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:45:52 INFO - 'tests': ['tp5n']}}, 21:45:52 INFO - 'talos.zip': {'path': '', 21:45:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:45:52 INFO - Running post-action listener: _resource_record_post_action 21:45:52 INFO - [mozharness: 2016-11-01 04:45:52.296837Z] Finished populate-webroot step (success) 21:45:52 INFO - [mozharness: 2016-11-01 04:45:52.296948Z] Running create-virtualenv step. 21:45:52 INFO - Running pre-action listener: _resource_record_pre_action 21:45:52 INFO - Running main action method: create_virtualenv 21:45:52 INFO - Creating virtualenv /builds/slave/test/build/venv 21:45:52 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 21:45:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:45:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:45:52 INFO - Using real prefix '/tools/python27' 21:45:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:45:53 INFO - Installing distribute.............................................................................................................................................................................................done. 21:45:55 INFO - Installing pip.................done. 21:45:55 INFO - Return code: 0 21:45:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:45:56 INFO - Reading from file tmpfile_stdout 21:45:56 INFO - Output received: 21:45:56 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) 21:45:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:45:56 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')]} 21:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:56 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')]} 21:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:56 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 0x10df49490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10debf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb60562c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd5dd30>, '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 0x10db83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd55b20>, '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.q5RwsXJB9m/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.qFQZbc4esW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 21:45:56 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 21:45:56 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 21:45:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q5RwsXJB9m/Render', 21:45:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:45:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:45:56 INFO - 'HOME': '/Users/cltbld', 21:45:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:45:56 INFO - 'LOGNAME': 'cltbld', 21:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:56 INFO - 'MOZ_NO_REMOTE': '1', 21:45:56 INFO - 'NO_EM_RESTART': '1', 21:45:56 INFO - 'PAGER': '/bin/cat', 21:45:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:56 INFO - 'PWD': '/builds/slave/test', 21:45:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:45:56 INFO - 'SHELL': '/bin/bash', 21:45:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFQZbc4esW/Listeners', 21:45:56 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 21:45:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:45:56 INFO - 'USER': 'cltbld', 21:45:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:45:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:56 INFO - 'XPC_FLAGS': '0x0', 21:45:56 INFO - 'XPC_SERVICE_NAME': '0', 21:45:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:56 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 21:45:56 INFO - Cleaning up... 21:45:56 INFO - Return code: 0 21:45:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:45:56 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')]} 21:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:56 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')]} 21:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:56 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 0x10df49490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10debf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb60562c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd5dd30>, '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 0x10db83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd55b20>, '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.q5RwsXJB9m/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.qFQZbc4esW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 21:45:56 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 21:45:56 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 21:45:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q5RwsXJB9m/Render', 21:45:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:45:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:45:56 INFO - 'HOME': '/Users/cltbld', 21:45:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:45:56 INFO - 'LOGNAME': 'cltbld', 21:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:56 INFO - 'MOZ_NO_REMOTE': '1', 21:45:56 INFO - 'NO_EM_RESTART': '1', 21:45:56 INFO - 'PAGER': '/bin/cat', 21:45:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:56 INFO - 'PWD': '/builds/slave/test', 21:45:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:45:56 INFO - 'SHELL': '/bin/bash', 21:45:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFQZbc4esW/Listeners', 21:45:56 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 21:45:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:45:56 INFO - 'USER': 'cltbld', 21:45:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:45:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:56 INFO - 'XPC_FLAGS': '0x0', 21:45:56 INFO - 'XPC_SERVICE_NAME': '0', 21:45:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:56 INFO - Downloading/unpacking psutil>=3.1.1 21:45:56 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 21:45:56 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 21:45:56 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 21:45:56 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 21:45:56 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 21:45:56 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 21:46:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:46:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:00 INFO - Installing collected packages: psutil 21:46:00 INFO - Running setup.py install for psutil 21:46:00 INFO - building 'psutil._psutil_osx' extension 21:46:00 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 21:46:01 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 21:46:01 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 21:46:01 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 21:46:01 INFO - building 'psutil._psutil_posix' extension 21:46:01 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 21:46:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:46:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:46:01 INFO - ^ 21:46:01 INFO - 1 warning generated. 21:46:01 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 21:46:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:01 INFO - Successfully installed psutil 21:46:01 INFO - Cleaning up... 21:46:01 INFO - Return code: 0 21:46:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:46:01 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')]} 21:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:01 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')]} 21:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:01 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 0x10df49490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10debf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb60562c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd5dd30>, '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 0x10db83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd55b20>, '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.q5RwsXJB9m/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.qFQZbc4esW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 21:46:01 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 21:46:01 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 21:46:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q5RwsXJB9m/Render', 21:46:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:01 INFO - 'HOME': '/Users/cltbld', 21:46:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:01 INFO - 'LOGNAME': 'cltbld', 21:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:01 INFO - 'MOZ_NO_REMOTE': '1', 21:46:01 INFO - 'NO_EM_RESTART': '1', 21:46:01 INFO - 'PAGER': '/bin/cat', 21:46:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:01 INFO - 'PWD': '/builds/slave/test', 21:46:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:01 INFO - 'SHELL': '/bin/bash', 21:46:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFQZbc4esW/Listeners', 21:46:01 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 21:46:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:01 INFO - 'USER': 'cltbld', 21:46:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:01 INFO - 'XPC_FLAGS': '0x0', 21:46:01 INFO - 'XPC_SERVICE_NAME': '0', 21:46:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:46:02 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 21:46:02 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 21:46:02 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 21:46:02 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 21:46:02 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 21:46:02 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 21:46:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:46:04 INFO - Installing collected packages: mozsystemmonitor 21:46:04 INFO - Running setup.py install for mozsystemmonitor 21:46:04 INFO - Successfully installed mozsystemmonitor 21:46:04 INFO - Cleaning up... 21:46:05 INFO - Return code: 0 21:46:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:46:05 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')]} 21:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:05 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')]} 21:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:05 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 0x10df49490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10debf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb60562c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd5dd30>, '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 0x10db83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd55b20>, '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.q5RwsXJB9m/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.qFQZbc4esW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 21:46:05 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 21:46:05 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 21:46:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q5RwsXJB9m/Render', 21:46:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:05 INFO - 'HOME': '/Users/cltbld', 21:46:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:05 INFO - 'LOGNAME': 'cltbld', 21:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:05 INFO - 'MOZ_NO_REMOTE': '1', 21:46:05 INFO - 'NO_EM_RESTART': '1', 21:46:05 INFO - 'PAGER': '/bin/cat', 21:46:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:05 INFO - 'PWD': '/builds/slave/test', 21:46:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:05 INFO - 'SHELL': '/bin/bash', 21:46:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFQZbc4esW/Listeners', 21:46:05 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 21:46:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:05 INFO - 'USER': 'cltbld', 21:46:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:05 INFO - 'XPC_FLAGS': '0x0', 21:46:05 INFO - 'XPC_SERVICE_NAME': '0', 21:46:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:05 INFO - Downloading/unpacking jsonschema==2.5.1 21:46:05 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 21:46:05 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 21:46:05 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 21:46:05 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 21:46:05 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 21:46:05 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 21:46:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:46:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:08 INFO - Downloading functools32-3.2.3-2.tar.gz 21:46:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:46:08 INFO - warning: no files found matching '*.txt' 21:46:08 INFO - no previously-included directories found matching 'build' 21:46:08 INFO - no previously-included directories found matching 'dist' 21:46:08 INFO - no previously-included directories found matching '.git*' 21:46:08 INFO - Installing collected packages: jsonschema, functools32 21:46:08 INFO - Running setup.py install for functools32 21:46:08 INFO - warning: no files found matching '*.txt' 21:46:08 INFO - no previously-included directories found matching 'build' 21:46:08 INFO - no previously-included directories found matching 'dist' 21:46:08 INFO - no previously-included directories found matching '.git*' 21:46:08 INFO - Successfully installed jsonschema functools32 21:46:08 INFO - Cleaning up... 21:46:08 INFO - Return code: 0 21:46:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:08 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 0x10df49490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10debf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb60562c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd5dd30>, '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 0x10db83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd55b20>, '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.q5RwsXJB9m/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.qFQZbc4esW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 21:46:08 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 21:46:08 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 21:46:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q5RwsXJB9m/Render', 21:46:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:08 INFO - 'HOME': '/Users/cltbld', 21:46:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:08 INFO - 'LOGNAME': 'cltbld', 21:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:08 INFO - 'MOZ_NO_REMOTE': '1', 21:46:08 INFO - 'NO_EM_RESTART': '1', 21:46:08 INFO - 'PAGER': '/bin/cat', 21:46:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:08 INFO - 'PWD': '/builds/slave/test', 21:46:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:08 INFO - 'SHELL': '/bin/bash', 21:46:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFQZbc4esW/Listeners', 21:46:08 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 21:46:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:08 INFO - 'USER': 'cltbld', 21:46:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:08 INFO - 'XPC_FLAGS': '0x0', 21:46:08 INFO - 'XPC_SERVICE_NAME': '0', 21:46:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:46:08 INFO - Cleaning up... 21:46:08 INFO - Return code: 0 21:46:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:08 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 0x10df49490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10debf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb60562c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd5dd30>, '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 0x10db83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd55b20>, '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.q5RwsXJB9m/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.qFQZbc4esW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 21:46:08 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 21:46:08 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 21:46:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q5RwsXJB9m/Render', 21:46:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:08 INFO - 'HOME': '/Users/cltbld', 21:46:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:08 INFO - 'LOGNAME': 'cltbld', 21:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:08 INFO - 'MOZ_NO_REMOTE': '1', 21:46:08 INFO - 'NO_EM_RESTART': '1', 21:46:08 INFO - 'PAGER': '/bin/cat', 21:46:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:08 INFO - 'PWD': '/builds/slave/test', 21:46:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:08 INFO - 'SHELL': '/bin/bash', 21:46:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFQZbc4esW/Listeners', 21:46:08 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 21:46:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:08 INFO - 'USER': 'cltbld', 21:46:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:08 INFO - 'XPC_FLAGS': '0x0', 21:46:08 INFO - 'XPC_SERVICE_NAME': '0', 21:46:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:09 INFO - Downloading/unpacking blobuploader==1.2.4 21:46:09 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 21:46:09 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 21:46:09 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 21:46:09 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 21:46:09 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 21:46:09 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 21:46:11 INFO - Downloading blobuploader-1.2.4.tar.gz 21:46:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:46:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:46:11 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 21:46:11 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 21:46:11 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 21:46:11 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 21:46:11 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 21:46:11 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 21:46:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:46:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:46:12 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 21:46:12 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 21:46:12 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 21:46:12 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 21:46:12 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 21:46:12 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 21:46:12 INFO - Downloading docopt-0.6.1.tar.gz 21:46:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:46:12 INFO - Installing collected packages: blobuploader, requests, docopt 21:46:12 INFO - Running setup.py install for blobuploader 21:46:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:46:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:46:13 INFO - Running setup.py install for requests 21:46:13 INFO - Running setup.py install for docopt 21:46:13 INFO - Successfully installed blobuploader requests docopt 21:46:13 INFO - Cleaning up... 21:46:13 INFO - Return code: 0 21:46:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:13 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 0x10df49490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10debf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb60562c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd5dd30>, '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 0x10db83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd55b20>, '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.q5RwsXJB9m/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.qFQZbc4esW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 21:46:13 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 21:46:13 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 21:46:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q5RwsXJB9m/Render', 21:46:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:13 INFO - 'HOME': '/Users/cltbld', 21:46:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:13 INFO - 'LOGNAME': 'cltbld', 21:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:13 INFO - 'MOZ_NO_REMOTE': '1', 21:46:13 INFO - 'NO_EM_RESTART': '1', 21:46:13 INFO - 'PAGER': '/bin/cat', 21:46:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:13 INFO - 'PWD': '/builds/slave/test', 21:46:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:13 INFO - 'SHELL': '/bin/bash', 21:46:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFQZbc4esW/Listeners', 21:46:13 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 21:46:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:13 INFO - 'USER': 'cltbld', 21:46:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:13 INFO - 'XPC_FLAGS': '0x0', 21:46:13 INFO - 'XPC_SERVICE_NAME': '0', 21:46:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:46:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Z0thcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:46:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-rHc1ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:46:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Xl4yMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:46:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-bziqE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:46:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-rt078n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:46:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-0WFI47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:46:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-iT9elJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:46:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-hJNCug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:46:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-EamRSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:46:14 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-4Ru5Uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:46:15 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-dckaz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:46:15 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-HljLxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:46:15 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Ej3lwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:46:15 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-xwGsAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:15 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-UKjwtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:46:15 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-XCyeWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:46:15 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-LDkqao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:46:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:46:15 INFO - Running setup.py install for manifestparser 21:46:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:46:15 INFO - Running setup.py install for mozcrash 21:46:16 INFO - Running setup.py install for mozdebug 21:46:16 INFO - Running setup.py install for mozdevice 21:46:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:46:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:46:16 INFO - Running setup.py install for mozfile 21:46:16 INFO - Running setup.py install for mozhttpd 21:46:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:46:16 INFO - Running setup.py install for mozinfo 21:46:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:46:16 INFO - Running setup.py install for mozInstall 21:46:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:46:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:46:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:46:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:46:16 INFO - Running setup.py install for mozleak 21:46:17 INFO - Running setup.py install for mozlog 21:46:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:46:17 INFO - Running setup.py install for moznetwork 21:46:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:46:17 INFO - Running setup.py install for mozprocess 21:46:17 INFO - Running setup.py install for mozprofile 21:46:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:46:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:46:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:46:17 INFO - Running setup.py install for mozrunner 21:46:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:46:17 INFO - Running setup.py install for mozscreenshot 21:46:18 INFO - Running setup.py install for moztest 21:46:18 INFO - Running setup.py install for mozversion 21:46:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:46:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:46:18 INFO - Cleaning up... 21:46:18 INFO - Return code: 0 21:46:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46:18 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')]} 21:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:18 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')]} 21:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:18 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 0x10df49490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10debf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb60562c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd5dd30>, '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 0x10db83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd55b20>, '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.q5RwsXJB9m/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.qFQZbc4esW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 21:46:18 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 21:46:18 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 21:46:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q5RwsXJB9m/Render', 21:46:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:18 INFO - 'HOME': '/Users/cltbld', 21:46:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:18 INFO - 'LOGNAME': 'cltbld', 21:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:18 INFO - 'MOZ_NO_REMOTE': '1', 21:46:18 INFO - 'NO_EM_RESTART': '1', 21:46:18 INFO - 'PAGER': '/bin/cat', 21:46:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:18 INFO - 'PWD': '/builds/slave/test', 21:46:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:18 INFO - 'SHELL': '/bin/bash', 21:46:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFQZbc4esW/Listeners', 21:46:18 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 21:46:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:18 INFO - 'USER': 'cltbld', 21:46:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:18 INFO - 'XPC_FLAGS': '0x0', 21:46:18 INFO - 'XPC_SERVICE_NAME': '0', 21:46:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:46:18 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-w7PWNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:46:18 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)) 21:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:46:18 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-g5eLEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:46:18 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)) 21:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:46:18 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-DLRWzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:46:18 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)) 21:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:46:19 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-k3sG0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:46:19 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-qrh_5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:46:19 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-dwSpik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:46:19 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-0k65C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:46:19 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-VTXJsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:46:19 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-SlvujJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:46:19 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-SgxPmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:46:19 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-qmLzsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:46:19 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-maCimX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:46:19 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-axMdfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:46:20 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)) 21:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:46:20 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-yPZQht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:46:20 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)) 21:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:20 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-DFuck4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:20 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)) 21:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:46:20 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-OEJzl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:46:20 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)) 21:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:46:20 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-ynMeC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:46:20 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)) 21:46:20 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)) 21:46:20 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)) 21:46:20 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)) 21:46:20 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)) 21:46:20 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)) 21:46:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:46:20 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 21:46:20 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 21:46:20 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 21:46:20 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 21:46:20 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 21:46:20 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 21:46:22 INFO - Downloading blessings-1.6.tar.gz 21:46:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:46:23 INFO - Installing collected packages: blessings 21:46:23 INFO - Running setup.py install for blessings 21:46:23 INFO - Successfully installed blessings 21:46:23 INFO - Cleaning up... 21:46:23 INFO - Return code: 0 21:46:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:46:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:46:23 INFO - Reading from file tmpfile_stdout 21:46:23 INFO - Current package versions: 21:46:23 INFO - blessings == 1.6 21:46:23 INFO - blobuploader == 1.2.4 21:46:23 INFO - docopt == 0.6.1 21:46:23 INFO - functools32 == 3.2.3-2 21:46:23 INFO - jsonschema == 2.5.1 21:46:23 INFO - manifestparser == 1.1 21:46:23 INFO - mozInstall == 1.12 21:46:23 INFO - mozcrash == 0.17 21:46:23 INFO - mozdebug == 0.1 21:46:23 INFO - mozdevice == 0.48 21:46:23 INFO - mozfile == 1.2 21:46:23 INFO - mozhttpd == 0.7 21:46:23 INFO - mozinfo == 0.9 21:46:23 INFO - mozleak == 0.1 21:46:23 INFO - mozlog == 3.4 21:46:23 INFO - moznetwork == 0.27 21:46:23 INFO - mozprocess == 0.23 21:46:23 INFO - mozprofile == 0.28 21:46:23 INFO - mozrunner == 6.12 21:46:23 INFO - mozscreenshot == 0.1 21:46:23 INFO - mozsystemmonitor == 0.3 21:46:23 INFO - moztest == 0.7 21:46:23 INFO - mozversion == 1.4 21:46:23 INFO - psutil == 3.1.1 21:46:23 INFO - requests == 1.2.3 21:46:23 INFO - wsgiref == 0.1.2 21:46:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46:23 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')]} 21:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:23 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')]} 21:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:23 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 0x10df49490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10debf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb60562c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd5dd30>, '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 0x10db83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd55b20>, '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.q5RwsXJB9m/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.qFQZbc4esW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 21:46:23 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 21:46:23 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 21:46:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q5RwsXJB9m/Render', 21:46:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:23 INFO - 'HOME': '/Users/cltbld', 21:46:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:23 INFO - 'LOGNAME': 'cltbld', 21:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:23 INFO - 'MOZ_NO_REMOTE': '1', 21:46:23 INFO - 'NO_EM_RESTART': '1', 21:46:23 INFO - 'PAGER': '/bin/cat', 21:46:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:23 INFO - 'PWD': '/builds/slave/test', 21:46:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:23 INFO - 'SHELL': '/bin/bash', 21:46:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFQZbc4esW/Listeners', 21:46:23 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 21:46:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:23 INFO - 'USER': 'cltbld', 21:46:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:23 INFO - 'XPC_FLAGS': '0x0', 21:46:23 INFO - 'XPC_SERVICE_NAME': '0', 21:46:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:23 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)) 21:46:23 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)) 21:46:23 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)) 21:46:23 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)) 21:46:23 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)) 21:46:23 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)) 21:46:23 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)) 21:46:23 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)) 21:46:23 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)) 21:46:23 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)) 21:46:23 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)) 21:46:23 INFO - Cleaning up... 21:46:23 INFO - Return code: 0 21:46:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:46:23 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')]} 21:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:23 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')]} 21:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:23 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 0x10df49490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10debf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb60562c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd5dd30>, '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 0x10db83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd55b20>, '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.q5RwsXJB9m/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.qFQZbc4esW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 21:46:23 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 21:46:23 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 21:46:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q5RwsXJB9m/Render', 21:46:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:23 INFO - 'HOME': '/Users/cltbld', 21:46:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:23 INFO - 'LOGNAME': 'cltbld', 21:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:23 INFO - 'MOZ_NO_REMOTE': '1', 21:46:23 INFO - 'NO_EM_RESTART': '1', 21:46:23 INFO - 'PAGER': '/bin/cat', 21:46:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:23 INFO - 'PWD': '/builds/slave/test', 21:46:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:23 INFO - 'SHELL': '/bin/bash', 21:46:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFQZbc4esW/Listeners', 21:46:23 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 21:46:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:23 INFO - 'USER': 'cltbld', 21:46:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:23 INFO - 'XPC_FLAGS': '0x0', 21:46:23 INFO - 'XPC_SERVICE_NAME': '0', 21:46:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:46:24 INFO - Cleaning up... 21:46:24 INFO - Return code: 0 21:46:24 INFO - Running post-action listener: _resource_record_post_action 21:46:24 INFO - Running post-action listener: _start_resource_monitoring 21:46:24 INFO - Starting resource monitoring. 21:46:24 INFO - [mozharness: 2016-11-01 04:46:24.115935Z] Finished create-virtualenv step (success) 21:46:24 INFO - [mozharness: 2016-11-01 04:46:24.116934Z] Running install step. 21:46:24 INFO - Running pre-action listener: _resource_record_pre_action 21:46:24 INFO - Running main action method: install 21:46:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:46:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:46:24 INFO - Reading from file tmpfile_stdout 21:46:24 INFO - Detecting whether we're running mozinstall >=1.0... 21:46:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:46:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:46:24 INFO - Reading from file tmpfile_stdout 21:46:24 INFO - Output received: 21:46:24 INFO - Usage: mozinstall [options] installer 21:46:24 INFO - Options: 21:46:24 INFO - -h, --help show this help message and exit 21:46:24 INFO - -d DEST, --destination=DEST 21:46:24 INFO - Directory to install application into. [default: 21:46:24 INFO - "/builds/slave/test"] 21:46:24 INFO - --app=APP Application being installed. [default: firefox] 21:46:24 INFO - mkdir: /builds/slave/test/build/application 21:46:24 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'] 21:46:24 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 21:46:58 INFO - Reading from file tmpfile_stdout 21:46:58 INFO - Output received: 21:46:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:46:58 INFO - Running post-action listener: _resource_record_post_action 21:46:58 INFO - [mozharness: 2016-11-01 04:46:58.347658Z] Finished install step (success) 21:46:58 INFO - [mozharness: 2016-11-01 04:46:58.347817Z] Running run-tests step. 21:46:58 INFO - Running pre-action listener: _resource_record_pre_action 21:46:58 INFO - Running main action method: run_tests 21:46:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:46:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:46:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:46:58 INFO - 2016-10-31 21:46:58.362 screenresolution[1648:8774] starting screenresolution argv=screenresolution get 21:46:58 INFO - 2016-10-31 21:46:58.365 screenresolution[1648:8774] Display 0: 1600x1200x32@60 21:46:58 INFO - 2016-10-31 21:46:58.371 screenresolution[1649:8776] starting screenresolution argv=screenresolution list 21:46:58 INFO - Available Modes on Display 0 21:46:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:46:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:46:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:46:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:46:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:46:58 INFO - Intel Iris: 21:46:58 INFO - Chipset Model: Intel Iris 21:46:58 INFO - Type: GPU 21:46:58 INFO - Bus: Built-In 21:46:58 INFO - VRAM (Dynamic, Max): 1536 MB 21:46:58 INFO - Vendor: Intel (0x8086) 21:46:58 INFO - Device ID: 0x0a2e 21:46:58 INFO - Revision ID: 0x0009 21:46:58 INFO - Displays: 21:46:58 INFO - Display: 21:46:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:46:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:46:58 INFO - Display Serial Number: 1600x1200 60 21:46:58 INFO - Main Display: Yes 21:46:58 INFO - Mirror: Off 21:46:58 INFO - Online: Yes 21:46:58 INFO - Rotation: Supported 21:46:58 INFO - Return code: 0 21:46:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:46:58 INFO - Python 2.7.3 21:46:58 INFO - Return code: 0 21:46:58 INFO - grabbing minidump binary from tooltool 21:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:46:58 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 0x10dd5dd30>, '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 0x10db83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd55b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:46:58 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 21:46:58 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 21:46:58 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 21:46:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:46:58 INFO - Return code: 0 21:46:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:46:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:46:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:46:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:46:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:46:58 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/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--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 21:46:58 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/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0137 --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 21:46:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q5RwsXJB9m/Render', 21:46:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:58 INFO - 'HOME': '/Users/cltbld', 21:46:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:58 INFO - 'LOGNAME': 'cltbld', 21:46:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:46:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:58 INFO - 'MOZ_NO_REMOTE': '1', 21:46:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:46:58 INFO - 'NO_EM_RESTART': '1', 21:46:58 INFO - 'PAGER': '/bin/cat', 21:46:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:58 INFO - 'PWD': '/builds/slave/test', 21:46:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:46:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:58 INFO - 'SHELL': '/bin/bash', 21:46:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFQZbc4esW/Listeners', 21:46:58 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 21:46:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:58 INFO - 'USER': 'cltbld', 21:46:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:58 INFO - 'XPC_FLAGS': '0x0', 21:46:58 INFO - 'XPC_SERVICE_NAME': '0', 21:46:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:58 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/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--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 21:46:58 INFO - mozversion application_buildid: 20161031193403 21:46:58 INFO - mozversion application_changeset: 2c773b97167252cedcba0be0c7af9d4cab192ef5 21:46:58 INFO - mozversion application_display_name: Nightly 21:46:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:46:58 INFO - mozversion application_name: Firefox 21:46:58 INFO - mozversion application_remotingname: firefox 21:46:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:46:58 INFO - mozversion application_vendor: Mozilla 21:46:58 INFO - mozversion application_version: 52.0a1 21:46:58 INFO - mozversion platform_buildid: 20161031193403 21:46:58 INFO - mozversion platform_changeset: 2c773b97167252cedcba0be0c7af9d4cab192ef5 21:46:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:46:58 INFO - mozversion platform_version: 52.0a1 21:46:58 INFO - using testdate: 1477975618 21:46:58 INFO - actual date: 1477975618 21:46:58 INFO - starting webserver on 'localhost:49272' 21:46:58 INFO - SUITE-START | Running 2 tests 21:46:58 INFO - TEST-START | dromaeo_css 21:46:58 INFO - operating with platform_type : mac_ 21:46:58 INFO - Initialising browser for dromaeo_css test... 21:46:58 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpjhXn6M/profile http://localhost:49272/getInfo.html) 21:47:01 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 21:47:01 INFO - PROCESS | 1659 | colorDepth:24 21:47:01 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 21:47:01 INFO - PROCESS | 1659 | __metrics 21:47:01 INFO - PROCESS | 1659 | 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" 21:47:01 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:47:02 INFO - TEST-INFO | 1659: exit 0 21:47:02 INFO - Browser initialized. 21:47:02 INFO - Running cycle 1/1 for dromaeo_css test... 21:47:02 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpjhXn6M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:47:14 INFO - PROCESS | 1662 | RSS: Main: 240893952 21:47:14 INFO - PROCESS | 1662 | 21:48:05 INFO - PROCESS | 1662 | 1477975685167 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] 21:50:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 21:50:20 INFO - PROCESS | 1662 | RSS: Main: 385564672 21:50:20 INFO - PROCESS | 1662 | 21:53:23 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 21:53:24 INFO - PROCESS | 1662 | RSS: Main: 372932608 21:53:24 INFO - PROCESS | 1662 | 21:56:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 21:56:27 INFO - PROCESS | 1662 | RSS: Main: 351825920 21:56:27 INFO - PROCESS | 1662 | 21:59:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 21:59:30 INFO - PROCESS | 1662 | RSS: Main: 336912384 21:59:30 INFO - PROCESS | 1662 | 22:02:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 22:02:34 INFO - PROCESS | 1662 | RSS: Main: 328339456 22:02:34 INFO - PROCESS | 1662 | 22:05:37 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 22:05:38 INFO - PROCESS | 1662 | RSS: Main: 436232192 22:05:38 INFO - PROCESS | 1662 | 22:05:38 INFO - PROCESS | 1662 | __start_tp_report 22:05:38 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 22:05:38 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 22:05:38 INFO - PROCESS | 1662 | |i|pagename|runs| 22:05:38 INFO - PROCESS | 1662 | |0;dojo.html;2947.9999999999995;3271.7055465008143;3275.2466932605507;3295.967040329596;3310.6854848789358;5458.372287186975;5533.114701647737;5566.721663916808;5634.352049514302;5641.069223578115;5593.468620481058;5635.464630860072;5638.154276858473;5642.294713160855;5642.887142257163;5062.569681577062;5107.744612769366;5117.513836185556;5153.665011774241;5191;5122.359705036871;5197.454267301917;5205.089109405858;5207.297014902996;5211.035958347698;5076.390833100033;5125.743712814363;5135.486451354872;5144.794208231666;5187.507186817246;5215.452377500384;5219.034478621467;5219.138842091051;5231.267622532849;5242.370915490165;5022.673526220784;5024.949750502485;5081.314022606938;5151.871203219949;5157.277981082614;5499.120140777456;5566.721663916788;5590.161475778625;5595.076812325961;5635.464630860061;6138.969305153446;6141.170941922873;6143.354947730469;6147.446729794296;6147.969260153671;6046.183765191687;6099.115628233925;6112.205413296288;6162.014077747539;6196.411340922605;5644.322681278273;5646.491815736563;5697.658140511582;5721.628094173949;5762.135679648086;5146.433892271847;6183.505319574423;6190.442860142609;6201.503879689704;6234.2830574483605;5970.283565972024;6032.065029920369;6050.3949605040025;6054.212952316171;6070.939290607126;5998.880022399528;6036.396360363929;6080.969595151996;6091.086337049478;6105.649091604566;6099.794059995552;6105.12618022345;6114.028320433944;6119.103262359083;6119.9181221891995;6130.012120365664;6145.293291271471;6145.770845830852;6151.907721384183;6154.630722156685;4737.857864264078;4789.736564488987;4799.928001079987;4843.24929635907;4850.393700787402;4326.740395576213;4373.322135069069;4381.6932814703305;4385.583369579885;4453.265211240174;5729.914051289234;5734.885302293931;5745.913811292834;5770.221020162308;5770.394108618619;6112.877742445126;6161.507079433634;6164.044573091178;6177.980633195472;6186.979148440547;4645.326427667969;5628.97185514078;5644.153376993402;5708.600397972185;5712.942870571324;5219.869503262373;5279.102552566073;5307.867303317448;5353;5362.329708786402;6186.969065154735;6210.347913469021;6219.657918814509;6230.376962303733;6231.2522497300615;6088.573799833969;6162.876742465036;6171.413715697002;6197.81406557804;6198.721057552511;6104.398524058527;6136.531586410724;6182.28903676083;6195.628262304276;6204.038374052029;6101.7016460496225;6109.9816581254145;6111.419415155553;6114.966544785144;6131.866048757656;6110.991686371699;6150.876982460236;6164;6177.104319873503;6183.96908015457;5689.487946084872;5790.160426738015;5985.25184351956;6004.129401236709;6055.576109672281;5920.348761636131;5940.405959404025;6012.218411606463;6018.21763170785;6095.542834287357;5870.7945221917025;5877.471027607536;5888.676122813115;5890.2342695449315;5901.173835662925;5974.850628734316;5976.133460648095;6025.276966764016;6047.939520604914;6079.817605471843;5628.662280263197;5687.658740475585;5697.971510142423;5724.227229323988;5797.362290147996 22:05:38 INFO - PROCESS | 1662 | |1;ext.html;482.10810001497225;495.6431369414021;505.69658205076934;522.1071966936538;523.6491550661057;30351;30940.690593094063;31653.208669783267;39411.40882886759;39834;41043.58956410435;41455;41476;41581.58418415815;41596.37605435921;9412.011738767416;9566.80866382672;9584.616615335379;9587.95206023969;9588.52057397131;9452.57463414148;9482.288828337867;9586.616535338613;9595.088466595662;9626.181774549172;9566.282528810367;9617.75955601112;9625.133737963582;9638.421694698305;9646.758831029245;9540.713778586618;9575.760605984837;9593.568289426992;9600.519974001272;9609.759756006086;8554.63125899853;9446.480443575601;9501.334906556544;9514.571844267024;9520.190783783386;36505.81747091247;39233.41149882754;39256.60743392558;39263.41104883429;39313.41029884554;3282.868685252587;3287.7205437537837;3354.580677415323;3486.546748922624;3655.3968595181764;29777;29870;30146.794128234844;30151.69848301511;30661;3151.8739250429953;3200.087974927158;3223.2586505103723;3257.1531401835455;3318.4856347266214;397494;474394;476180.9999999965;478236.0910449806;486621;56701;56918.7154064227;56922.7153864228;56968.86062278731;56974.43615037333;33344.66655333464;34042.31915361679;34053.148671283416;59504.40495594989;59843.70078149581;15415;15754.369825207092;15789.605259868595;15791.921040394724;15796.60508487297;11946.701332466584;12070.396480175956;12074.939625301817;12075;12126.575569855013;18619.906900465412;18629.627407451775;18643.347482838035;18662.973536455353;18669.43991680252;6270.717817698123;7673.654685539164;7690.346320562815;7792.882846861187;7794.3764498839955;858.2361698088706;945.5366870233536;967.2890425537224;1027.6557353286582;1117.3407689463256;27836.443271134867;29012.854935725187;29206.786105019146;29838.701612983594;29933.70066299309;893.3701740273092;1013.2704452793977;1013.8681971343678;1041.6874937518714;1092.5684354679856;14649.707005859824;14967.775483367759;15267.236638168048;15460.458883939233;15640.2179891005;579600.2039979546;582472.0876395591;584138;585405;587229.063854678;55028.72485637546;55603;55617.443825561226;55629.887402252534;55754.72122639442;1204.175140029083;1245.0724210463081;1317.1043690290694;1337.317967836391;1360.149906308557;25686.8715656428;28807.56788648214;30284.394312113192;30984.845075774476;31947.840260798548;52819;53300.73349633227;53583.6604084901;53636.46363536471;53861.46138538564;580561;583134;583572;584099;584210;40442.9889252771;41304;41498.58501415068;41772.79113604413;41832.79083604684;37222.44166337561;45268.54731452775;45880.77059614681;46047;47046.11923509561;37819.62180378271;38655.6134438652;38855.80572097121;38950.61049389583;38985.610143899336;30375.544366834074;38010.809945950095;38091;39081.82754517369;39358.803205983786;36759;37146.44280335851;37932.05169870775;37968.430473542365;38232;29976.850115749283;32721.836390817894;33725.66274337225;34305.82847085749;34394.31211375808;24894.377640558407;25008.74991250137;25043.620856019377;25204.74795252024;25575.872120639277 22:05:38 INFO - PROCESS | 1662 | |2;jquery.html;351.8715668780896;370.8831718008827;371.37979574111216;380.8781190019194;398.5595916512254;14952.850471495281;15263.694726105472;15811.525654230363;20130.396088117344;20756.16975320989;16015.439459618916;20117.19531218753;20188.49528761778;20405.591888162227;20625.865577393237;5698.572607054477;5981.910271345933;5987.221661184061;5988.790392336269;5994.5204383649425;4601.33280674302;6430.7749228777;6508.47932165428;6570.63861487618;6578.309277525863;5501.4223506531835;6218.564700470969;6457.741690332381;6499.350064993487;6502.967485162591;6380.138681278015;6418.614883107029;6443.420092191678;6453.903191452132;6491.058796474508;5062;5338.91991620126;5395.892082158335;5424.755885985141;5614.747336369873;10785.5685772569;12774.872251277462;13028.934855325662;18047.007414592194;24578.754212457825;2087.8747275163387;2116.8518203725744;2255.2670382125875;2304.193532263711;2357.704927842647;9781.46201958892;9919.454430006346;10321;10333.018363255478;13949.32608087026;1500.9024413413201;1635.2641311409914;1793.2737241417246;1815.1196669615226;1858.721191821224;98292.22201113809;116778;125008;125491.37254313761;125738.11392829206;7225.494215404976;9478.24174066087;9769.804603908024;9777.9022209777;9945.071696679772;10031;10822.296550724177;12096.911277984847;12263.26420414778;12280.692982675504;6270.341614130451;7816.53100813953;7866.685332586632;7873.606319684108;8014.15851335613;8097.433179677366;8101.716439924574;8109.837803243902;8243.25810677042;8282.378821588285;3833.9808300958316;3852.788096654655;3863.9613603864163;3926.2147570485445;3957.881263562098;1885.6040231551253;1897.1083590712344;1902.5540589152067;1916.1760443009362;1954.7752008519203;820.6307161777224;857.7040920882285;858.6393714639867;892.3084609427616;899.8920129584492;20322;21197.470063248235;21219.8939005304;21253.46866328323;21342.573148537253;889.5374405309333;893.8033632600817;918.3709159225951;923.6859467780853;969.2924165359327;8471.745847624581;8579.013413457533;9796.167325777245;10908.018278354828;11178;572863.1356843272;576262;585279;587331;587813;84023;119680.20479692811;125436;126543;133645;947.5357075033322;973.6300205921705;984.694744629153;984.921206303494;988.8566157907063;19202.8079719201;19444.125014374105;19572.92348920823;19782.70325945141;19787;35686.821565892;35844.820775895954;52533.474665252856;52711.736441317546;53982;76145;78815;79677.00807479859;79878;80788;7841.333486653698;8065.556394398364;8081.676732930852;8091.797705057421;8308.086110527958;12141.514339426323;12643.747125057631;12700.428480718205;12774.36128193568;13124.606261812161;10866.61966831157;10973.670789876316;11214.66356009321;11245.943770281096;11316.321020738782;10604.734881628021;10633.521491532745;10938.234323597271;11200.10399168081;11310.660680179608;8918.821623567623;10616.84074738895;10894.237403381687;11319.773604528027;11545.13411494158;7832.170625864504;7867.17394673551;7909.386267284776;8264.338852891875;8280.296174825207;8173;9922.603095876084;10797.892021079688;11316.886831131584;11423.657290281304 22:05:38 INFO - PROCESS | 1662 | |3;mootools.html;1375.77299745542;1529.8623123918844;1531.8324570732414;1723.9569010774728;1875.6436277107348;7435;7809.140994490602;8087.959560202198;8348.123447038064;8357.74926752197;8200;8219.876701849476;8229.930109085826;8304.667813287477;8330.20863018014;2292.9656055159144;2318.4783423729696;2322.814174866015;2323.512062466884;2326.766813588792;2252.526969336441;2326.2439707095177;2340.356401989458;2342.812574994005;2346.530693861226;2276.430892276931;2283.486215601493;2312.0173926081434;2314.884255787212;2321.4776675248104;2255.1881322723807;2270.648049552322;2291.014863608648;2292.0373443153917;2308.35366097493;2279.327598358488;2307.5154217614154;2312.2022902098915;2313.5835549601065;2315.0855412112123;8237.299829514499;8284.958575207145;8341.41610087294;8352.8329433411;8358.414910956235;4459.554044595547;5046.940142570064;5211.348581427322;5218.452062533455;5221.556167725748;3498.6676265754713;3587.515685382466;3600.3357515438647;3603.8557058550123;3605.5853576838736;1034.2036631793553;1055.6516349604613;1074.0548317480568;1084.3006260961636;1091.8471414002047;10995.34027958325;11033.337999720043;11044.447777611167;11067.72330691731;11099.667009989713;4427.6236519896165;4484.977575112103;4660.976695116503;4719.858404247878;4752.097101550694;8643.222110010129;8662;8686.739397818075;8701.825963480695;8702.95648521766;5095.515925987025;5112.079825631347;5116.462771409023;5118.38579370478;5129.128048231735;3954.8418063277722;4171.328428994385;4705.694129881546;4722.716637001791;4788.970371370172;3531.9823400882833;3596.478510615946;3642.453631955228;3672.265546890633;3683.778973261613;1123.7640095579857;1127.3968426891574;1133.1727838677646;1136.0684238924002;1141.092831199182;863.1989195062064;869.5782545465444;879.8900137482815;890.3055616618918;900.1898291537537;5384.138537833927;5423.132298832168;5559.027170245191;5707.686077265707;5769.596128271065;894.49461054504;907.26964793342;976.9853452198223;979.7501637082498;1004.4826914139225;3660.158163622382;3692.372296709566;3761.304158730589;3772.8113594320175;3799.6770274526975;9675.612975481043;10185.236107291983;10224.182065434747;10234.181265498743;10243.07812296897;9576.760580985392;9941.254405919584;9948.701538953697;9965.651202207888;9975.650852220282;7718.266764657348;7944.801379965547;7946.682132714626;7954.64204110828;7954.801129971681;5281.207818827206;5383.434739352469;5434.701091440009;5733.369329373849;5866.711982326981;7387.741429049957;9384.859227111736;9394.577244023898;9500;9525;8985.46087234768;9280.164785169367;9440.811183776423;9626.95186524063;9645;6534.183227096613;6973.6164510952385;7179.712811487482;7270.982062511147;7332.45006624516;7935.801604959922;8103.432759706764;8116.675332986851;8122.431429800094;8129;7033.156021277479;7227.602481863548;7246.998712664734;7283.817904552428;7288.890666640111;6961.338672826073;7031.542949708457;7056;7231.963840180765;7245.166805817398;6583.473322134314;6778.389944904982;6778.593284402951;6778.694958726771;6787.253402125861;4742.52574742523;4788.209945359116;4804.903901922012;4838.443578988461;4940.92588611164;4412.205802955499;4528.88677783058;4776.8566942991765;4789.353437286061;4910.140725373117 22:05:38 INFO - PROCESS | 1662 | |4;prototype.html;294.4170542326194;300.7699110180711;308.38015588666804;308.6327270548048;312.0280326782073;4293.871183864481;5148.485151484854;5203.725087353599;5244.292020577221;5269.473052694738;4752.239641657336;4895.31465594817;5006.449290578043;5098.209777484487;5102.061216737644;3975.5687952337134;3975.761454312736;3986.123052928351;4002.6397624213814;4006.8397264109544;3465.878694245702;3993;3996.0009997500624;3996.1008773025983;4004.557220095754;3659.213269147133;3870.903227419323;3898.376259798433;3938.448617193595;3973.185496973128;3251.3659836331926;3350.8157051362164;3430.794152350842;3828.368319227352;3882;2947.924007737182;3392.135005573563;3399.609044959812;3421.0250078727445;3425.4348032574594;4826;5072.898542029138;5080.59355251579;5084.44071152173;5112.948870511284;4435.7338559686195;4435.955640443619;4476.910461790746;4502.954970450286;4515.661325400575;4518.661100417482;5429.9411614735145;5471.385941147371;5477.315335583052;5483.314585676791;3707.238107609821;3720.981395093007;3738.9813050934845;3740.5698344690163;3748.175401411685;5156.819511317123;5458.9454105458835;5673.383085820563;5726.713664316768;5744.684042377709;3789.1663833956486;3792.6156952712063;3796.620337966181;3799.5820459749407;3800.6009369015856;3155.0377134974055;3587.013571267922;3614.4939708440315;3787.507624008861;3823.3882578787816;4202.495700515958;4394.494633117232;4421.646268298528;4451.488078870907;4475.709078909926;4530.456345238593;5399.109146990702;5457.836264912059;5466;5468.179773033997;1130.9943450282697;1219.6522842259353;1237.10928131745;1261.5521489871146;1290.605926007243;774.2605811450052;806.9919300806916;869.6260607938647;880.5421180985851;882.3823323673327;4550.817967281338;4634.629229661619;4991.775370108354;5082.593392528589;5118.87202819925;4880.780364883589;5338.905524367496;5447.673139611636;5473.877855039707;5554.222408862763;4110.856120035784;4830.637702172351;4979.954209616021;5073.974630126826;5143.022825663112;2552.6515605642853;2557.961630575543;2693.7710294624785;2907.113330434238;2916.416716656677;4723.905521889543;5397.35231772182;5701.344345400249;5714.342850572154;5725.742341594639;5607.299087614048;5664.915026274609;5678.659280443187;5695.7152142392715;5702.914456283159;4768.356271903249;4770.6183505318795;5073.746312684351;5474.39781624021;5673.567491667564;4776.665633405628;5329;5333.06671332523;5492.034301477158;5653.604247702621;5617.48327951459;5628.85927851807;5639.488409272648;5641.238432811682;5643.943560564342;5170.8965820684125;5906.279044202125;5908.615939963888;5918.319393269829;5943.524518038633;3272.836358182129;3367;3682.3187710273687;3834.6357096075826;3869.6008474745836;5628.296462942132;5639.661620302795;5642.60501764889;5646.435356464485;5651.463111004448;5427.674339539641;5468.425815289337;5471.425500322568;5500.944990550043;5511;4837.612990960644;4933.9506604933495;5158.742062896915;5401.461313182798;5488.725563721878;5193.246979188072;5357.1696387060065;5368.597355198298;5368.892622147457;5391.62258641907;5432.538234250133;5543.8891222176135;5552.833414997556;5555.055820415187;5568.749406276808;4686.765661716969;5403.324584426947;5416.539594134542;5437.673739575638;5459.344878614592 22:05:38 INFO - PROCESS | 1662 | |5;yui.html;692.5290802254467;725.4667819152921;748.5246868238667;785.4344871692383;801.7875263055295;15131.621709457255;15380.61548461289;15383.538493845188;15420.922895385507;15439.305231264592;13403.865961340383;13748.793768093461;13780.173189608631;13809;13819.723605527883;650.4341223135866;688.8518968421788;689.3279052923384;818.2635627934847;845.1632883445376;821.7534739578102;829.9460535065232;831.6174559702544;836.7280633794011;838.7483754873545;884.703624285865;885.5262434597491;886.5788750343568;890.4968692688642;890.7149712092133;684.4558575932097;883.7569668341193;884.0275696733606;884.9867251991193;887.3300658003167;526.194921769693;640.8814369341686;659.5251418978328;667.2526770017563;667.7028722218614;14051.297435128203;14329.498467553585;14580.635484112876;14605.70788584233;14614.415423383052;13066.673333166747;13192.86807131926;13325.13386629866;13471.326433678374;13496;12024.33866137362;12127.514899404014;12163.939180304042;12250;12286.525616925937;4335.414719012924;4365.2142614329405;4397;4483.103379324149;4614.330922016323;90888;91448;91713.54143229307;92722.53638731762;92838.14323713555;10530.631427899987;10642.148628109733;10642.25504214713;10672.46637668129;10817.83773243402;20342.186312547627;20344.287949921683;20360.89819550893;20378;20419.693704594443;7395.445341599401;7465.888011679829;7475.0656167979005;7510.173880873209;7649.464537482434;4160.729552579072;4164.958350416457;4183.6234738873645;4240.215560121387;4360.41134446852;3000.549917512347;3041.6045914031033;3094.6441159266974;3108.347247078094;3111.2066423061974;627.704978660029;634.8000379880323;634.8761991411723;650.3658932540735;701.992980070203;515.5257163409672;602.3434456442499;621.4686443091182;675.8546912413855;681.8738533371342;8768.605412756442;9107.863382049274;9258.699241000806;9313.860292095624;9384;520.2144761410298;537.5538303208327;660.4815220052236;665.3313420012856;666.6866572710818;4359.782010899442;4395.230834603995;4403.867883963486;4431.499011754892;4461.643068554507;115748.42125789318;117092;117910.82089179169;118030;121626;81894.59052704817;100365.49086272756;102585.48707256417;103969;106336;92801.07198927924;92916;93563.30209336063;93897.59153612565;94843.52578237065;8716.520591367536;8793.868091978753;8842.336824738042;8851.114888511098;8868.556572171494;55502.44497555134;58117.70941145267;58418;59156.04219788907;59481.51296217456;82058.17941820505;83441.16558834577;84444;85146;85937.14062859291;9546.284028698014;11469.466594027173;11749.355090287538;12057.51769929193;12380.690482738004;13976.580702578938;14154.858451415354;14157.534383296372;14372.568822935329;14419.85580144227;10443.530041148015;13155.342232888508;13442.462301508222;13503.932480337535;13766.93116534411;13109.737805244033;13147;13514.121582097132;13567.932160339134;13888.236147012012;11446.656600302003;12250.571230006906;12821.358932053547;13282.203067815963;13528.86471135276;10850.186236032487;10929.125669946545;11243.943780281046;11257.04315133223;11489.770204596029;10842.366981601193;11058.060064894575;11092.334459932106;11157.218994670295;11184.440777960906 22:05:38 INFO - PROCESS | 1662 | __end_tp_report 22:05:38 INFO - PROCESS | 1662 | __start_cc_report 22:05:38 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1639 22:05:38 INFO - PROCESS | 1662 | __end_cc_report 22:05:38 INFO - PROCESS | 1662 | __startTimestamp1477976738196__endTimestamp 22:05:38 INFO - PROCESS | 1662 | 22:05:38 INFO - PROCESS | 1662 | ------- Summary: start ------- 22:05:38 INFO - PROCESS | 1662 | Number of tests: 6 22:05:38 INFO - PROCESS | 1662 | 22:05:38 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5644.49 Median:5797.36 stddev:639.23 (11.0%) stddev-sans-first:605.18 22:05:38 INFO - PROCESS | 1662 | Values: 2948.0 3271.7 3275.2 3296.0 3310.7 5458.4 5533.1 5566.7 5634.4 5641.1 5593.5 5635.5 5638.2 5642.3 5642.9 5062.6 5107.7 5117.5 5153.7 5191.0 5122.4 5197.5 5205.1 5207.3 5211.0 5076.4 5125.7 5135.5 5144.8 5187.5 5215.5 5219.0 5219.1 5231.3 5242.4 5022.7 5024.9 5081.3 5151.9 5157.3 5499.1 5566.7 5590.2 5595.1 5635.5 6139.0 6141.2 6143.4 6147.4 6148.0 6046.2 6099.1 6112.2 6162.0 6196.4 5644.3 5646.5 5697.7 5721.6 5762.1 5146.4 6183.5 6190.4 6201.5 6234.3 5970.3 6032.1 6050.4 6054.2 6070.9 5998.9 6036.4 6081.0 6091.1 6105.6 6099.8 6105.1 6114.0 6119.1 6119.9 6130.0 6145.3 6145.8 6151.9 6154.6 4737.9 4789.7 4799.9 4843.2 4850.4 4326.7 4373.3 4381.7 4385.6 4453.3 5729.9 5734.9 5745.9 5770.2 5770.4 6112.9 6161.5 6164.0 6178.0 6187.0 4645.3 5629.0 5644.2 5708.6 5712.9 5219.9 5279.1 5307.9 5353.0 5362.3 6187.0 6210.3 6219.7 6230.4 6231.3 6088.6 6162.9 6171.4 6197.8 6198.7 6104.4 6136.5 6182.3 6195.6 6204.0 6101.7 6110.0 6111.4 6115.0 6131.9 6111.0 6150.9 6164.0 6177.1 6184.0 5689.5 5790.2 5985.3 6004.1 6055.6 5920.3 5940.4 6012.2 6018.2 6095.5 5870.8 5877.5 5888.7 5890.2 5901.2 5974.9 5976.1 6025.3 6047.9 6079.8 5628.7 5687.7 5698.0 5724.2 5797.4 22:05:38 INFO - PROCESS | 1662 | 22:05:38 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:67418.88 Median:39288.41 stddev:145874.26 (371.3%) stddev-sans-first:146196.90 22:05:38 INFO - PROCESS | 1662 | Values: 482.1 495.6 505.7 522.1 523.6 30351.0 30940.7 31653.2 39411.4 39834.0 41043.6 41455.0 41476.0 41581.6 41596.4 9412.0 9566.8 9584.6 9588.0 9588.5 9452.6 9482.3 9586.6 9595.1 9626.2 9566.3 9617.8 9625.1 9638.4 9646.8 9540.7 9575.8 9593.6 9600.5 9609.8 8554.6 9446.5 9501.3 9514.6 9520.2 36505.8 39233.4 39256.6 39263.4 39313.4 3282.9 3287.7 3354.6 3486.5 3655.4 29777.0 29870.0 30146.8 30151.7 30661.0 3151.9 3200.1 3223.3 3257.2 3318.5 397494.0 474394.0 476181.0 478236.1 486621.0 56701.0 56918.7 56922.7 56968.9 56974.4 33344.7 34042.3 34053.1 59504.4 59843.7 15415.0 15754.4 15789.6 15791.9 15796.6 11946.7 12070.4 12074.9 12075.0 12126.6 18619.9 18629.6 18643.3 18663.0 18669.4 6270.7 7673.7 7690.3 7792.9 7794.4 858.2 945.5 967.3 1027.7 1117.3 27836.4 29012.9 29206.8 29838.7 29933.7 893.4 1013.3 1013.9 1041.7 1092.6 14649.7 14967.8 15267.2 15460.5 15640.2 579600.2 582472.1 584138.0 585405.0 587229.1 55028.7 55603.0 55617.4 55629.9 55754.7 1204.2 1245.1 1317.1 1337.3 1360.1 25686.9 28807.6 30284.4 30984.8 31947.8 52819.0 53300.7 53583.7 53636.5 53861.5 580561.0 583134.0 583572.0 584099.0 584210.0 40443.0 41304.0 41498.6 41772.8 41832.8 37222.4 45268.5 45880.8 46047.0 47046.1 37819.6 38655.6 38855.8 38950.6 38985.6 30375.5 38010.8 38091.0 39081.8 39358.8 36759.0 37146.4 37932.1 37968.4 38232.0 29976.9 32721.8 33725.7 34305.8 34394.3 24894.4 25008.7 25043.6 25204.7 25575.9 22:05:38 INFO - PROCESS | 1662 | 22:05:38 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:33569.74 Median:2178.22 stddev:97189.65 (4461.9%) stddev-sans-first:97430.29 22:05:38 INFO - PROCESS | 1662 | Values: 351.9 370.9 371.4 380.9 398.6 14952.9 15263.7 15811.5 20130.4 20756.2 16015.4 20117.2 20188.5 20405.6 20625.9 5698.6 5981.9 5987.2 5988.8 5994.5 4601.3 6430.8 6508.5 6570.6 6578.3 5501.4 6218.6 6457.7 6499.4 6503.0 6380.1 6418.6 6443.4 6453.9 6491.1 5062.0 5338.9 5395.9 5424.8 5614.7 10785.6 12774.9 13028.9 18047.0 24578.8 2087.9 2116.9 2255.3 2304.2 2357.7 9781.5 9919.5 10321.0 10333.0 13949.3 1500.9 1635.3 1793.3 1815.1 1858.7 98292.2 116778.0 125008.0 125491.4 125738.1 7225.5 9478.2 9769.8 9777.9 9945.1 10031.0 10822.3 12096.9 12263.3 12280.7 6270.3 7816.5 7866.7 7873.6 8014.2 8097.4 8101.7 8109.8 8243.3 8282.4 3834.0 3852.8 3864.0 3926.2 3957.9 1885.6 1897.1 1902.6 1916.2 1954.8 820.6 857.7 858.6 892.3 899.9 20322.0 21197.5 21219.9 21253.5 21342.6 889.5 893.8 918.4 923.7 969.3 8471.7 8579.0 9796.2 10908.0 11178.0 572863.1 576262.0 585279.0 587331.0 587813.0 84023.0 119680.2 125436.0 126543.0 133645.0 947.5 973.6 984.7 984.9 988.9 19202.8 19444.1 19572.9 19782.7 19787.0 35686.8 35844.8 52533.5 52711.7 53982.0 76145.0 78815.0 79677.0 79878.0 80788.0 7841.3 8065.6 8081.7 8091.8 8308.1 12141.5 12643.7 12700.4 12774.4 13124.6 10866.6 10973.7 11214.7 11245.9 11316.3 10604.7 10633.5 10938.2 11200.1 11310.7 8918.8 10616.8 10894.2 11319.8 11545.1 7832.2 7867.2 7909.4 8264.3 8280.3 8173.0 9922.6 10797.9 11316.9 11423.7 22:05:38 INFO - PROCESS | 1662 | 22:05:38 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5410.89 Median:5123.76 stddev:2964.08 (57.8%) stddev-sans-first:2956.88 22:05:38 INFO - PROCESS | 1662 | Values: 1375.8 1529.9 1531.8 1724.0 1875.6 7435.0 7809.1 8088.0 8348.1 8357.7 8200.0 8219.9 8229.9 8304.7 8330.2 2293.0 2318.5 2322.8 2323.5 2326.8 2252.5 2326.2 2340.4 2342.8 2346.5 2276.4 2283.5 2312.0 2314.9 2321.5 2255.2 2270.6 2291.0 2292.0 2308.4 2279.3 2307.5 2312.2 2313.6 2315.1 8237.3 8285.0 8341.4 8352.8 8358.4 4459.6 5046.9 5211.3 5218.5 5221.6 3498.7 3587.5 3600.3 3603.9 3605.6 1034.2 1055.7 1074.1 1084.3 1091.8 10995.3 11033.3 11044.4 11067.7 11099.7 4427.6 4485.0 4661.0 4719.9 4752.1 8643.2 8662.0 8686.7 8701.8 8703.0 5095.5 5112.1 5116.5 5118.4 5129.1 3954.8 4171.3 4705.7 4722.7 4789.0 3532.0 3596.5 3642.5 3672.3 3683.8 1123.8 1127.4 1133.2 1136.1 1141.1 863.2 869.6 879.9 890.3 900.2 5384.1 5423.1 5559.0 5707.7 5769.6 894.5 907.3 977.0 979.8 1004.5 3660.2 3692.4 3761.3 3772.8 3799.7 9675.6 10185.2 10224.2 10234.2 10243.1 9576.8 9941.3 9948.7 9965.7 9975.7 7718.3 7944.8 7946.7 7954.6 7954.8 5281.2 5383.4 5434.7 5733.4 5866.7 7387.7 9384.9 9394.6 9500.0 9525.0 8985.5 9280.2 9440.8 9627.0 9645.0 6534.2 6973.6 7179.7 7271.0 7332.5 7935.8 8103.4 8116.7 8122.4 8129.0 7033.2 7227.6 7247.0 7283.8 7288.9 6961.3 7031.5 7056.0 7232.0 7245.2 6583.5 6778.4 6778.6 6778.7 6787.3 4742.5 4788.2 4804.9 4838.4 4940.9 4412.2 4528.9 4776.9 4789.4 4910.1 22:05:38 INFO - PROCESS | 1662 | 22:05:38 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4413.92 Median:5039.67 stddev:1374.92 (27.3%) stddev-sans-first:1343.56 22:05:38 INFO - PROCESS | 1662 | Values: 294.4 300.8 308.4 308.6 312.0 4293.9 5148.5 5203.7 5244.3 5269.5 4752.2 4895.3 5006.4 5098.2 5102.1 3975.6 3975.8 3986.1 4002.6 4006.8 3465.9 3993.0 3996.0 3996.1 4004.6 3659.2 3870.9 3898.4 3938.4 3973.2 3251.4 3350.8 3430.8 3828.4 3882.0 2947.9 3392.1 3399.6 3421.0 3425.4 4826.0 5072.9 5080.6 5084.4 5112.9 4435.7 4436.0 4476.9 4503.0 4515.7 4518.7 5429.9 5471.4 5477.3 5483.3 3707.2 3721.0 3739.0 3740.6 3748.2 5156.8 5458.9 5673.4 5726.7 5744.7 3789.2 3792.6 3796.6 3799.6 3800.6 3155.0 3587.0 3614.5 3787.5 3823.4 4202.5 4394.5 4421.6 4451.5 4475.7 4530.5 5399.1 5457.8 5466.0 5468.2 1131.0 1219.7 1237.1 1261.6 1290.6 774.3 807.0 869.6 880.5 882.4 4550.8 4634.6 4991.8 5082.6 5118.9 4880.8 5338.9 5447.7 5473.9 5554.2 4110.9 4830.6 4980.0 5074.0 5143.0 2552.7 2558.0 2693.8 2907.1 2916.4 4723.9 5397.4 5701.3 5714.3 5725.7 5607.3 5664.9 5678.7 5695.7 5702.9 4768.4 4770.6 5073.7 5474.4 5673.6 4776.7 5329.0 5333.1 5492.0 5653.6 5617.5 5628.9 5639.5 5641.2 5643.9 5170.9 5906.3 5908.6 5918.3 5943.5 3272.8 3367.0 3682.3 3834.6 3869.6 5628.3 5639.7 5642.6 5646.4 5651.5 5427.7 5468.4 5471.4 5500.9 5511.0 4837.6 4934.0 5158.7 5401.5 5488.7 5193.2 5357.2 5368.6 5368.9 5391.6 5432.5 5543.9 5552.8 5555.1 5568.7 4686.8 5403.3 5416.5 5437.7 5459.3 22:05:38 INFO - PROCESS | 1662 | 22:05:38 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:21667.47 Median:4380.22 stddev:32356.97 (738.7%) stddev-sans-first:32409.41 22:05:38 INFO - PROCESS | 1662 | Values: 692.5 725.5 748.5 785.4 801.8 15131.6 15380.6 15383.5 15420.9 15439.3 13403.9 13748.8 13780.2 13809.0 13819.7 650.4 688.9 689.3 818.3 845.2 821.8 829.9 831.6 836.7 838.7 884.7 885.5 886.6 890.5 890.7 684.5 883.8 884.0 885.0 887.3 526.2 640.9 659.5 667.3 667.7 14051.3 14329.5 14580.6 14605.7 14614.4 13066.7 13192.9 13325.1 13471.3 13496.0 12024.3 12127.5 12163.9 12250.0 12286.5 4335.4 4365.2 4397.0 4483.1 4614.3 90888.0 91448.0 91713.5 92722.5 92838.1 10530.6 10642.1 10642.3 10672.5 10817.8 20342.2 20344.3 20360.9 20378.0 20419.7 7395.4 7465.9 7475.1 7510.2 7649.5 4160.7 4165.0 4183.6 4240.2 4360.4 3000.5 3041.6 3094.6 3108.3 3111.2 627.7 634.8 634.9 650.4 702.0 515.5 602.3 621.5 675.9 681.9 8768.6 9107.9 9258.7 9313.9 9384.0 520.2 537.6 660.5 665.3 666.7 4359.8 4395.2 4403.9 4431.5 4461.6 115748.4 117092.0 117910.8 118030.0 121626.0 81894.6 100365.5 102585.5 103969.0 106336.0 92801.1 92916.0 93563.3 93897.6 94843.5 8716.5 8793.9 8842.3 8851.1 8868.6 55502.4 58117.7 58418.0 59156.0 59481.5 82058.2 83441.2 84444.0 85146.0 85937.1 9546.3 11469.5 11749.4 12057.5 12380.7 13976.6 14154.9 14157.5 14372.6 14419.9 10443.5 13155.3 13442.5 13503.9 13766.9 13109.7 13147.0 13514.1 13567.9 13888.2 11446.7 12250.6 12821.4 13282.2 13528.9 10850.2 10929.1 11243.9 11257.0 11489.8 10842.4 11058.1 11092.3 11157.2 11184.4 22:05:38 INFO - PROCESS | 1662 | -------- Summary: end -------- 22:05:38 INFO - PROCESS | 1662 | 22:05:38 INFO - TEST-INFO | 1662: exit 0 22:05:38 INFO - TEST-OK | dromaeo_css | took 1119899ms 22:05:38 INFO - TEST-START | kraken 22:05:38 INFO - operating with platform_type : mac_ 22:05:38 INFO - Initialising browser for kraken test... 22:05:38 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpZr5qln/profile http://localhost:49272/getInfo.html) 22:05:41 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 22:05:41 INFO - PROCESS | 1668 | colorDepth:24 22:05:41 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 22:05:41 INFO - PROCESS | 1668 | __metrics 22:05:41 INFO - PROCESS | 1668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:05:41 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:05:42 INFO - TEST-INFO | 1668: exit 0 22:05:42 INFO - Browser initialized. 22:05:42 INFO - Running cycle 1/1 for kraken test... 22:05:42 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpZr5qln/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:05:54 INFO - PROCESS | 1669 | RSS: Main: 232583168 22:05:54 INFO - PROCESS | 1669 | 22:05:57 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 22:05:57 INFO - PROCESS | 1669 | RSS: Main: 292282368 22:05:57 INFO - PROCESS | 1669 | 22:06:00 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 22:06:01 INFO - PROCESS | 1669 | RSS: Main: 294191104 22:06:01 INFO - PROCESS | 1669 | 22:06:04 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 22:06:05 INFO - PROCESS | 1669 | RSS: Main: 382885888 22:06:05 INFO - PROCESS | 1669 | 22:06:07 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 22:06:07 INFO - PROCESS | 1669 | RSS: Main: 284319744 22:06:07 INFO - PROCESS | 1669 | 22:06:09 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:06:10 INFO - PROCESS | 1669 | RSS: Main: 288665600 22:06:10 INFO - PROCESS | 1669 | 22:06:13 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 22:06:13 INFO - PROCESS | 1669 | RSS: Main: 326557696 22:06:13 INFO - PROCESS | 1669 | 22:06:16 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 22:06:17 INFO - PROCESS | 1669 | RSS: Main: 326897664 22:06:17 INFO - PROCESS | 1669 | 22:06:19 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 22:06:20 INFO - PROCESS | 1669 | RSS: Main: 327196672 22:06:20 INFO - PROCESS | 1669 | 22:06:22 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:06:22 INFO - PROCESS | 1669 | RSS: Main: 304144384 22:06:22 INFO - PROCESS | 1669 | 22:06:24 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:06:25 INFO - PROCESS | 1669 | RSS: Main: 304103424 22:06:25 INFO - PROCESS | 1669 | 22:06:27 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:06:28 INFO - PROCESS | 1669 | RSS: Main: 311902208 22:06:28 INFO - PROCESS | 1669 | 22:06:31 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:06:31 INFO - PROCESS | 1669 | RSS: Main: 327503872 22:06:31 INFO - PROCESS | 1669 | 22:06:34 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:06:35 INFO - PROCESS | 1669 | RSS: Main: 320335872 22:06:35 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 22:06:37 INFO - PROCESS | 1669 | RSS: Main: 364261376 22:06:37 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | __start_tp_report 22:06:37 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 22:06:37 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 22:06:37 INFO - PROCESS | 1669 | |i|pagename|runs| 22:06:37 INFO - PROCESS | 1669 | |0;ai-astar;103;112;121;168;149;113;113;113;117;163 22:06:37 INFO - PROCESS | 1669 | |1;audio-beat-detection;149;118;137;185;113;114;117;113;149;142 22:06:37 INFO - PROCESS | 1669 | |2;audio-dft;183;183;184;186;185;183;181;183;181;183 22:06:37 INFO - PROCESS | 1669 | |3;audio-fft;76;61;59;85;60;62;59;58;81;56 22:06:37 INFO - PROCESS | 1669 | |4;audio-oscillator;83;66;91;73;67;69;88;67;67;92 22:06:37 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;86;85;87;84;86;84;88;88;86;82 22:06:37 INFO - PROCESS | 1669 | |6;imaging-darkroom;94;96;95;94;96;95;95;97;95;95 22:06:37 INFO - PROCESS | 1669 | |7;imaging-desaturate;83;83;82;81;83;85;82;84;89;84 22:06:37 INFO - PROCESS | 1669 | |8;json-parse-financial;57;57;56;55;56;58;57;55;56;55 22:06:37 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;66;80;78;77;72;70;70;71;72;72 22:06:37 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;86;87;89;87;87;85;90;86;93;91 22:06:37 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;147;145;146;157;155;155;143;146;194;164 22:06:37 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;172;173;174;172;170;170;172;170;170;175 22:06:37 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;68;68;68;67;67;67;67;66;66;67 22:06:37 INFO - PROCESS | 1669 | __end_tp_report 22:06:37 INFO - PROCESS | 1669 | __start_cc_report 22:06:37 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1999 22:06:37 INFO - PROCESS | 1669 | __end_cc_report 22:06:37 INFO - PROCESS | 1669 | __startTimestamp1477976797330__endTimestamp 22:06:37 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | ------- Summary: start ------- 22:06:37 INFO - PROCESS | 1669 | Number of tests: 14 22:06:37 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:127.20 Median:119.00 stddev:23.54 (19.8%) stddev-sans-first:23.28 22:06:37 INFO - PROCESS | 1669 | Values: 103.0 112.0 121.0 168.0 149.0 113.0 113.0 113.0 117.0 163.0 22:06:37 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:139.50 stddev:23.45 (16.8%) stddev-sans-first:24.21 22:06:37 INFO - PROCESS | 1669 | Values: 149.0 118.0 137.0 185.0 113.0 114.0 117.0 113.0 149.0 142.0 22:06:37 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.00 stddev:1.55 (0.8%) stddev-sans-first:1.64 22:06:37 INFO - PROCESS | 1669 | Values: 183.0 183.0 184.0 186.0 185.0 183.0 181.0 183.0 181.0 183.0 22:06:37 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:65.70 Median:61.50 stddev:10.67 (17.3%) stddev-sans-first:10.64 22:06:37 INFO - PROCESS | 1669 | Values: 76.0 61.0 59.0 85.0 60.0 62.0 59.0 58.0 81.0 56.0 22:06:37 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:76.30 Median:78.00 stddev:10.92 (14.0%) stddev-sans-first:11.31 22:06:37 INFO - PROCESS | 1669 | Values: 83.0 66.0 91.0 73.0 67.0 69.0 88.0 67.0 67.0 92.0 22:06:37 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.00 stddev:1.90 (2.2%) stddev-sans-first:2.01 22:06:37 INFO - PROCESS | 1669 | Values: 86.0 85.0 87.0 84.0 86.0 84.0 88.0 88.0 86.0 82.0 22:06:37 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.87 22:06:37 INFO - PROCESS | 1669 | Values: 94.0 96.0 95.0 94.0 96.0 95.0 95.0 97.0 95.0 95.0 22:06:37 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:83.60 Median:83.50 stddev:2.22 (2.7%) stddev-sans-first:2.35 22:06:37 INFO - PROCESS | 1669 | Values: 83.0 83.0 82.0 81.0 83.0 85.0 82.0 84.0 89.0 84.0 22:06:37 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:1.03 (1.8%) stddev-sans-first:1.05 22:06:37 INFO - PROCESS | 1669 | Values: 57.0 57.0 56.0 55.0 56.0 58.0 57.0 55.0 56.0 55.0 22:06:37 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:72.80 Median:72.00 stddev:4.26 (5.9%) stddev-sans-first:3.75 22:06:37 INFO - PROCESS | 1669 | Values: 66.0 80.0 78.0 77.0 72.0 70.0 70.0 71.0 72.0 72.0 22:06:37 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:88.00 stddev:2.56 (2.9%) stddev-sans-first:2.60 22:06:37 INFO - PROCESS | 1669 | Values: 86.0 87.0 89.0 87.0 87.0 85.0 90.0 86.0 93.0 91.0 22:06:37 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:155.20 Median:155.00 stddev:15.19 (9.8%) stddev-sans-first:15.81 22:06:37 INFO - PROCESS | 1669 | Values: 147.0 145.0 146.0 157.0 155.0 155.0 143.0 146.0 194.0 164.0 22:06:37 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:172.00 stddev:1.81 (1.1%) stddev-sans-first:1.92 22:06:37 INFO - PROCESS | 1669 | Values: 172.0 173.0 174.0 172.0 170.0 170.0 172.0 170.0 170.0 175.0 22:06:37 INFO - PROCESS | 1669 | 22:06:37 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 22:06:37 INFO - PROCESS | 1669 | Values: 68.0 68.0 68.0 67.0 67.0 67.0 67.0 66.0 66.0 67.0 22:06:37 INFO - PROCESS | 1669 | -------- Summary: end -------- 22:06:37 INFO - PROCESS | 1669 | 22:06:38 INFO - TEST-INFO | 1669: exit 0 22:06:38 INFO - TEST-OK | kraken | took 59376ms 22:06:38 INFO - SUITE-END | took 1179s 22:06:38 INFO - Completed test suite (00:19:39) 22:06:38 INFO - javascript benchmark 22:06:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2947.9999999999995, 3271.7055465008143, 3275.2466932605507, 3295.967040329596, 3310.6854848789358, 5458.372287186975, 5533.114701647737, 5566.721663916808, 5634.352049514302, 5641.069223578115, 5593.468620481058, 5635.464630860072, 5638.154276858473, 5642.294713160855, 5642.887142257163, 5062.569681577062, 5107.744612769366, 5117.513836185556, 5153.665011774241, 5191.0, 5122.359705036871, 5197.454267301917, 5205.089109405858, 5207.297014902996, 5211.035958347698, 5076.390833100033, 5125.743712814363, 5135.486451354872, 5144.794208231666, 5187.507186817246, 5215.452377500384, 5219.034478621467, 5219.138842091051, 5231.267622532849, 5242.370915490165, 5022.673526220784, 5024.949750502485, 5081.314022606938, 5151.871203219949, 5157.277981082614, 5499.120140777456, 5566.721663916788, 5590.161475778625, 5595.076812325961, 5635.464630860061, 6138.969305153446, 6141.170941922873, 6143.354947730469, 6147.446729794296, 6147.969260153671, 6046.183765191687, 6099.115628233925, 6112.205413296288, 6162.014077747539, 6196.411340922605, 5644.322681278273, 5646.491815736563, 5697.658140511582, 5721.628094173949, 5762.135679648086, 5146.433892271847, 6183.505319574423, 6190.442860142609, 6201.503879689704, 6234.2830574483605, 5970.283565972024, 6032.065029920369, 6050.3949605040025, 6054.212952316171, 6070.939290607126, 5998.880022399528, 6036.396360363929, 6080.969595151996, 6091.086337049478, 6105.649091604566, 6099.794059995552, 6105.12618022345, 6114.028320433944, 6119.103262359083, 6119.9181221891995, 6130.012120365664, 6145.293291271471, 6145.770845830852, 6151.907721384183, 6154.630722156685, 4737.857864264078, 4789.736564488987, 4799.928001079987, 4843.24929635907, 4850.393700787402, 4326.740395576213, 4373.322135069069, 4381.6932814703305, 4385.583369579885, 4453.265211240174, 5729.914051289234, 5734.885302293931, 5745.913811292834, 5770.221020162308, 5770.394108618619, 6112.877742445126, 6161.507079433634, 6164.044573091178, 6177.980633195472, 6186.979148440547, 4645.326427667969, 5628.97185514078, 5644.153376993402, 5708.600397972185, 5712.942870571324, 5219.869503262373, 5279.102552566073, 5307.867303317448, 5353.0, 5362.329708786402, 6186.969065154735, 6210.347913469021, 6219.657918814509, 6230.376962303733, 6231.2522497300615, 6088.573799833969, 6162.876742465036, 6171.413715697002, 6197.81406557804, 6198.721057552511, 6104.398524058527, 6136.531586410724, 6182.28903676083, 6195.628262304276, 6204.038374052029, 6101.7016460496225, 6109.9816581254145, 6111.419415155553, 6114.966544785144, 6131.866048757656, 6110.991686371699, 6150.876982460236, 6164.0, 6177.104319873503, 6183.96908015457, 5689.487946084872, 5790.160426738015, 5985.25184351956, 6004.129401236709, 6055.576109672281, 5920.348761636131, 5940.405959404025, 6012.218411606463, 6018.21763170785, 6095.542834287357, 5870.7945221917025, 5877.471027607536, 5888.676122813115, 5890.2342695449315, 5901.173835662925, 5974.850628734316, 5976.133460648095, 6025.276966764016, 6047.939520604914, 6079.817605471843, 5628.662280263197, 5687.658740475585, 5697.971510142423, 5724.227229323988, 5797.362290147996], "value": 5602.357281279846, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.10810001497225, 495.6431369414021, 505.69658205076934, 522.1071966936538, 523.6491550661057, 30351.0, 30940.690593094063, 31653.208669783267, 39411.40882886759, 39834.0, 41043.58956410435, 41455.0, 41476.0, 41581.58418415815, 41596.37605435921, 9412.011738767416, 9566.80866382672, 9584.616615335379, 9587.95206023969, 9588.52057397131, 9452.57463414148, 9482.288828337867, 9586.616535338613, 9595.088466595662, 9626.181774549172, 9566.282528810367, 9617.75955601112, 9625.133737963582, 9638.421694698305, 9646.758831029245, 9540.713778586618, 9575.760605984837, 9593.568289426992, 9600.519974001272, 9609.759756006086, 8554.63125899853, 9446.480443575601, 9501.334906556544, 9514.571844267024, 9520.190783783386, 36505.81747091247, 39233.41149882754, 39256.60743392558, 39263.41104883429, 39313.41029884554, 3282.868685252587, 3287.7205437537837, 3354.580677415323, 3486.546748922624, 3655.3968595181764, 29777.0, 29870.0, 30146.794128234844, 30151.69848301511, 30661.0, 3151.8739250429953, 3200.087974927158, 3223.2586505103723, 3257.1531401835455, 3318.4856347266214, 397494.0, 474394.0, 476180.9999999965, 478236.0910449806, 486621.0, 56701.0, 56918.7154064227, 56922.7153864228, 56968.86062278731, 56974.43615037333, 33344.66655333464, 34042.31915361679, 34053.148671283416, 59504.40495594989, 59843.70078149581, 15415.0, 15754.369825207092, 15789.605259868595, 15791.921040394724, 15796.60508487297, 11946.701332466584, 12070.396480175956, 12074.939625301817, 12075.0, 12126.575569855013, 18619.906900465412, 18629.627407451775, 18643.347482838035, 18662.973536455353, 18669.43991680252, 6270.717817698123, 7673.654685539164, 7690.346320562815, 7792.882846861187, 7794.3764498839955, 858.2361698088706, 945.5366870233536, 967.2890425537224, 1027.6557353286582, 1117.3407689463256, 27836.443271134867, 29012.854935725187, 29206.786105019146, 29838.701612983594, 29933.70066299309, 893.3701740273092, 1013.2704452793977, 1013.8681971343678, 1041.6874937518714, 1092.5684354679856, 14649.707005859824, 14967.775483367759, 15267.236638168048, 15460.458883939233, 15640.2179891005, 579600.2039979546, 582472.0876395591, 584138.0, 585405.0, 587229.063854678, 55028.72485637546, 55603.0, 55617.443825561226, 55629.887402252534, 55754.72122639442, 1204.175140029083, 1245.0724210463081, 1317.1043690290694, 1337.317967836391, 1360.149906308557, 25686.8715656428, 28807.56788648214, 30284.394312113192, 30984.845075774476, 31947.840260798548, 52819.0, 53300.73349633227, 53583.6604084901, 53636.46363536471, 53861.46138538564, 580561.0, 583134.0, 583572.0, 584099.0, 584210.0, 40442.9889252771, 41304.0, 41498.58501415068, 41772.79113604413, 41832.79083604684, 37222.44166337561, 45268.54731452775, 45880.77059614681, 46047.0, 47046.11923509561, 37819.62180378271, 38655.6134438652, 38855.80572097121, 38950.61049389583, 38985.610143899336, 30375.544366834074, 38010.809945950095, 38091.0, 39081.82754517369, 39358.803205983786, 36759.0, 37146.44280335851, 37932.05169870775, 37968.430473542365, 38232.0, 29976.850115749283, 32721.836390817894, 33725.66274337225, 34305.82847085749, 34394.31211375808, 24894.377640558407, 25008.74991250137, 25043.620856019377, 25204.74795252024, 25575.872120639277], "value": 19562.528974555662, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.8715668780896, 370.8831718008827, 371.37979574111216, 380.8781190019194, 398.5595916512254, 14952.850471495281, 15263.694726105472, 15811.525654230363, 20130.396088117344, 20756.16975320989, 16015.439459618916, 20117.19531218753, 20188.49528761778, 20405.591888162227, 20625.865577393237, 5698.572607054477, 5981.910271345933, 5987.221661184061, 5988.790392336269, 5994.5204383649425, 4601.33280674302, 6430.7749228777, 6508.47932165428, 6570.63861487618, 6578.309277525863, 5501.4223506531835, 6218.564700470969, 6457.741690332381, 6499.350064993487, 6502.967485162591, 6380.138681278015, 6418.614883107029, 6443.420092191678, 6453.903191452132, 6491.058796474508, 5062.0, 5338.91991620126, 5395.892082158335, 5424.755885985141, 5614.747336369873, 10785.5685772569, 12774.872251277462, 13028.934855325662, 18047.007414592194, 24578.754212457825, 2087.8747275163387, 2116.8518203725744, 2255.2670382125875, 2304.193532263711, 2357.704927842647, 9781.46201958892, 9919.454430006346, 10321.0, 10333.018363255478, 13949.32608087026, 1500.9024413413201, 1635.2641311409914, 1793.2737241417246, 1815.1196669615226, 1858.721191821224, 98292.22201113809, 116778.0, 125008.0, 125491.37254313761, 125738.11392829206, 7225.494215404976, 9478.24174066087, 9769.804603908024, 9777.9022209777, 9945.071696679772, 10031.0, 10822.296550724177, 12096.911277984847, 12263.26420414778, 12280.692982675504, 6270.341614130451, 7816.53100813953, 7866.685332586632, 7873.606319684108, 8014.15851335613, 8097.433179677366, 8101.716439924574, 8109.837803243902, 8243.25810677042, 8282.378821588285, 3833.9808300958316, 3852.788096654655, 3863.9613603864163, 3926.2147570485445, 3957.881263562098, 1885.6040231551253, 1897.1083590712344, 1902.5540589152067, 1916.1760443009362, 1954.7752008519203, 820.6307161777224, 857.7040920882285, 858.6393714639867, 892.3084609427616, 899.8920129584492, 20322.0, 21197.470063248235, 21219.8939005304, 21253.46866328323, 21342.573148537253, 889.5374405309333, 893.8033632600817, 918.3709159225951, 923.6859467780853, 969.2924165359327, 8471.745847624581, 8579.013413457533, 9796.167325777245, 10908.018278354828, 11178.0, 572863.1356843272, 576262.0, 585279.0, 587331.0, 587813.0, 84023.0, 119680.20479692811, 125436.0, 126543.0, 133645.0, 947.5357075033322, 973.6300205921705, 984.694744629153, 984.921206303494, 988.8566157907063, 19202.8079719201, 19444.125014374105, 19572.92348920823, 19782.70325945141, 19787.0, 35686.821565892, 35844.820775895954, 52533.474665252856, 52711.736441317546, 53982.0, 76145.0, 78815.0, 79677.00807479859, 79878.0, 80788.0, 7841.333486653698, 8065.556394398364, 8081.676732930852, 8091.797705057421, 8308.086110527958, 12141.514339426323, 12643.747125057631, 12700.428480718205, 12774.36128193568, 13124.606261812161, 10866.61966831157, 10973.670789876316, 11214.66356009321, 11245.943770281096, 11316.321020738782, 10604.734881628021, 10633.521491532745, 10938.234323597271, 11200.10399168081, 11310.660680179608, 8918.821623567623, 10616.84074738895, 10894.237403381687, 11319.773604528027, 11545.13411494158, 7832.170625864504, 7867.17394673551, 7909.386267284776, 8264.338852891875, 8280.296174825207, 8173.0, 9922.603095876084, 10797.892021079688, 11316.886831131584, 11423.657290281304], "value": 9094.531549469073, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.77299745542, 1529.8623123918844, 1531.8324570732414, 1723.9569010774728, 1875.6436277107348, 7435.0, 7809.140994490602, 8087.959560202198, 8348.123447038064, 8357.74926752197, 8200.0, 8219.876701849476, 8229.930109085826, 8304.667813287477, 8330.20863018014, 2292.9656055159144, 2318.4783423729696, 2322.814174866015, 2323.512062466884, 2326.766813588792, 2252.526969336441, 2326.2439707095177, 2340.356401989458, 2342.812574994005, 2346.530693861226, 2276.430892276931, 2283.486215601493, 2312.0173926081434, 2314.884255787212, 2321.4776675248104, 2255.1881322723807, 2270.648049552322, 2291.014863608648, 2292.0373443153917, 2308.35366097493, 2279.327598358488, 2307.5154217614154, 2312.2022902098915, 2313.5835549601065, 2315.0855412112123, 8237.299829514499, 8284.958575207145, 8341.41610087294, 8352.8329433411, 8358.414910956235, 4459.554044595547, 5046.940142570064, 5211.348581427322, 5218.452062533455, 5221.556167725748, 3498.6676265754713, 3587.515685382466, 3600.3357515438647, 3603.8557058550123, 3605.5853576838736, 1034.2036631793553, 1055.6516349604613, 1074.0548317480568, 1084.3006260961636, 1091.8471414002047, 10995.34027958325, 11033.337999720043, 11044.447777611167, 11067.72330691731, 11099.667009989713, 4427.6236519896165, 4484.977575112103, 4660.976695116503, 4719.858404247878, 4752.097101550694, 8643.222110010129, 8662.0, 8686.739397818075, 8701.825963480695, 8702.95648521766, 5095.515925987025, 5112.079825631347, 5116.462771409023, 5118.38579370478, 5129.128048231735, 3954.8418063277722, 4171.328428994385, 4705.694129881546, 4722.716637001791, 4788.970371370172, 3531.9823400882833, 3596.478510615946, 3642.453631955228, 3672.265546890633, 3683.778973261613, 1123.7640095579857, 1127.3968426891574, 1133.1727838677646, 1136.0684238924002, 1141.092831199182, 863.1989195062064, 869.5782545465444, 879.8900137482815, 890.3055616618918, 900.1898291537537, 5384.138537833927, 5423.132298832168, 5559.027170245191, 5707.686077265707, 5769.596128271065, 894.49461054504, 907.26964793342, 976.9853452198223, 979.7501637082498, 1004.4826914139225, 3660.158163622382, 3692.372296709566, 3761.304158730589, 3772.8113594320175, 3799.6770274526975, 9675.612975481043, 10185.236107291983, 10224.182065434747, 10234.181265498743, 10243.07812296897, 9576.760580985392, 9941.254405919584, 9948.701538953697, 9965.651202207888, 9975.650852220282, 7718.266764657348, 7944.801379965547, 7946.682132714626, 7954.64204110828, 7954.801129971681, 5281.207818827206, 5383.434739352469, 5434.701091440009, 5733.369329373849, 5866.711982326981, 7387.741429049957, 9384.859227111736, 9394.577244023898, 9500.0, 9525.0, 8985.46087234768, 9280.164785169367, 9440.811183776423, 9626.95186524063, 9645.0, 6534.183227096613, 6973.6164510952385, 7179.712811487482, 7270.982062511147, 7332.45006624516, 7935.801604959922, 8103.432759706764, 8116.675332986851, 8122.431429800094, 8129.0, 7033.156021277479, 7227.602481863548, 7246.998712664734, 7283.817904552428, 7288.890666640111, 6961.338672826073, 7031.542949708457, 7056.0, 7231.963840180765, 7245.166805817398, 6583.473322134314, 6778.389944904982, 6778.593284402951, 6778.694958726771, 6787.253402125861, 4742.52574742523, 4788.209945359116, 4804.903901922012, 4838.443578988461, 4940.92588611164, 4412.205802955499, 4528.88677783058, 4776.8566942991765, 4789.353437286061, 4910.140725373117], "value": 4388.716781705144, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.4170542326194, 300.7699110180711, 308.38015588666804, 308.6327270548048, 312.0280326782073, 4293.871183864481, 5148.485151484854, 5203.725087353599, 5244.292020577221, 5269.473052694738, 4752.239641657336, 4895.31465594817, 5006.449290578043, 5098.209777484487, 5102.061216737644, 3975.5687952337134, 3975.761454312736, 3986.123052928351, 4002.6397624213814, 4006.8397264109544, 3465.878694245702, 3993.0, 3996.0009997500624, 3996.1008773025983, 4004.557220095754, 3659.213269147133, 3870.903227419323, 3898.376259798433, 3938.448617193595, 3973.185496973128, 3251.3659836331926, 3350.8157051362164, 3430.794152350842, 3828.368319227352, 3882.0, 2947.924007737182, 3392.135005573563, 3399.609044959812, 3421.0250078727445, 3425.4348032574594, 4826.0, 5072.898542029138, 5080.59355251579, 5084.44071152173, 5112.948870511284, 4435.7338559686195, 4435.955640443619, 4476.910461790746, 4502.954970450286, 4515.661325400575, 4518.661100417482, 5429.9411614735145, 5471.385941147371, 5477.315335583052, 5483.314585676791, 3707.238107609821, 3720.981395093007, 3738.9813050934845, 3740.5698344690163, 3748.175401411685, 5156.819511317123, 5458.9454105458835, 5673.383085820563, 5726.713664316768, 5744.684042377709, 3789.1663833956486, 3792.6156952712063, 3796.620337966181, 3799.5820459749407, 3800.6009369015856, 3155.0377134974055, 3587.013571267922, 3614.4939708440315, 3787.507624008861, 3823.3882578787816, 4202.495700515958, 4394.494633117232, 4421.646268298528, 4451.488078870907, 4475.709078909926, 4530.456345238593, 5399.109146990702, 5457.836264912059, 5466.0, 5468.179773033997, 1130.9943450282697, 1219.6522842259353, 1237.10928131745, 1261.5521489871146, 1290.605926007243, 774.2605811450052, 806.9919300806916, 869.6260607938647, 880.5421180985851, 882.3823323673327, 4550.817967281338, 4634.629229661619, 4991.775370108354, 5082.593392528589, 5118.87202819925, 4880.780364883589, 5338.905524367496, 5447.673139611636, 5473.877855039707, 5554.222408862763, 4110.856120035784, 4830.637702172351, 4979.954209616021, 5073.974630126826, 5143.022825663112, 2552.6515605642853, 2557.961630575543, 2693.7710294624785, 2907.113330434238, 2916.416716656677, 4723.905521889543, 5397.35231772182, 5701.344345400249, 5714.342850572154, 5725.742341594639, 5607.299087614048, 5664.915026274609, 5678.659280443187, 5695.7152142392715, 5702.914456283159, 4768.356271903249, 4770.6183505318795, 5073.746312684351, 5474.39781624021, 5673.567491667564, 4776.665633405628, 5329.0, 5333.06671332523, 5492.034301477158, 5653.604247702621, 5617.48327951459, 5628.85927851807, 5639.488409272648, 5641.238432811682, 5643.943560564342, 5170.8965820684125, 5906.279044202125, 5908.615939963888, 5918.319393269829, 5943.524518038633, 3272.836358182129, 3367.0, 3682.3187710273687, 3834.6357096075826, 3869.6008474745836, 5628.296462942132, 5639.661620302795, 5642.60501764889, 5646.435356464485, 5651.463111004448, 5427.674339539641, 5468.425815289337, 5471.425500322568, 5500.944990550043, 5511.0, 4837.612990960644, 4933.9506604933495, 5158.742062896915, 5401.461313182798, 5488.725563721878, 5193.246979188072, 5357.1696387060065, 5368.597355198298, 5368.892622147457, 5391.62258641907, 5432.538234250133, 5543.8891222176135, 5552.833414997556, 5555.055820415187, 5568.749406276808, 4686.765661716969, 5403.324584426947, 5416.539594134542, 5437.673739575638, 5459.344878614592], "value": 3972.103965409179, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.5290802254467, 725.4667819152921, 748.5246868238667, 785.4344871692383, 801.7875263055295, 15131.621709457255, 15380.61548461289, 15383.538493845188, 15420.922895385507, 15439.305231264592, 13403.865961340383, 13748.793768093461, 13780.173189608631, 13809.0, 13819.723605527883, 650.4341223135866, 688.8518968421788, 689.3279052923384, 818.2635627934847, 845.1632883445376, 821.7534739578102, 829.9460535065232, 831.6174559702544, 836.7280633794011, 838.7483754873545, 884.703624285865, 885.5262434597491, 886.5788750343568, 890.4968692688642, 890.7149712092133, 684.4558575932097, 883.7569668341193, 884.0275696733606, 884.9867251991193, 887.3300658003167, 526.194921769693, 640.8814369341686, 659.5251418978328, 667.2526770017563, 667.7028722218614, 14051.297435128203, 14329.498467553585, 14580.635484112876, 14605.70788584233, 14614.415423383052, 13066.673333166747, 13192.86807131926, 13325.13386629866, 13471.326433678374, 13496.0, 12024.33866137362, 12127.514899404014, 12163.939180304042, 12250.0, 12286.525616925937, 4335.414719012924, 4365.2142614329405, 4397.0, 4483.103379324149, 4614.330922016323, 90888.0, 91448.0, 91713.54143229307, 92722.53638731762, 92838.14323713555, 10530.631427899987, 10642.148628109733, 10642.25504214713, 10672.46637668129, 10817.83773243402, 20342.186312547627, 20344.287949921683, 20360.89819550893, 20378.0, 20419.693704594443, 7395.445341599401, 7465.888011679829, 7475.0656167979005, 7510.173880873209, 7649.464537482434, 4160.729552579072, 4164.958350416457, 4183.6234738873645, 4240.215560121387, 4360.41134446852, 3000.549917512347, 3041.6045914031033, 3094.6441159266974, 3108.347247078094, 3111.2066423061974, 627.704978660029, 634.8000379880323, 634.8761991411723, 650.3658932540735, 701.992980070203, 515.5257163409672, 602.3434456442499, 621.4686443091182, 675.8546912413855, 681.8738533371342, 8768.605412756442, 9107.863382049274, 9258.699241000806, 9313.860292095624, 9384.0, 520.2144761410298, 537.5538303208327, 660.4815220052236, 665.3313420012856, 666.6866572710818, 4359.782010899442, 4395.230834603995, 4403.867883963486, 4431.499011754892, 4461.643068554507, 115748.42125789318, 117092.0, 117910.82089179169, 118030.0, 121626.0, 81894.59052704817, 100365.49086272756, 102585.48707256417, 103969.0, 106336.0, 92801.07198927924, 92916.0, 93563.30209336063, 93897.59153612565, 94843.52578237065, 8716.520591367536, 8793.868091978753, 8842.336824738042, 8851.114888511098, 8868.556572171494, 55502.44497555134, 58117.70941145267, 58418.0, 59156.04219788907, 59481.51296217456, 82058.17941820505, 83441.16558834577, 84444.0, 85146.0, 85937.14062859291, 9546.284028698014, 11469.466594027173, 11749.355090287538, 12057.51769929193, 12380.690482738004, 13976.580702578938, 14154.858451415354, 14157.534383296372, 14372.568822935329, 14419.85580144227, 10443.530041148015, 13155.342232888508, 13442.462301508222, 13503.932480337535, 13766.93116534411, 13109.737805244033, 13147.0, 13514.121582097132, 13567.932160339134, 13888.236147012012, 11446.656600302003, 12250.571230006906, 12821.358932053547, 13282.203067815963, 13528.86471135276, 10850.186236032487, 10929.125669946545, 11243.943780281046, 11257.04315133223, 11489.770204596029, 10842.366981601193, 11058.060064894575, 11092.334459932106, 11157.218994670295, 11184.440777960906], "value": 7397.037480745518, "unit": "score"}], "name": "dromaeo_css", "value": 7104.060154476554, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 121.0, 168.0, 149.0, 113.0, 113.0, 113.0, 117.0, 163.0], "value": 127.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 137.0, 185.0, 113.0, 114.0, 117.0, 113.0, 149.0, 142.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 184.0, 186.0, 185.0, 183.0, 181.0, 183.0, 181.0, 183.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 61.0, 59.0, 85.0, 60.0, 62.0, 59.0, 58.0, 81.0, 56.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 66.0, 91.0, 73.0, 67.0, 69.0, 88.0, 67.0, 67.0, 92.0], "value": 76.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 87.0, 84.0, 86.0, 84.0, 88.0, 88.0, 86.0, 82.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 94.0, 96.0, 95.0, 95.0, 97.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 81.0, 83.0, 85.0, 82.0, 84.0, 89.0, 84.0], "value": 83.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 55.0, 56.0, 58.0, 57.0, 55.0, 56.0, 55.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 80.0, 78.0, 77.0, 72.0, 70.0, 70.0, 71.0, 72.0, 72.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 89.0, 87.0, 87.0, 85.0, 90.0, 86.0, 93.0, 91.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 157.0, 155.0, 155.0, 143.0, 146.0, 194.0, 164.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 174.0, 172.0, 170.0, 170.0, 172.0, 170.0, 170.0, 175.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1461.6999999999998, "alertThreshold": 2.0}]} 22:06:38 INFO - Return code: 0 22:06:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:06:38 INFO - # TBPL SUCCESS # 22:06:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:06:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:06:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:06:38 INFO - 2016-10-31 22:06:38.687 screenresolution[1673:11054] starting screenresolution argv=screenresolution get 22:06:38 INFO - 2016-10-31 22:06:38.690 screenresolution[1673:11054] Display 0: 1600x1200x32@60 22:06:38 INFO - 2016-10-31 22:06:38.696 screenresolution[1674:11057] starting screenresolution argv=screenresolution list 22:06:38 INFO - Available Modes on Display 0 22:06:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:06:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:06:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:06:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:06:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:06:38 INFO - Intel Iris: 22:06:38 INFO - Chipset Model: Intel Iris 22:06:38 INFO - Type: GPU 22:06:38 INFO - Bus: Built-In 22:06:38 INFO - VRAM (Dynamic, Max): 1536 MB 22:06:38 INFO - Vendor: Intel (0x8086) 22:06:38 INFO - Device ID: 0x0a2e 22:06:38 INFO - Revision ID: 0x0009 22:06:38 INFO - Displays: 22:06:38 INFO - Display: 22:06:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:06:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:06:38 INFO - Display Serial Number: 1600x1200 60 22:06:38 INFO - Main Display: Yes 22:06:38 INFO - Mirror: Off 22:06:38 INFO - Online: Yes 22:06:38 INFO - Rotation: Supported 22:06:38 INFO - Return code: 0 22:06:38 INFO - Running post-action listener: _resource_record_post_action 22:06:38 INFO - [mozharness: 2016-11-01 05:06:38.932839Z] Finished run-tests step (success) 22:06:38 INFO - Running post-run listener: _resource_record_post_run 22:06:38 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 33037312; Write bytes: 709798912; Read time: 310; Write time: 2338 22:06:38 INFO - TinderboxPrint: CPU usage
53.6% 22:06:38 INFO - TinderboxPrint: I/O read bytes / time
33,037,312 / 310 22:06:38 INFO - TinderboxPrint: I/O write bytes / time
709,798,912 / 2,338 22:06:38 INFO - TinderboxPrint: CPU idle
2,255.8 (46.4%) 22:06:38 INFO - TinderboxPrint: CPU system
973.7 (20.0%) 22:06:38 INFO - TinderboxPrint: CPU user
1,628.2 (33.5%) 22:06:38 INFO - TinderboxPrint: Swap in / out
436,371,456 / 0 22:06:38 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 406321664; Write bytes: 401995776; Read time: 29711; Write time: 808 22:06:39 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 29154304; Write bytes: 297382912; Read time: 281; Write time: 1498 22:06:39 INFO - Running post-run listener: _upload_blobber_files 22:06:39 INFO - Blob upload gear active. 22:06:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:06:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:06:39 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'] 22:06:39 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 22:06:39 INFO - (blobuploader) - INFO - Open directory for files ... 22:06:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:06:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:06:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:40 INFO - (blobuploader) - INFO - Done attempting. 22:06:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:06:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:06:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:41 INFO - (blobuploader) - INFO - Done attempting. 22:06:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:06:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:06:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:44 INFO - (blobuploader) - INFO - Done attempting. 22:06:44 INFO - (blobuploader) - INFO - Iteration through files over. 22:06:44 INFO - Return code: 0 22:06:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:06:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:06:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75c5ee529ecdbfc2a43d9e5664314fed3a30772c7be811c6559cf7d67b3aae4c1cd4c68c94ebdcf87f138441a6aaaa23a73899c22f2ffa8a61da882ae140ab39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a26c0f156a3ff7b980f37a499dfe427d8f8fe7b90362a18ba1928c9a76fbd950a53b38f9a410b9f58b54ca9da0874d4655e6832fc9ac0a42862bbe62becfffd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3c4f363d9e4d5e4275fa4941f553173ece4710648b38962a9852a634cd982c711030357eff3ba26511a7526582c51b7cc7c10e3aec73dadc849ad898cfdffeb"} 22:06:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:06:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:06:44 INFO - Contents: 22:06:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75c5ee529ecdbfc2a43d9e5664314fed3a30772c7be811c6559cf7d67b3aae4c1cd4c68c94ebdcf87f138441a6aaaa23a73899c22f2ffa8a61da882ae140ab39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a26c0f156a3ff7b980f37a499dfe427d8f8fe7b90362a18ba1928c9a76fbd950a53b38f9a410b9f58b54ca9da0874d4655e6832fc9ac0a42862bbe62becfffd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3c4f363d9e4d5e4275fa4941f553173ece4710648b38962a9852a634cd982c711030357eff3ba26511a7526582c51b7cc7c10e3aec73dadc849ad898cfdffeb"} 22:06:44 INFO - Running post-run listener: copy_logs_to_upload_dir 22:06:44 INFO - Copying logs to upload dir... 22:06:44 INFO - mkdir: /builds/slave/test/build/upload/logs 22:06:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.174210 ========= master_lag: 0.38 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-31 22:06:44.477840) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 22:06:44.481977) ========= 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.q5RwsXJB9m/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.qFQZbc4esW/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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/75c5ee529ecdbfc2a43d9e5664314fed3a30772c7be811c6559cf7d67b3aae4c1cd4c68c94ebdcf87f138441a6aaaa23a73899c22f2ffa8a61da882ae140ab39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a26c0f156a3ff7b980f37a499dfe427d8f8fe7b90362a18ba1928c9a76fbd950a53b38f9a410b9f58b54ca9da0874d4655e6832fc9ac0a42862bbe62becfffd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3c4f363d9e4d5e4275fa4941f553173ece4710648b38962a9852a634cd982c711030357eff3ba26511a7526582c51b7cc7c10e3aec73dadc849ad898cfdffeb"} build_url:https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011067 build_url: 'https://queue.taskcluster.net/v1/task/K-SIkf0DRkqjT_Jd4XrxIQ/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/75c5ee529ecdbfc2a43d9e5664314fed3a30772c7be811c6559cf7d67b3aae4c1cd4c68c94ebdcf87f138441a6aaaa23a73899c22f2ffa8a61da882ae140ab39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a26c0f156a3ff7b980f37a499dfe427d8f8fe7b90362a18ba1928c9a76fbd950a53b38f9a410b9f58b54ca9da0874d4655e6832fc9ac0a42862bbe62becfffd3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3c4f363d9e4d5e4275fa4941f553173ece4710648b38962a9852a634cd982c711030357eff3ba26511a7526582c51b7cc7c10e3aec73dadc849ad898cfdffeb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 22:06:44.519292) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 22:06:44.519577) ========= 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.q5RwsXJB9m/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.qFQZbc4esW/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.004962 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 22:06:44.571008) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 22:06:44.571293) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 22:06:44.571569) ========= ========= Total master_lag: 0.54 =========