builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0357 starttime: 1482370791.02 results: success (0) buildid: 20161221163353 builduid: 4d3b2a55d14d4588a3de3057ff795fe5 revision: f179934df0c1bab590c558485d419c7910e41325 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 17:39:51.016636) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 17:39:51.017559) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 17:39:51.017900) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 17:39:51.044903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 17:39:51.045225) ========= 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.vVrUzExWMc/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.BCfuo8ppxM/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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-12-21 17:39:51-- 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% 18.1M=0.001s 2016-12-21 17:39:51 (18.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.177726 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 17:39:51.246786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 17:39:51.247126) ========= 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.vVrUzExWMc/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.BCfuo8ppxM/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.025196 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 17:39:51.295942) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 17:39:51.296324) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f179934df0c1bab590c558485d419c7910e41325 --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 f179934df0c1bab590c558485d419c7910e41325 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vVrUzExWMc/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.BCfuo8ppxM/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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-12-21 17:39:51,397 truncating revision to first 12 chars 2016-12-21 17:39:51,397 Setting DEBUG logging. 2016-12-21 17:39:51,397 attempt 1/10 2016-12-21 17:39:51,397 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f179934df0c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 17:39:52,402 unpacking tar archive at: mozilla-central-f179934df0c1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.264009 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 17:39:52.590706) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 17:39:52.591065) ========= script_repo_revision: f179934df0c1bab590c558485d419c7910e41325 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 17:39:52.591496) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 17:39:52.591811) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 17:39:52.649289) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-12-21 17:39:52.649667) ========= /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.vVrUzExWMc/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.BCfuo8ppxM/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 17:39:52 INFO - MultiFileLogger online at 20161221 17:39:52 in /builds/slave/test 17:39:52 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 17:39:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:39:52 INFO - {'append_to_log': False, 17:39:52 INFO - 'base_work_dir': '/builds/slave/test', 17:39:52 INFO - 'blob_upload_branch': 'Firefox', 17:39:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:39:52 INFO - 'branch': 'Firefox', 17:39:52 INFO - 'buildbot_json_path': 'buildprops.json', 17:39:52 INFO - 'config_files': ('talos/mac_config.py',), 17:39:52 INFO - 'default_actions': ('clobber', 17:39:52 INFO - 'read-buildbot-config', 17:39:52 INFO - 'download-and-extract', 17:39:52 INFO - 'populate-webroot', 17:39:52 INFO - 'create-virtualenv', 17:39:52 INFO - 'install', 17:39:52 INFO - 'run-tests'), 17:39:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:39:52 INFO - 'download_minidump_stackwalk': True, 17:39:52 INFO - 'download_symbols': 'ondemand', 17:39:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:39:52 INFO - 'tooltool.py': '/tools/tooltool.py', 17:39:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:39:52 INFO - '/tools/misc-python/virtualenv.py')}, 17:39:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:39:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:39:52 INFO - 'installer_path': 'installer.exe', 17:39:52 INFO - 'log_level': 'info', 17:39:52 INFO - 'log_name': 'talos', 17:39:52 INFO - 'log_to_console': True, 17:39:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:39:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:39:52 INFO - 'opt_config_files': (), 17:39:52 INFO - 'pip_index': False, 17:39:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:39:52 INFO - 'cmd': ('bash', 17:39:52 INFO - '-c', 17:39:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:39:52 INFO - 'enabled': True, 17:39:52 INFO - 'halt_on_failure': False, 17:39:52 INFO - 'name': 'check_screen_resolution'},), 17:39:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:39:52 INFO - 'cmd': ('bash', 17:39:52 INFO - '-c', 17:39:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:39:52 INFO - 'enabled': True, 17:39:52 INFO - 'halt_on_failure': False, 17:39:52 INFO - 'name': 'check_screen_resolution'},), 17:39:52 INFO - 'run_cmd_checks_enabled': True, 17:39:52 INFO - 'sps_profile': False, 17:39:52 INFO - 'sps_profile_interval': 0, 17:39:52 INFO - 'suite': 'dromaeojs', 17:39:52 INFO - 'system_bits': '32', 17:39:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:39:52 INFO - 'title': 't-yosemite-r7-0357', 17:39:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:39:52 INFO - 'use_talos_json': True, 17:39:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:39:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:39:52 INFO - 'work_dir': 'build'} 17:39:52 INFO - [mozharness: 2016-12-22 01:39:52.858994Z] Running clobber step. 17:39:52 INFO - Running pre-action listener: _resource_record_pre_action 17:39:52 INFO - Running main action method: clobber 17:39:52 INFO - rmtree: /builds/slave/test/build 17:39:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:39:55 INFO - Running post-action listener: _resource_record_post_action 17:39:55 INFO - [mozharness: 2016-12-22 01:39:55.184952Z] Finished clobber step (success) 17:39:55 INFO - [mozharness: 2016-12-22 01:39:55.185137Z] Running read-buildbot-config step. 17:39:55 INFO - Running pre-action listener: _resource_record_pre_action 17:39:55 INFO - Running main action method: read_buildbot_config 17:39:55 INFO - Using buildbot properties: 17:39:55 INFO - { 17:39:55 INFO - "project": "", 17:39:55 INFO - "product": "firefox", 17:39:55 INFO - "script_repo_revision": "production", 17:39:55 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:39:55 INFO - "repository": "", 17:39:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:39:55 INFO - "buildid": "20161221163353", 17:39:55 INFO - "pgo_build": "False", 17:39:55 INFO - "basedir": "/builds/slave/test", 17:39:55 INFO - "buildnumber": 11, 17:39:55 INFO - "slavename": "t-yosemite-r7-0357", 17:39:55 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:39:55 INFO - "platform": "yosemite_r7", 17:39:55 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:39:55 INFO - "branch": "mozilla-central", 17:39:55 INFO - "repo_path": "mozilla-central", 17:39:55 INFO - "revision": "f179934df0c1bab590c558485d419c7910e41325", 17:39:55 INFO - "stage_platform": "macosx64", 17:39:55 INFO - "builduid": "4d3b2a55d14d4588a3de3057ff795fe5", 17:39:55 INFO - "slavebuilddir": "test" 17:39:55 INFO - } 17:39:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 17:39:55 INFO - Running post-action listener: _resource_record_post_action 17:39:55 INFO - [mozharness: 2016-12-22 01:39:55.188506Z] Finished read-buildbot-config step (success) 17:39:55 INFO - [mozharness: 2016-12-22 01:39:55.188620Z] Running download-and-extract step. 17:39:55 INFO - Running pre-action listener: _resource_record_pre_action 17:39:55 INFO - Running main action method: download_and_extract 17:39:55 INFO - mkdir: /builds/slave/test/build/tests 17:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:55 INFO - trying https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 17:39:55 INFO - Downloading https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 17:39:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 17:39:56 INFO - Downloaded 1199 bytes. 17:39:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 17:39:56 INFO - Using the following test package requirements: 17:39:56 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 17:39:56 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:39:56 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 17:39:56 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:39:56 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 17:39:56 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:39:56 INFO - u'jsshell-mac.zip'], 17:39:56 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:39:56 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 17:39:56 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 17:39:56 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:39:56 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 17:39:56 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:39:56 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 17:39:56 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:39:56 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 17:39:56 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:39:56 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 17:39:56 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:39:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 17:39:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:39:56 INFO - Fetch https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 17:39:57 INFO - Expected file size: 16289259 17:39:57 INFO - Obtained file size: 16289259 17:40:04 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:40:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 17:40:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:40:04 INFO - Fetch https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 17:40:05 INFO - Expected file size: 16289259 17:40:05 INFO - Obtained file size: 16289259 17:40:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 17:40:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:40:11 INFO - Fetch https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 17:40:12 INFO - Expected file size: 14409734 17:40:12 INFO - Obtained file size: 14409734 17:40: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')]} 17:40:13 INFO - trying https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 17:40:13 INFO - Downloading https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 17:40:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 17:40:16 INFO - Downloaded 69666031 bytes. 17:40:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 17:40:16 INFO - mkdir: /builds/slave/test/properties 17:40:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:40:16 INFO - Writing to file /builds/slave/test/properties/build_url 17:40:16 INFO - Contents: 17:40:16 INFO - build_url:https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 17:40:16 INFO - Running post-action listener: _resource_record_post_action 17:40:16 INFO - Running post-action listener: set_extra_try_arguments 17:40:16 INFO - [mozharness: 2016-12-22 01:40:16.834703Z] Finished download-and-extract step (success) 17:40:16 INFO - [mozharness: 2016-12-22 01:40:16.834855Z] Running populate-webroot step. 17:40:16 INFO - Running pre-action listener: _resource_record_pre_action 17:40:16 INFO - Running main action method: populate_webroot 17:40:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:40:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:40:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:40:16 INFO - '--tppagecycles', 17:40:16 INFO - '7'], 17:40:16 INFO - 'tests': ['tsvgm']}}, 17:40:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:40:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:40:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:40:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:40:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:40:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:40:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:40:16 INFO - 'talos_options': ['--disable-e10s'], 17:40:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:40:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:40:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:40:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:40:16 INFO - 'talos_options': ['--disable-e10s'], 17:40:16 INFO - 'tests': ['damp', 'tps']}, 17:40:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:40:16 INFO - 'tests': ['damp', 'tps']}, 17:40:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:40:16 INFO - 'tests': ['dromaeo_dom']}, 17:40:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:40:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:40:16 INFO - 'tests': ['basic_compositor_video']}, 17:40:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:40:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:40:16 INFO - 'tests': ['a11yr', 17:40:16 INFO - 'ts_paint', 17:40:16 INFO - 'tpaint', 17:40:16 INFO - 'sessionrestore', 17:40:16 INFO - 'sessionrestore_no_auto_restore', 17:40:16 INFO - 'tabpaint']}, 17:40:16 INFO - 'other-e10s': {'tests': ['a11yr', 17:40:16 INFO - 'ts_paint', 17:40:16 INFO - 'tpaint', 17:40:16 INFO - 'sessionrestore', 17:40:16 INFO - 'sessionrestore_no_auto_restore', 17:40:16 INFO - 'tabpaint']}, 17:40:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:40:16 INFO - 'ts_paint', 17:40:16 INFO - 'tpaint', 17:40:16 INFO - 'sessionrestore', 17:40:16 INFO - 'sessionrestore_no_auto_restore', 17:40:16 INFO - 'tabpaint']}, 17:40:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:40:16 INFO - 'ts_paint', 17:40:16 INFO - 'tpaint', 17:40:16 INFO - 'sessionrestore', 17:40:16 INFO - 'sessionrestore_no_auto_restore', 17:40:16 INFO - 'tabpaint']}, 17:40:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:40:16 INFO - 'tests': ['a11yr', 17:40:16 INFO - 'ts_paint', 17:40:16 INFO - 'tpaint', 17:40:16 INFO - 'sessionrestore', 17:40:16 INFO - 'sessionrestore_no_auto_restore', 17:40:16 INFO - 'tabpaint']}, 17:40:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:40:16 INFO - 'tests': ['a11yr', 17:40:16 INFO - 'ts_paint', 17:40:16 INFO - 'tpaint', 17:40:16 INFO - 'sessionrestore', 17:40:16 INFO - 'sessionrestore_no_auto_restore', 17:40:16 INFO - 'tabpaint']}, 17:40:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:40:16 INFO - 'tests': ['tsvgx', 17:40:16 INFO - 'tsvgr_opacity', 17:40:16 INFO - 'tart', 17:40:16 INFO - 'tscrollx', 17:40:16 INFO - 'cart', 17:40:16 INFO - 'tsvg_static']}, 17:40:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:40:16 INFO - 'tsvgr_opacity', 17:40:16 INFO - 'tart', 17:40:16 INFO - 'tscrollx', 17:40:16 INFO - 'cart', 17:40:16 INFO - 'tsvg_static']}, 17:40:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:40:16 INFO - 'talos_options': ['--disable-e10s'], 17:40:16 INFO - 'tests': ['tp5o']}, 17:40:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:40:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:40:16 INFO - 'talos_options': ['--disable-e10s', 17:40:16 INFO - '--xperf_path', 17:40:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:40:16 INFO - 'tests': ['tp5n']}, 17:40:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:40:16 INFO - 'talos_options': ['--xperf_path', 17:40:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:40:16 INFO - 'tests': ['tp5n']}}, 17:40:16 INFO - 'talos.zip': {'path': '', 17:40:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:40:16 INFO - Running post-action listener: _resource_record_post_action 17:40:16 INFO - [mozharness: 2016-12-22 01:40:16.853485Z] Finished populate-webroot step (success) 17:40:16 INFO - [mozharness: 2016-12-22 01:40:16.853585Z] Running create-virtualenv step. 17:40:16 INFO - Running pre-action listener: _resource_record_pre_action 17:40:16 INFO - Running main action method: create_virtualenv 17:40:16 INFO - Creating virtualenv /builds/slave/test/build/venv 17:40:16 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 17:40:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:40:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:40:16 INFO - Using real prefix '/tools/python27' 17:40:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:40:17 INFO - Installing distribute.............................................................................................................................................................................................done. 17:40:20 INFO - Installing pip.................done. 17:40:20 INFO - Return code: 0 17:40:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:40:20 INFO - Reading from file tmpfile_stdout 17:40:20 INFO - Output received: 17:40:20 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) 17:40:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:40:20 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')]} 17:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:20 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')]} 17:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:20 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 0x10ace9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9681c9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac7d30>, '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 0x10a9eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aabcbe8>, '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.vVrUzExWMc/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.BCfuo8ppxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 17:40:20 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 17:40:20 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 17:40:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVrUzExWMc/Render', 17:40:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:20 INFO - 'HOME': '/Users/cltbld', 17:40:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:20 INFO - 'LOGNAME': 'cltbld', 17:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:20 INFO - 'MOZ_NO_REMOTE': '1', 17:40:20 INFO - 'NO_EM_RESTART': '1', 17:40:20 INFO - 'PAGER': '/bin/cat', 17:40:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:20 INFO - 'PWD': '/builds/slave/test', 17:40:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:20 INFO - 'SHELL': '/bin/bash', 17:40:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BCfuo8ppxM/Listeners', 17:40:20 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 17:40:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:20 INFO - 'USER': 'cltbld', 17:40:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:20 INFO - 'XPC_FLAGS': '0x0', 17:40:20 INFO - 'XPC_SERVICE_NAME': '0', 17:40:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:21 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 17:40:21 INFO - Cleaning up... 17:40:21 INFO - Return code: 0 17:40:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:40:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:21 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 0x10ace9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9681c9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac7d30>, '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 0x10a9eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aabcbe8>, '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.vVrUzExWMc/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.BCfuo8ppxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 17:40:21 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 17:40:21 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 17:40:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVrUzExWMc/Render', 17:40:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:21 INFO - 'HOME': '/Users/cltbld', 17:40:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:21 INFO - 'LOGNAME': 'cltbld', 17:40:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:21 INFO - 'MOZ_NO_REMOTE': '1', 17:40:21 INFO - 'NO_EM_RESTART': '1', 17:40:21 INFO - 'PAGER': '/bin/cat', 17:40:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:21 INFO - 'PWD': '/builds/slave/test', 17:40:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:21 INFO - 'SHELL': '/bin/bash', 17:40:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BCfuo8ppxM/Listeners', 17:40:21 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 17:40:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:21 INFO - 'USER': 'cltbld', 17:40:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:21 INFO - 'XPC_FLAGS': '0x0', 17:40:21 INFO - 'XPC_SERVICE_NAME': '0', 17:40:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:21 INFO - Downloading/unpacking psutil>=3.1.1 17:40:21 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 17:40:21 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 17:40:21 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 17:40:21 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 17:40:21 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 17:40:21 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 17:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:40:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:40:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:40:25 INFO - Installing collected packages: psutil 17:40:25 INFO - Running setup.py install for psutil 17:40:25 INFO - building 'psutil._psutil_osx' extension 17:40:25 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 17:40:25 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 17:40:26 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 17:40:26 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 17:40:26 INFO - building 'psutil._psutil_posix' extension 17:40:26 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 17:40:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:40:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:40:26 INFO - ^ 17:40:26 INFO - 1 warning generated. 17:40:26 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 17:40:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:40:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:40:26 INFO - Successfully installed psutil 17:40:26 INFO - Cleaning up... 17:40:26 INFO - Return code: 0 17:40:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ace9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9681c9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac7d30>, '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 0x10a9eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aabcbe8>, '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.vVrUzExWMc/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.BCfuo8ppxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 17:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:40:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVrUzExWMc/Render', 17:40:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:26 INFO - 'HOME': '/Users/cltbld', 17:40:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:26 INFO - 'LOGNAME': 'cltbld', 17:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:26 INFO - 'MOZ_NO_REMOTE': '1', 17:40:26 INFO - 'NO_EM_RESTART': '1', 17:40:26 INFO - 'PAGER': '/bin/cat', 17:40:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:26 INFO - 'PWD': '/builds/slave/test', 17:40:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:26 INFO - 'SHELL': '/bin/bash', 17:40:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BCfuo8ppxM/Listeners', 17:40:26 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 17:40:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:26 INFO - 'USER': 'cltbld', 17:40:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:26 INFO - 'XPC_FLAGS': '0x0', 17:40:26 INFO - 'XPC_SERVICE_NAME': '0', 17:40:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:40:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:40:29 INFO - Installing collected packages: mozsystemmonitor 17:40:29 INFO - Running setup.py install for mozsystemmonitor 17:40:29 INFO - Successfully installed mozsystemmonitor 17:40:29 INFO - Cleaning up... 17:40:29 INFO - Return code: 0 17:40:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ace9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9681c9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac7d30>, '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 0x10a9eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aabcbe8>, '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.vVrUzExWMc/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.BCfuo8ppxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 17:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:40:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVrUzExWMc/Render', 17:40:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:29 INFO - 'HOME': '/Users/cltbld', 17:40:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:29 INFO - 'LOGNAME': 'cltbld', 17:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:29 INFO - 'MOZ_NO_REMOTE': '1', 17:40:29 INFO - 'NO_EM_RESTART': '1', 17:40:29 INFO - 'PAGER': '/bin/cat', 17:40:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:29 INFO - 'PWD': '/builds/slave/test', 17:40:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:29 INFO - 'SHELL': '/bin/bash', 17:40:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BCfuo8ppxM/Listeners', 17:40:29 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 17:40:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:29 INFO - 'USER': 'cltbld', 17:40:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:29 INFO - 'XPC_FLAGS': '0x0', 17:40:29 INFO - 'XPC_SERVICE_NAME': '0', 17:40:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:29 INFO - Downloading/unpacking jsonschema==2.5.1 17:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:40:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:40:32 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 17:40:32 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 17:40:32 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 17:40:32 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 17:40:32 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 17:40:32 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 17:40:32 INFO - Downloading functools32-3.2.3-2.tar.gz 17:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:40:33 INFO - warning: no files found matching '*.txt' 17:40:33 INFO - no previously-included directories found matching 'build' 17:40:33 INFO - no previously-included directories found matching 'dist' 17:40:33 INFO - no previously-included directories found matching '.git*' 17:40:33 INFO - Installing collected packages: jsonschema, functools32 17:40:33 INFO - Running setup.py install for functools32 17:40:33 INFO - warning: no files found matching '*.txt' 17:40:33 INFO - no previously-included directories found matching 'build' 17:40:33 INFO - no previously-included directories found matching 'dist' 17:40:33 INFO - no previously-included directories found matching '.git*' 17:40:33 INFO - Successfully installed jsonschema functools32 17:40:33 INFO - Cleaning up... 17:40:33 INFO - Return code: 0 17:40:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:40:33 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')]} 17:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:33 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')]} 17:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:33 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 0x10ace9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9681c9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac7d30>, '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 0x10a9eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aabcbe8>, '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.vVrUzExWMc/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.BCfuo8ppxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 17:40:33 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 17:40:33 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 17:40:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVrUzExWMc/Render', 17:40:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:33 INFO - 'HOME': '/Users/cltbld', 17:40:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:33 INFO - 'LOGNAME': 'cltbld', 17:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:33 INFO - 'MOZ_NO_REMOTE': '1', 17:40:33 INFO - 'NO_EM_RESTART': '1', 17:40:33 INFO - 'PAGER': '/bin/cat', 17:40:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:33 INFO - 'PWD': '/builds/slave/test', 17:40:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:33 INFO - 'SHELL': '/bin/bash', 17:40:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BCfuo8ppxM/Listeners', 17:40:33 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 17:40:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:33 INFO - 'USER': 'cltbld', 17:40:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:33 INFO - 'XPC_FLAGS': '0x0', 17:40:33 INFO - 'XPC_SERVICE_NAME': '0', 17:40:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:40:33 INFO - Cleaning up... 17:40:33 INFO - Return code: 0 17:40:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:40:33 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')]} 17:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:33 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')]} 17:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:33 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 0x10ace9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9681c9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac7d30>, '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 0x10a9eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aabcbe8>, '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.vVrUzExWMc/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.BCfuo8ppxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 17:40:33 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 17:40:33 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 17:40:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVrUzExWMc/Render', 17:40:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:33 INFO - 'HOME': '/Users/cltbld', 17:40:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:33 INFO - 'LOGNAME': 'cltbld', 17:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:33 INFO - 'MOZ_NO_REMOTE': '1', 17:40:33 INFO - 'NO_EM_RESTART': '1', 17:40:33 INFO - 'PAGER': '/bin/cat', 17:40:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:33 INFO - 'PWD': '/builds/slave/test', 17:40:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:33 INFO - 'SHELL': '/bin/bash', 17:40:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BCfuo8ppxM/Listeners', 17:40:33 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 17:40:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:33 INFO - 'USER': 'cltbld', 17:40:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:33 INFO - 'XPC_FLAGS': '0x0', 17:40:33 INFO - 'XPC_SERVICE_NAME': '0', 17:40:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:33 INFO - Downloading/unpacking blobuploader==1.2.4 17:40:33 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 17:40:33 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 17:40:33 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 17:40:33 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 17:40:33 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 17:40:33 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 17:40:36 INFO - Downloading blobuploader-1.2.4.tar.gz 17:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:40:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:40:36 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 17:40:36 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 17:40:36 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 17:40:36 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 17:40:36 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 17:40:36 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 17:40:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:40:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:37 INFO - Downloading docopt-0.6.1.tar.gz 17:40:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:40:37 INFO - Installing collected packages: blobuploader, requests, docopt 17:40:37 INFO - Running setup.py install for blobuploader 17:40:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:40:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:40:38 INFO - Running setup.py install for requests 17:40:38 INFO - Running setup.py install for docopt 17:40:38 INFO - Successfully installed blobuploader requests docopt 17:40:38 INFO - Cleaning up... 17:40:38 INFO - Return code: 0 17:40:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:38 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 0x10ace9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9681c9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac7d30>, '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 0x10a9eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aabcbe8>, '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.vVrUzExWMc/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.BCfuo8ppxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 17:40:38 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 17:40:38 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 17:40:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVrUzExWMc/Render', 17:40:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:38 INFO - 'HOME': '/Users/cltbld', 17:40:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:38 INFO - 'LOGNAME': 'cltbld', 17:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:38 INFO - 'MOZ_NO_REMOTE': '1', 17:40:38 INFO - 'NO_EM_RESTART': '1', 17:40:38 INFO - 'PAGER': '/bin/cat', 17:40:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:38 INFO - 'PWD': '/builds/slave/test', 17:40:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:38 INFO - 'SHELL': '/bin/bash', 17:40:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BCfuo8ppxM/Listeners', 17:40:38 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 17:40:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:38 INFO - 'USER': 'cltbld', 17:40:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:38 INFO - 'XPC_FLAGS': '0x0', 17:40:38 INFO - 'XPC_SERVICE_NAME': '0', 17:40:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:40:39 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-zcd2Md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:40:39 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-TEuPay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:40:39 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-jvze1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:40:39 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-CkJPVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:40:39 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-s8r7th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:40:39 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-OstPTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:40:39 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-ckeE7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:40:39 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-2y9JvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:40:39 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-vqu_Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:40:39 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-KqATJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:40:40 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-QERmtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:40:40 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-kSdxqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:40:40 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-OwjJo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:40:40 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-uIgnOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:40:40 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-CjUlbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:40:40 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-oskRNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:40:40 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-SlEFjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:40:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:40:40 INFO - Running setup.py install for manifestparser 17:40:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:40:40 INFO - Running setup.py install for mozcrash 17:40:41 INFO - Running setup.py install for mozdebug 17:40:41 INFO - Running setup.py install for mozdevice 17:40:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:40:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:40:41 INFO - Running setup.py install for mozfile 17:40:41 INFO - Running setup.py install for mozhttpd 17:40:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:40:41 INFO - Running setup.py install for mozinfo 17:40:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:40:41 INFO - Running setup.py install for mozInstall 17:40:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:40:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:40:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:40:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:40:42 INFO - Running setup.py install for mozleak 17:40:42 INFO - Running setup.py install for mozlog 17:40:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:40:42 INFO - Running setup.py install for moznetwork 17:40:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:40:42 INFO - Running setup.py install for mozprocess 17:40:42 INFO - Running setup.py install for mozprofile 17:40:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:40:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:40:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:40:42 INFO - Running setup.py install for mozrunner 17:40:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:40:42 INFO - Running setup.py install for mozscreenshot 17:40:43 INFO - Running setup.py install for moztest 17:40:43 INFO - Running setup.py install for mozversion 17:40:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:40:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:40:43 INFO - Cleaning up... 17:40:43 INFO - Return code: 0 17:40:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:43 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 0x10ace9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9681c9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac7d30>, '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 0x10a9eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aabcbe8>, '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.vVrUzExWMc/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.BCfuo8ppxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 17:40:43 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 17:40:43 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 17:40:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVrUzExWMc/Render', 17:40:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:43 INFO - 'HOME': '/Users/cltbld', 17:40:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:43 INFO - 'LOGNAME': 'cltbld', 17:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:43 INFO - 'MOZ_NO_REMOTE': '1', 17:40:43 INFO - 'NO_EM_RESTART': '1', 17:40:43 INFO - 'PAGER': '/bin/cat', 17:40:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:43 INFO - 'PWD': '/builds/slave/test', 17:40:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:43 INFO - 'SHELL': '/bin/bash', 17:40:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BCfuo8ppxM/Listeners', 17:40:43 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 17:40:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:43 INFO - 'USER': 'cltbld', 17:40:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:43 INFO - 'XPC_FLAGS': '0x0', 17:40:43 INFO - 'XPC_SERVICE_NAME': '0', 17:40:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:40:43 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-jp8dLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:40:43 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)) 17:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:40:43 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-MykD8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:40:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:40:43 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-jA_b6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:40:44 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)) 17:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:40:44 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-K7KWUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:40:44 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-JWIpGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:40:44 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)) 17:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:40:44 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-HBMap6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:40:44 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)) 17:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:40:44 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-rOhEJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:40:44 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)) 17:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:40:44 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-LsM7TR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:40:44 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)) 17:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:40:44 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-J5qKc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:40:44 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)) 17:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:40:44 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-0zg723-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:40:44 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)) 17:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:40:44 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-khdDmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:40:44 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)) 17:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:40:44 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-rsXa7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:40:45 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)) 17:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:40:45 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-3e6bvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:40:45 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)) 17:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:40:45 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Vfj5Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:40:45 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-wS98ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:40:45 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)) 17:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:40:45 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-yM3WxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:40:45 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)) 17:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:40:45 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-IhElU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:40:45 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)) 17:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:40:45 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)) 17:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:40:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:40:48 INFO - Downloading blessings-1.6.tar.gz 17:40:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:40:48 INFO - Installing collected packages: blessings 17:40:48 INFO - Running setup.py install for blessings 17:40:48 INFO - Successfully installed blessings 17:40:48 INFO - Cleaning up... 17:40:48 INFO - Return code: 0 17:40:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:40:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:40:48 INFO - Reading from file tmpfile_stdout 17:40:48 INFO - Current package versions: 17:40:48 INFO - blessings == 1.6 17:40:48 INFO - blobuploader == 1.2.4 17:40:48 INFO - docopt == 0.6.1 17:40:48 INFO - functools32 == 3.2.3-2 17:40:48 INFO - jsonschema == 2.5.1 17:40:48 INFO - manifestparser == 1.1 17:40:48 INFO - mozInstall == 1.12 17:40:48 INFO - mozcrash == 1.0 17:40:48 INFO - mozdebug == 0.1 17:40:48 INFO - mozdevice == 0.49 17:40:48 INFO - mozfile == 1.2 17:40:48 INFO - mozhttpd == 0.7 17:40:48 INFO - mozinfo == 0.9 17:40:48 INFO - mozleak == 0.1 17:40:48 INFO - mozlog == 3.4 17:40:48 INFO - moznetwork == 0.27 17:40:48 INFO - mozprocess == 0.23 17:40:48 INFO - mozprofile == 0.28 17:40:48 INFO - mozrunner == 6.13 17:40:48 INFO - mozscreenshot == 0.1 17:40:48 INFO - mozsystemmonitor == 0.3 17:40:48 INFO - moztest == 0.7 17:40:48 INFO - mozversion == 1.4 17:40:48 INFO - psutil == 3.1.1 17:40:48 INFO - requests == 1.2.3 17:40:48 INFO - wsgiref == 0.1.2 17:40:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:48 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 0x10ace9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9681c9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac7d30>, '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 0x10a9eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aabcbe8>, '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.vVrUzExWMc/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.BCfuo8ppxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 17:40:48 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 17:40:48 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 17:40:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVrUzExWMc/Render', 17:40:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:48 INFO - 'HOME': '/Users/cltbld', 17:40:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:48 INFO - 'LOGNAME': 'cltbld', 17:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:48 INFO - 'MOZ_NO_REMOTE': '1', 17:40:48 INFO - 'NO_EM_RESTART': '1', 17:40:48 INFO - 'PAGER': '/bin/cat', 17:40:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:48 INFO - 'PWD': '/builds/slave/test', 17:40:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:48 INFO - 'SHELL': '/bin/bash', 17:40:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BCfuo8ppxM/Listeners', 17:40:48 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 17:40:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:48 INFO - 'USER': 'cltbld', 17:40:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:48 INFO - 'XPC_FLAGS': '0x0', 17:40:48 INFO - 'XPC_SERVICE_NAME': '0', 17:40:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:49 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)) 17:40:49 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)) 17:40:49 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)) 17:40:49 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)) 17:40:49 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)) 17:40:49 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)) 17:40:49 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)) 17:40:49 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)) 17:40:49 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)) 17:40:49 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)) 17:40:49 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)) 17:40:49 INFO - Cleaning up... 17:40:49 INFO - Return code: 0 17:40:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:40:49 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 0x10ace9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9681c9c8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac7d30>, '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 0x10a9eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aabcbe8>, '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.vVrUzExWMc/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.BCfuo8ppxM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 17:40:49 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 17:40:49 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 17:40:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVrUzExWMc/Render', 17:40:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:49 INFO - 'HOME': '/Users/cltbld', 17:40:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:49 INFO - 'LOGNAME': 'cltbld', 17:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:49 INFO - 'MOZ_NO_REMOTE': '1', 17:40:49 INFO - 'NO_EM_RESTART': '1', 17:40:49 INFO - 'PAGER': '/bin/cat', 17:40:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:49 INFO - 'PWD': '/builds/slave/test', 17:40:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:49 INFO - 'SHELL': '/bin/bash', 17:40:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BCfuo8ppxM/Listeners', 17:40:49 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 17:40:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:49 INFO - 'USER': 'cltbld', 17:40:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:49 INFO - 'XPC_FLAGS': '0x0', 17:40:49 INFO - 'XPC_SERVICE_NAME': '0', 17:40:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:40:49 INFO - Cleaning up... 17:40:49 INFO - Return code: 0 17:40:49 INFO - Running post-action listener: _resource_record_post_action 17:40:49 INFO - Running post-action listener: _start_resource_monitoring 17:40:49 INFO - Starting resource monitoring. 17:40:49 INFO - [mozharness: 2016-12-22 01:40:49.440981Z] Finished create-virtualenv step (success) 17:40:49 INFO - [mozharness: 2016-12-22 01:40:49.442057Z] Running install step. 17:40:49 INFO - Running pre-action listener: _resource_record_pre_action 17:40:49 INFO - Running main action method: install 17:40:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:40:49 INFO - Reading from file tmpfile_stdout 17:40:49 INFO - Detecting whether we're running mozinstall >=1.0... 17:40:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:40:49 INFO - Reading from file tmpfile_stdout 17:40:49 INFO - Output received: 17:40:49 INFO - Usage: mozinstall [options] installer 17:40:49 INFO - Options: 17:40:49 INFO - -h, --help show this help message and exit 17:40:49 INFO - -d DEST, --destination=DEST 17:40:49 INFO - Directory to install application into. [default: 17:40:49 INFO - "/builds/slave/test"] 17:40:49 INFO - --app=APP Application being installed. [default: firefox] 17:40:49 INFO - mkdir: /builds/slave/test/build/application 17:40:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:41:11 INFO - Reading from file tmpfile_stdout 17:41:11 INFO - Output received: 17:41:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:41:11 INFO - Running post-action listener: _resource_record_post_action 17:41:11 INFO - [mozharness: 2016-12-22 01:41:11.986631Z] Finished install step (success) 17:41:11 INFO - [mozharness: 2016-12-22 01:41:11.986796Z] Running run-tests step. 17:41:11 INFO - Running pre-action listener: _resource_record_pre_action 17:41:11 INFO - Running main action method: run_tests 17:41:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:41:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:41:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:41:12 INFO - 2016-12-21 17:41:12.001 screenresolution[1648:8583] starting screenresolution argv=screenresolution get 17:41:12 INFO - 2016-12-21 17:41:12.004 screenresolution[1648:8583] Display 0: 1600x1200x32@60 17:41:12 INFO - 2016-12-21 17:41:12.010 screenresolution[1649:8585] starting screenresolution argv=screenresolution list 17:41:12 INFO - Available Modes on Display 0 17:41:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:41:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:41:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:41:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:41:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:41:12 INFO - Intel Iris: 17:41:12 INFO - Chipset Model: Intel Iris 17:41:12 INFO - Type: GPU 17:41:12 INFO - Bus: Built-In 17:41:12 INFO - VRAM (Dynamic, Max): 1536 MB 17:41:12 INFO - Vendor: Intel (0x8086) 17:41:12 INFO - Device ID: 0x0a2e 17:41:12 INFO - Revision ID: 0x0009 17:41:12 INFO - Displays: 17:41:12 INFO - Display: 17:41:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:41:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:41:12 INFO - Display Serial Number: 1600x1200 60 17:41:12 INFO - Main Display: Yes 17:41:12 INFO - Mirror: Off 17:41:12 INFO - Online: Yes 17:41:12 INFO - Rotation: Supported 17:41:12 INFO - Return code: 0 17:41:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:41:12 INFO - Python 2.7.3 17:41:12 INFO - Return code: 0 17:41:12 INFO - grabbing minidump binary from tooltool 17:41:12 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')]} 17:41:12 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 0x10aac7d30>, '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 0x10a9eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aabcbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:41:12 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 17:41:12 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 17:41:12 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 17:41:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:41:12 INFO - Return code: 0 17:41:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:41:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:41:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:41:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:41:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:41:12 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/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--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 17:41:12 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/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0357 --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 17:41:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVrUzExWMc/Render', 17:41:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:41:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:41:12 INFO - 'HOME': '/Users/cltbld', 17:41:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:41:12 INFO - 'LOGNAME': 'cltbld', 17:41:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:41:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:12 INFO - 'MOZ_NO_REMOTE': '1', 17:41:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:41:12 INFO - 'NO_EM_RESTART': '1', 17:41:12 INFO - 'PAGER': '/bin/cat', 17:41:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:12 INFO - 'PWD': '/builds/slave/test', 17:41:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:41:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:41:12 INFO - 'SHELL': '/bin/bash', 17:41:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BCfuo8ppxM/Listeners', 17:41:12 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 17:41:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:41:12 INFO - 'USER': 'cltbld', 17:41:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:41:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:12 INFO - 'XPC_FLAGS': '0x0', 17:41:12 INFO - 'XPC_SERVICE_NAME': '0', 17:41:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:41:12 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/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--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 17:41:12 INFO - mozversion application_buildid: 20161221163353 17:41:12 INFO - mozversion application_changeset: f179934df0c1bab590c558485d419c7910e41325 17:41:12 INFO - mozversion application_display_name: Nightly 17:41:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:41:12 INFO - mozversion application_name: Firefox 17:41:12 INFO - mozversion application_remotingname: firefox 17:41:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:41:12 INFO - mozversion application_vendor: Mozilla 17:41:12 INFO - mozversion application_version: 53.0a1 17:41:12 INFO - mozversion platform_buildid: 20161221163353 17:41:12 INFO - mozversion platform_changeset: f179934df0c1bab590c558485d419c7910e41325 17:41:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:41:12 INFO - mozversion platform_version: 53.0a1 17:41:12 INFO - using testdate: 1482370872 17:41:12 INFO - actual date: 1482370872 17:41:12 INFO - starting webserver on 'localhost:49236' 17:41:12 INFO - SUITE-START | Running 2 tests 17:41:12 INFO - TEST-START | dromaeo_css 17:41:12 INFO - operating with platform_type : mac_ 17:41:12 INFO - Initialising browser for dromaeo_css test... 17:41:12 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpFrhs5v/profile http://localhost:49236/getInfo.html) 17:41:14 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 17:41:14 INFO - PROCESS | 1659 | colorDepth:24 17:41:14 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 17:41:14 INFO - PROCESS | 1659 | __metrics 17:41:15 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:41:15 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] 17:41:15 INFO - TEST-INFO | 1659: exit 0 17:41:15 INFO - Browser initialized. 17:41:15 INFO - Running cycle 1/1 for dromaeo_css test... 17:41:15 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpFrhs5v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:41:27 INFO - PROCESS | 1662 | RSS: Main: 237539328 17:41:27 INFO - PROCESS | 1662 | 17:42:19 INFO - PROCESS | 1662 | 1482370939300 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] 17:44:30 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 17:44:33 INFO - PROCESS | 1662 | RSS: Main: 441286656 17:44:33 INFO - PROCESS | 1662 | 17:47:36 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 17:47:37 INFO - PROCESS | 1662 | RSS: Main: 370814976 17:47:37 INFO - PROCESS | 1662 | 17:50:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 17:50:40 INFO - PROCESS | 1662 | RSS: Main: 351338496 17:50:40 INFO - PROCESS | 1662 | 17:53:42 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 17:53:43 INFO - PROCESS | 1662 | RSS: Main: 343183360 17:53:43 INFO - PROCESS | 1662 | 17:56:46 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 17:56:47 INFO - PROCESS | 1662 | RSS: Main: 340447232 17:56:47 INFO - PROCESS | 1662 | 17:59:50 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 17:59:51 INFO - PROCESS | 1662 | RSS: Main: 456245248 17:59:51 INFO - PROCESS | 1662 | 17:59:51 INFO - PROCESS | 1662 | __start_tp_report 17:59:51 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 17:59:51 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 17:59:51 INFO - PROCESS | 1662 | |i|pagename|runs| 17:59:51 INFO - PROCESS | 1662 | |0;dojo.html;2722.823016503927;3285.934281314374;3289.3421315736846;3315.1712071982006;3338.966610333896;5394.541463975557;5492.588055895814;5526.309211348582;5562.610617256793;5595.18869763884;5493.23094766733;5501.559875209983;5550.611457197998;5558.277423934883;5598.748056337475;4626.421697287839;5020.924686129711;5038.59691224703;5078.923816142761;5093.236014597803;4459.4202753641985;5092.057969275677;5188.740562971855;5198.92201616976;5234.267202591621;5043.747812609392;5053.671511351788;5095.566876815476;5130.07658621448;5154.974225128851;5106.923396149061;5117.155669314596;5122.667026643294;5124.333836601218;5127.2052831811125;5010.7494625268955;5076.13705670037;5078.415982162025;5081.237814327844;5107.565856902168;5477.534409575191;5525.4474552544825;5525.502704756591;5538.778448862041;5548.167774833767;6026.306974697922;6068.605540639845;6078.908816367758;6106.114613381035;6116.052011938113;5140.768665410065;6170.19787427636;6175.135481032659;6196.318404975449;6215.968920155416;4760.833370832004;5507.862303442366;5509.256250406224;5623.26897503326;5665.433456654343;6125.2460813874895;6139.750513311054;6175.536834737412;6191.164192834;6260.060990851409;5911.201987731687;5920.615160014585;5922;5931.940680593225;5942.64344139353;5935.376785437467;6072.574919755663;6086.817395478142;6100.450959413674;6101.450869421773;5922.3485416604135;5954.136650185699;5955.642661440327;5958.761649534057;5967.1347654589845;5064;5938.703064846741;6010.3689112643415;6022.909656355158;6031.909521357183;4721.716696998123;4764.166270902579;4769.856904292877;4773.618110551148;4804.42346918372;3641.32635462435;4267.97866010668;4277.144571085795;4281.7002809803635;4302.763348015889;5483.862903427446;5535.723213839292;5613.747381367848;5614.9612321720615;5629.2681951346885;6105.664188469588;6107.450329470369;6128.686460748404;6129.632222066691;6198.411150940653;5607.383187849333;5665.5467562594895;5677.290338707661;5677.80127695537;5691.117876729114;5297.17893726473;5307.575393968474;5310.946890531122;5316.494932981361;5334.7065911374475;6114.449440885012;6142.652254521207;6169.290531588746;6169.691515424301;6216.098665693539;5994.250718660168;6063.242094738158;6083.7870674526175;6098.664573448503;6114.2357205349335;6182;6188.876222475616;6212.534059945432;6230.6884655766125;6248.281447633581;5850.64896106235;5862.149988251595;5907.202527658711;5963.493103086286;5991.131285963598;6021.909671355021;6152.661603611844;6171.876562468815;6177.660228687465;6188.9788184948975;5929.140274660236;5931.021381472009;5951.345352011189;5953.732082056405;5960.850978725566;5759.71201439918;5807.070868660994;5900;5928.67392293428;5961.910571341346;5740.966626007192;5752.712364381848;5757.222774925332;5761.991651460894;5768.653880767168;5855.180274761452;5880.705964701833;5882.294124704892;5894.322152952293;5899.085641725539;5735.426457354231;5741.62679425836;5751.654900705971;5752.741126649395;5761.078227483583 17:59:51 INFO - PROCESS | 1662 | |1;ext.html;405.8737004811648;492.19771772011615;493.6889759451545;497.28639402457463;497.5845169283648;37855;39673.80163099184;39969.800150999276;41807.37288940668;41829.37255941163;40751;41150.971225719375;41255.58744412555;41281.38077928834;41457.96355091124;8382.371322150833;8608.52653104079;9383.953080234607;9595.424274543515;9613.711588652352;11123.777524449506;11415.600453984112;11437.256578322382;11594.246373985665;11611;11310.491027903723;11391.430428478543;11396.347529608202;11403.885961140408;11438.942805285962;11272.929071738212;11287.717807054807;11352.829707554394;11360.147988900824;11379.032782213522;11099.278546894426;11154.498047587878;11166.330020198815;11170.553177872875;11187.552497900155;38847.61152388468;39151.41272880909;39182.62860799887;39327.21345573072;39362.80318598417;3355.8489867956;3463.8960831175104;3498.7900725956524;3549.378858699743;3579.803110828929;30013.699863001308;30456.84771576128;30587.2353191172;30689.09495363548;30827.845860770554;3143.931063438419;3157.3211759471824;3238.5304130901122;3298.7855789373616;3299.554560134375;322545.38727306447;351184;358278;359681;360434;55197.17204241859;55388.72305638446;55390.72304638451;55420.72289638526;59881.70059149677;62670;62792.686036569525;62830;62906.0564091539;62964.685176573825;13778.448862045607;15692.76460853088;15936.601584960468;15940.362385504683;15956.521304360887;10972.177086718528;11230.831537526943;11260;11440.828387574193;12163.2702037878;16996.660066798595;17091.059991700575;17103.743443848103;17117.22972466242;17140;7118.145822501229;7483.8503229935095;7512.6243687815395;7534.208908064684;7566.886496702554;846.3144852669358;868.4745728834091;888.5246393179747;920.1994264989502;950.9619615215453;28191;29175.854120729262;29201.707982920325;29477.705222947498;30015.849920750257;987.0573602209872;1032.936075841869;1076.494047797534;1080.135891286983;1201.08117290273;13440.932795336157;14058.507952221828;14330;14353;14488.275586220647;595830;597816;599380;599801.0009950009;600174.9991250016;50377.49622503801;50624.24063639048;50647.493525065016;50753.746231269346;50820;1214.2289646074805;1340.6538557524332;1388.9305534723426;1398.741232871922;1402.845686974432;25815.870920645277;26431.86784066144;26885.462290754465;27055;27116.593251101644;45074.77462612797;45423.77288113538;45440.77279613581;45472.54527454683;45487.999999998676;560633;561874.1906290606;562093;562954;563419;21625;22033.669494957267;23753.64369534493;24276.393090172885;24525.386865327797;38726.6127338723;40487;40768;40768.36926523024;40995.79502102471;34306.48540271948;34343.82828085843;34467;35416.114597135274;35550.46674299836;33784.986450406526;34034.14914627154;34584;34897.82551087228;34962;33257.669693212;33606.831965840014;34060.489092664124;34144.317113658086;34253.65746342605;27507;30631.081067568008;30849.95379065741;30856.074317770504;30979.845100774353;19988.400347989584;22881.77118228863;23622.88188559046;23632.763672363057;24185.911633976866 17:59:51 INFO - PROCESS | 1662 | |2;jquery.html;350.13167344984424;367.28929521376136;368.2395852564454;374.12828110502534;396.19176879166486;14628.414863405464;14708.632284192901;15633.5929766321;19325.323613673525;20546.280880169197;19786;20253.39239822804;20692.172313107494;20952.26667066653;21163.68254476184;5465.824847657753;5721.399253078419;5954.196183515213;5968.731407086691;5976.88046239075;5527.640703354289;5866.76532938682;5922.466977971982;5926.703664816763;5938.079597662348;5678.744456499468;5793.942060579382;5862.443067908542;5876.647401155944;5881.294244690643;5926.822195334125;6063.120847477136;6075.939240607581;6077.42264484871;6077.5137988961;5126.820561280338;5348.866278343034;5405.702686352249;5837.883242335172;5858.179854820286;12844.614661560168;12906.80639790404;13085.738285234242;13096.803547946789;13512.256825874572;1870.5884705364797;2152.773958734326;2158.333952405706;2259.9435014124615;2296.9310920672237;9441.90558094424;9549.665761698378;9613.855792163124;9950.054744799305;10108.786945566579;1756.130715295924;1767.8232176782346;1790.1496789025239;1817.954551136219;1870.2799422222406;109038.45480772546;115814.42092789483;116058;117237;117427.41286293599;11358.318500889807;11452.141089418326;11529.942350288362;11617.991792831459;11754;14406.495772647908;14424.134551926918;14430.567082987527;14447.78328325076;14449.133052016912;8224.588770561448;8368.24685778283;8393.202645748644;8410.369222308229;8498.830023399498;8255.876161857577;8282.213189746964;8401.831963360699;8453.873191902127;8457.238848503664;3799.9430008549894;4420.403245561873;4541.568550987651;4554.590086892195;4563.703359281636;1878.474027272366;1899.2497963304693;1907.961840763177;1919.865609407328;1949.7952714965008;788.8461749958703;824.2169938558274;930.9433792645397;962.841131213356;969.9418034917927;20427.387178384673;21339.57320853574;21364.824934628745;21392.358229253146;21478;818.55388813097;895.4045559702855;934.1825902335456;941.6939494664261;962.4197983501364;10224.846627300596;11233.438328083726;11236.494357753922;11270;11278.379689117177;502840;514840;526394;526921;529971;84727.44175006893;105020;112876;121537;124629.37685311516;978.2516374973009;981.9934567068811;1008.6671398438498;1030.4744580264119;1043.5147656339839;17760.822391775917;18275.908620456812;18401.90799045996;18771.530711732317;18929.43211703651;53289.73355133199;53836.19245711239;54044.64888377822;55096.449035510734;55311.44688553063;74517.62741186259;76014.4797104066;77787;78997;79070.20929790629;6005.699715014319;7536.434767392577;7570.280823321776;7731;7982.6008699565955;10101.747456313651;11993.800619937936;12302.876971230173;12489.875101248872;12559.497620095459;9215.723528294162;10473.900240474944;10501.264911456125;10796.784064318826;10898.945505272422;9789.216862650828;9982.60069597208;10533.631322903662;10866.239363244496;10873.945630271797;10814.945925270324;10821.56713731442;11087.279326843729;11092.33445993243;11179.88820111821;7633.809154770953;7844.921550784419;7877.094134174643;8101.068377136469;8104.918950810416;10223.539940702834;10873.401962892116;11166.44167791591;11201.71995700114;11239.100871930063 17:59:51 INFO - PROCESS | 1662 | |3;mootools.html;1453.978190327145;1501.3544176004314;1698.804637466691;1860.7022876339772;1885.198790514031;7833.960830195848;8280.958595207016;8286.337093032558;8287.75136745897;8298.502089874604;7316.451266155046;7542.962285188566;7553.811154721135;7829.843403131934;8115.14790946951;2124.405166553364;2162.0703097667997;2166.9349919502442;2168.1002384010617;2168.718066651333;2272.4773302140434;2277.350954977832;2294.506681063571;2299.8505097168713;2304.9884750576307;2249.5613355395703;2255.4474153832252;2268.7617800130997;2277.6697378880135;2280.315905228433;2238.2278114050628;2260;2261.0729600863733;2269.5347453771938;2270.23946977761;2247.7752224777555;2283.703118594589;2285.245868863271;2286.7713228677167;2289.210222473244;7706.344960678293;8129.796755081111;8201.30288925442;8209;8235.670573177125;4439.378487011821;4963.900721985576;5102.311187989611;5106.872328191825;5115.18157094863;3234.660360662144;3403.6936675699308;3444.345574340867;3452.7583069185166;3454.2573346730323;984.4683870709808;1015.7308313296983;1027;1031.9174466042698;1064.5050051725907;10601.575936962512;10622.415767132805;10625.5218515167;10634;10741.087007604363;3894.3963685628773;4237.470316210473;4418.403515525363;4600.148972440109;4616.238320677118;9160.8625870612;9164.816703665889;9172.587233574504;9176.632934682539;9213.81572368549;5031.547160755549;5117.513836185556;5137.409197942285;5146.742662866842;5155.304033955443;4193.559676234013;4370.21336159488;4435.379046933432;4570.131674981742;4646.3727396801;3484.1115515543374;3681.2269423420844;3737.8878633641034;3765.9058523536582;3780.243951209769;1086.223350304536;1189.607429548247;1230.4893469210178;1230.809224570193;1245.5017992802952;774.4578794843632;830.4602008694397;894.1773568317163;896.4486840592988;932.4032619123766;5287.735613219324;5602.943970560324;5608.691521966331;5742.7415766290615;5948.970255148696;828.941974061822;903.75146834621;942.6088173407959;975.3513913247752;997.0926456924165;3628.546431696038;3642.2351306225987;3678.8528458861347;3701.2967536168044;3711.3319602471815;9441.527923603793;9854.211663066937;9855.556499957376;9887.30788844774;9890.901090989142;9822.312438129406;9823.557939892722;9833.16418104469;9839.212862971088;9855.605775769032;7296.270372962767;7602.885956710654;7635.389168866477;7655.349295309849;7732.57470839098;5496.4503549646315;5608.270924779753;5739.770409183586;5770.221020162392;5841;8869.379143459895;9139.725808225763;9276;9315.301352398732;9332.72001839946;9318.580663870278;9336.719898403058;9337.766555836159;9344.486053267136;9368.484733339732;6990.755323563651;7049.894251586333;7123.893141602776;7138.821529461805;7155.642217889189;7549.2073332299315;7620.237976202336;7696.807579810549;7703.345215656732;7713.845723085619;6671.733130674718;6787.457003439812;6811.182658081062;6974.442044636316;7019.403350715246;6806.9319306808275;6883.827904302432;6884.690188941609;6912.688928998307;6950.826229344307;6273.749050037947;6457.644829534421;6474.1907261592305;6586.110875031809;6589.155036589763;4115.9176816462905;4701.717896926195;4755.643326750576;4795.18481858078;4883.633727470383;4345.97827010863;4621.32990716351;4761.619070474285;4781.6891902026255;4884.145274577006 17:59:51 INFO - PROCESS | 1662 | |4;prototype.html;290.74414515226596;353.1594804365611;356.8679588552236;363.7417433622127;363.89628955747617;4476.798544065517;4654.557817007383;4665.3235280884255;5026.82406115786;5297.788088476466;4644;5108.182690769478;5162.714946594327;5205.219217117435;5218.425973142951;3300.950485742716;3519.348920449725;3675.5221821163345;4016.871058339085;4060.634542891139;4101.241270364992;4103.589641035903;4106.301928672118;4118.6499147572495;4128.493100018487;4075.144219713849;4087.202995415895;4093.5087789465306;4113.814878330482;4142.316517774563;3335.5497007903864;3752.662260396564;3834.386498160281;4111.403846442264;4125.443065186191;3148.8110713357273;3482.8606855725993;3600.559776089559;3601.549806274216;3604.279144171176;4234.110836724291;4395.384646149541;4445.888852778707;4989.706793516262;5085.466026067246;4466.151431228056;4541.909161816745;4650.488446270908;4661.533846615312;4669.603083737887;4564.566366195206;4673.948361618643;5018.698878067327;5488.121900495901;5516.282883225195;3453.4286899460685;3974.205158968218;3992.6606238469767;4003.4395184674167;4024.3359845625437;4868.78090485929;5447.891042179134;5634.690092044895;5658.179563963244;5790.449907258803;3744.4570537271943;3913.7064720146104;4086.9386959195635;4112.758546592115;4114.403411505315;3569.23261498779;4128.793560321972;4152.43942067823;4152.563980782034;4188.769617671057;4166.520850102277;4464.6428285737065;4602.378678878308;4673.299005149255;4755.953690188153;5477.67133971963;5497.8075767348755;5516.4143306850065;5520.503154716095;5544.63959842609;1192.2667559450874;1307.9869201308056;1332.5003123828565;1339.2968691437075;1339.604816579092;870.1385628228008;929.2751653710117;944.3767113704922;946.3659348236698;947.6114792934864;4780.402449693788;4785.569298763128;4788.880277993078;4801.399825021872;4813.278008298783;4533.591976722045;4847.612191024709;5026.773795179226;5050.989802039607;5282.102042652758;4172.415861779354;4775.928361074587;4812.374391329105;4817.662763606584;4818.325434439182;2474.34429876083;2527.4692314614135;2529.2791554406904;2606.413556949709;2721.79586531007;4716.339712440261;5116;5240.65935714185;5390.649607775482;5650.304908527425;4662.650301227422;5035.79856805731;5400.486953739389;5564.666120032811;5833.620814647034;5673.262475878109;5899.292084949833;5918.970405148033;5924.5852790305125;5941.405859414111;5256;5266.420693723764;5273.815416460406;5715.31416230055;5777.660047680696;5355.732213389393;5456;5598.740283436195;5638.407967163389;5670.682650649416;5469.1951655954235;5545.3622833373065;5747.08046712524;5768.913466298093;5777.566682498914;3513.648635136466;3533.6113027566435;3678.6505281998166;3690.7047436204502;3699.852005919733;4405.180684361947;5460.933512391241;5684.7157642118555;5691.658500489983;5703.401142879938;5051.206821578434;5344.4922732340365;5435.782568697208;5488.670679759227;5498.835034948958;4652.883308006122;5304.602154838325;5425.4857023022605;5498.477644623755;5510.586705997146;4207.221663992172;4682.953170468251;5182.196759502283;5394.379646340564;5409.729513524229;4455.732656040648;4554.9316760249285;4928.334674818853;5226.843194704165;5274.76263568148;4551.886202844956;5342.492463215988;5380.811671591476;5418.106012507892;5464.207689885024 17:59:51 INFO - PROCESS | 1662 | |5;yui.html;720.2437440687277;738.597464381912;768.4160038370836;815.4006804998326;824.8721448175535;14717.558473245806;15811.446599369025;15816.20918954052;15817.92091039546;15852.603684907883;12345.012399008081;12480.375981200927;14212.786808197885;14217.573472795806;14424.711505769877;657.6645910585612;682.0587589126998;683.7914436096988;793.4842352470882;842.8525008123585;857.6998050682242;858.6264974735979;867.3884911137665;871.2855458524012;874.4490970688457;926.7590426489094;926.8934072581671;927.332320729074;927.3832901120746;928.7585227840742;922.3727865051762;924.2236521322121;924.6393906376519;924.9167574918256;925.0887875442717;519.566162254518;538.0771976061075;588.6732863260888;656.3338211715113;683.4873844616537;14959.326830292663;15010.774838377432;15011.699766004727;15013.324400402009;15084.39662413502;13563.796543051862;13586.592402227949;13586.660333491644;13646.181229126285;13660.931695341558;12415.255084694947;12529.122961392706;12536.937315313366;12847.036472264617;12867.09930304879;4390.275604525282;4396.406485124499;4445.244308467568;4560.931586026212;4573.176828170928;103315.48342258316;105353.99999999923;106915;107608;107614.99999999921;9283.25733941283;10679.626213082505;10902.454877256105;10904.727381815359;11095.667129986114;21262.574748504943;21474.14103435845;21832.45418864541;21926.89036554807;21959.451013724785;7700.730474433368;7740.651670674833;7752.147263800977;7823.4523583349755;8009;4199.70602057853;4286.5284818669925;4289.871303860889;4327.632151267115;4449.998750281161;3384.4415671414436;3444.621091679913;3487;3491.284286721216;3501.229729459515;628.9496840252768;632.9208848893888;634.1122428599997;645.1322970604623;650.4731167754135;518.9610779191576;520.8906129712802;541.7670401727295;583.9722089123173;610.9450149486479;7994.880076798852;8429.662813487514;9029;9163.58763855628;9375.62497500106;560.2408437506234;569.1207085053519;597.7967491053063;610.6946526736632;616.1281786272464;4283.571642835754;4447.755373454491;4470.155140678419;4579;4676.672632915664;77729;91779.54110229407;93061;96291.55562666565;103172;85151.14848851557;88585.55707221423;91063;91485;91730.0826991735;80120.59939700265;82117;83029.58485207656;83338.333233335;84724;9800.059388300619;9834.950825245827;9864.309498335047;9996.900030999597;10015.24885633595;46643.766781165876;50343;51517.227241590655;53873.461265386846;54232.746035238015;66536.33463665302;66593.66703166453;70393;72050.55898882098;73853;13150.408231629408;13196.868031319564;13354.465821367037;13387.263700496565;13691.794623080463;12155.392230388623;14787.556373308387;15040.721538669335;15396.84603153999;15644.374225031326;13354.532591359255;13505.527306544223;13601.727965440437;14108.506202282872;14312.284385780462;11185.776284474428;13494.257815820225;13812.723745525234;14361.281935902955;14365.20991345486;13524.256165910969;13634.1137826041;13721.45114195421;14157.221352825281;14349.64125896861;10623.203259755704;11039.613613523488;11052.668419947415;11116.277441966246;11327.093832493545;11234.887651123385;11310.60412885545;11321.943390282995;11355.943220283845;11464.885351146382 17:59:51 INFO - PROCESS | 1662 | __end_tp_report 17:59:51 INFO - PROCESS | 1662 | __start_cc_report 17:59:51 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2501 17:59:51 INFO - PROCESS | 1662 | __end_cc_report 17:59:51 INFO - PROCESS | 1662 | __startTimestamp1482371991109__endTimestamp 17:59:51 INFO - PROCESS | 1662 | 17:59:51 INFO - PROCESS | 1662 | ------- Summary: start ------- 17:59:51 INFO - PROCESS | 1662 | Number of tests: 6 17:59:51 INFO - PROCESS | 1662 | 17:59:51 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5568.97 Median:5752.74 stddev:653.02 (11.4%) stddev-sans-first:615.67 17:59:51 INFO - PROCESS | 1662 | Values: 2722.8 3285.9 3289.3 3315.2 3339.0 5394.5 5492.6 5526.3 5562.6 5595.2 5493.2 5501.6 5550.6 5558.3 5598.7 4626.4 5020.9 5038.6 5078.9 5093.2 4459.4 5092.1 5188.7 5198.9 5234.3 5043.7 5053.7 5095.6 5130.1 5155.0 5106.9 5117.2 5122.7 5124.3 5127.2 5010.7 5076.1 5078.4 5081.2 5107.6 5477.5 5525.4 5525.5 5538.8 5548.2 6026.3 6068.6 6078.9 6106.1 6116.1 5140.8 6170.2 6175.1 6196.3 6216.0 4760.8 5507.9 5509.3 5623.3 5665.4 6125.2 6139.8 6175.5 6191.2 6260.1 5911.2 5920.6 5922.0 5931.9 5942.6 5935.4 6072.6 6086.8 6100.5 6101.5 5922.3 5954.1 5955.6 5958.8 5967.1 5064.0 5938.7 6010.4 6022.9 6031.9 4721.7 4764.2 4769.9 4773.6 4804.4 3641.3 4268.0 4277.1 4281.7 4302.8 5483.9 5535.7 5613.7 5615.0 5629.3 6105.7 6107.5 6128.7 6129.6 6198.4 5607.4 5665.5 5677.3 5677.8 5691.1 5297.2 5307.6 5310.9 5316.5 5334.7 6114.4 6142.7 6169.3 6169.7 6216.1 5994.3 6063.2 6083.8 6098.7 6114.2 6182.0 6188.9 6212.5 6230.7 6248.3 5850.6 5862.1 5907.2 5963.5 5991.1 6021.9 6152.7 6171.9 6177.7 6189.0 5929.1 5931.0 5951.3 5953.7 5960.9 5759.7 5807.1 5900.0 5928.7 5961.9 5741.0 5752.7 5757.2 5762.0 5768.7 5855.2 5880.7 5882.3 5894.3 5899.1 5735.4 5741.6 5751.7 5752.7 5761.1 17:59:51 INFO - PROCESS | 1662 | 17:59:51 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:63431.60 Median:34102.40 stddev:137853.09 (404.2%) stddev-sans-first:138158.59 17:59:51 INFO - PROCESS | 1662 | Values: 405.9 492.2 493.7 497.3 497.6 37855.0 39673.8 39969.8 41807.4 41829.4 40751.0 41151.0 41255.6 41281.4 41458.0 8382.4 8608.5 9384.0 9595.4 9613.7 11123.8 11415.6 11437.3 11594.2 11611.0 11310.5 11391.4 11396.3 11403.9 11438.9 11272.9 11287.7 11352.8 11360.1 11379.0 11099.3 11154.5 11166.3 11170.6 11187.6 38847.6 39151.4 39182.6 39327.2 39362.8 3355.8 3463.9 3498.8 3549.4 3579.8 30013.7 30456.8 30587.2 30689.1 30827.8 3143.9 3157.3 3238.5 3298.8 3299.6 322545.4 351184.0 358278.0 359681.0 360434.0 55197.2 55388.7 55390.7 55420.7 59881.7 62670.0 62792.7 62830.0 62906.1 62964.7 13778.4 15692.8 15936.6 15940.4 15956.5 10972.2 11230.8 11260.0 11440.8 12163.3 16996.7 17091.1 17103.7 17117.2 17140.0 7118.1 7483.9 7512.6 7534.2 7566.9 846.3 868.5 888.5 920.2 951.0 28191.0 29175.9 29201.7 29477.7 30015.8 987.1 1032.9 1076.5 1080.1 1201.1 13440.9 14058.5 14330.0 14353.0 14488.3 595830.0 597816.0 599380.0 599801.0 600175.0 50377.5 50624.2 50647.5 50753.7 50820.0 1214.2 1340.7 1388.9 1398.7 1402.8 25815.9 26431.9 26885.5 27055.0 27116.6 45074.8 45423.8 45440.8 45472.5 45488.0 560633.0 561874.2 562093.0 562954.0 563419.0 21625.0 22033.7 23753.6 24276.4 24525.4 38726.6 40487.0 40768.0 40768.4 40995.8 34306.5 34343.8 34467.0 35416.1 35550.5 33785.0 34034.1 34584.0 34897.8 34962.0 33257.7 33606.8 34060.5 34144.3 34253.7 27507.0 30631.1 30850.0 30856.1 30979.8 19988.4 22881.8 23622.9 23632.8 24185.9 17:59:51 INFO - PROCESS | 1662 | 17:59:51 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:31743.50 Median:358.71 stddev:87190.98 (24306.8%) stddev-sans-first:87403.72 17:59:51 INFO - PROCESS | 1662 | Values: 350.1 367.3 368.2 374.1 396.2 14628.4 14708.6 15633.6 19325.3 20546.3 19786.0 20253.4 20692.2 20952.3 21163.7 5465.8 5721.4 5954.2 5968.7 5976.9 5527.6 5866.8 5922.5 5926.7 5938.1 5678.7 5793.9 5862.4 5876.6 5881.3 5926.8 6063.1 6075.9 6077.4 6077.5 5126.8 5348.9 5405.7 5837.9 5858.2 12844.6 12906.8 13085.7 13096.8 13512.3 1870.6 2152.8 2158.3 2259.9 2296.9 9441.9 9549.7 9613.9 9950.1 10108.8 1756.1 1767.8 1790.1 1818.0 1870.3 109038.5 115814.4 116058.0 117237.0 117427.4 11358.3 11452.1 11529.9 11618.0 11754.0 14406.5 14424.1 14430.6 14447.8 14449.1 8224.6 8368.2 8393.2 8410.4 8498.8 8255.9 8282.2 8401.8 8453.9 8457.2 3799.9 4420.4 4541.6 4554.6 4563.7 1878.5 1899.2 1908.0 1919.9 1949.8 788.8 824.2 930.9 962.8 969.9 20427.4 21339.6 21364.8 21392.4 21478.0 818.6 895.4 934.2 941.7 962.4 10224.8 11233.4 11236.5 11270.0 11278.4 502840.0 514840.0 526394.0 526921.0 529971.0 84727.4 105020.0 112876.0 121537.0 124629.4 978.3 982.0 1008.7 1030.5 1043.5 17760.8 18275.9 18401.9 18771.5 18929.4 53289.7 53836.2 54044.6 55096.4 55311.4 74517.6 76014.5 77787.0 78997.0 79070.2 6005.7 7536.4 7570.3 7731.0 7982.6 10101.7 11993.8 12302.9 12489.9 12559.5 9215.7 10473.9 10501.3 10796.8 10898.9 9789.2 9982.6 10533.6 10866.2 10873.9 10814.9 10821.6 11087.3 11092.3 11179.9 7633.8 7844.9 7877.1 8101.1 8104.9 10223.5 10873.4 11166.4 11201.7 11239.1 17:59:51 INFO - PROCESS | 1662 | 17:59:51 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5325.39 Median:5549.70 stddev:2912.77 (52.5%) stddev-sans-first:2906.42 17:59:51 INFO - PROCESS | 1662 | Values: 1454.0 1501.4 1698.8 1860.7 1885.2 7834.0 8281.0 8286.3 8287.8 8298.5 7316.5 7543.0 7553.8 7829.8 8115.1 2124.4 2162.1 2166.9 2168.1 2168.7 2272.5 2277.4 2294.5 2299.9 2305.0 2249.6 2255.4 2268.8 2277.7 2280.3 2238.2 2260.0 2261.1 2269.5 2270.2 2247.8 2283.7 2285.2 2286.8 2289.2 7706.3 8129.8 8201.3 8209.0 8235.7 4439.4 4963.9 5102.3 5106.9 5115.2 3234.7 3403.7 3444.3 3452.8 3454.3 984.5 1015.7 1027.0 1031.9 1064.5 10601.6 10622.4 10625.5 10634.0 10741.1 3894.4 4237.5 4418.4 4600.1 4616.2 9160.9 9164.8 9172.6 9176.6 9213.8 5031.5 5117.5 5137.4 5146.7 5155.3 4193.6 4370.2 4435.4 4570.1 4646.4 3484.1 3681.2 3737.9 3765.9 3780.2 1086.2 1189.6 1230.5 1230.8 1245.5 774.5 830.5 894.2 896.4 932.4 5287.7 5602.9 5608.7 5742.7 5949.0 828.9 903.8 942.6 975.4 997.1 3628.5 3642.2 3678.9 3701.3 3711.3 9441.5 9854.2 9855.6 9887.3 9890.9 9822.3 9823.6 9833.2 9839.2 9855.6 7296.3 7602.9 7635.4 7655.3 7732.6 5496.5 5608.3 5739.8 5770.2 5841.0 8869.4 9139.7 9276.0 9315.3 9332.7 9318.6 9336.7 9337.8 9344.5 9368.5 6990.8 7049.9 7123.9 7138.8 7155.6 7549.2 7620.2 7696.8 7703.3 7713.8 6671.7 6787.5 6811.2 6974.4 7019.4 6806.9 6883.8 6884.7 6912.7 6950.8 6273.7 6457.6 6474.2 6586.1 6589.2 4115.9 4701.7 4755.6 4795.2 4883.6 4346.0 4621.3 4761.6 4781.7 4884.1 17:59:51 INFO - PROCESS | 1662 | 17:59:51 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4395.63 Median:4778.17 stddev:1319.33 (27.6%) stddev-sans-first:1286.56 17:59:51 INFO - PROCESS | 1662 | Values: 290.7 353.2 356.9 363.7 363.9 4476.8 4654.6 4665.3 5026.8 5297.8 4644.0 5108.2 5162.7 5205.2 5218.4 3301.0 3519.3 3675.5 4016.9 4060.6 4101.2 4103.6 4106.3 4118.6 4128.5 4075.1 4087.2 4093.5 4113.8 4142.3 3335.5 3752.7 3834.4 4111.4 4125.4 3148.8 3482.9 3600.6 3601.5 3604.3 4234.1 4395.4 4445.9 4989.7 5085.5 4466.2 4541.9 4650.5 4661.5 4669.6 4564.6 4673.9 5018.7 5488.1 5516.3 3453.4 3974.2 3992.7 4003.4 4024.3 4868.8 5447.9 5634.7 5658.2 5790.4 3744.5 3913.7 4086.9 4112.8 4114.4 3569.2 4128.8 4152.4 4152.6 4188.8 4166.5 4464.6 4602.4 4673.3 4756.0 5477.7 5497.8 5516.4 5520.5 5544.6 1192.3 1308.0 1332.5 1339.3 1339.6 870.1 929.3 944.4 946.4 947.6 4780.4 4785.6 4788.9 4801.4 4813.3 4533.6 4847.6 5026.8 5051.0 5282.1 4172.4 4775.9 4812.4 4817.7 4818.3 2474.3 2527.5 2529.3 2606.4 2721.8 4716.3 5116.0 5240.7 5390.6 5650.3 4662.7 5035.8 5400.5 5564.7 5833.6 5673.3 5899.3 5919.0 5924.6 5941.4 5256.0 5266.4 5273.8 5715.3 5777.7 5355.7 5456.0 5598.7 5638.4 5670.7 5469.2 5545.4 5747.1 5768.9 5777.6 3513.6 3533.6 3678.7 3690.7 3699.9 4405.2 5460.9 5684.7 5691.7 5703.4 5051.2 5344.5 5435.8 5488.7 5498.8 4652.9 5304.6 5425.5 5498.5 5510.6 4207.2 4683.0 5182.2 5394.4 5409.7 4455.7 4554.9 4928.3 5226.8 5274.8 4551.9 5342.5 5380.8 5418.1 5464.2 17:59:51 INFO - PROCESS | 1662 | 17:59:51 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:20444.10 Median:4460.08 stddev:29112.34 (652.7%) stddev-sans-first:29156.34 17:59:51 INFO - PROCESS | 1662 | Values: 720.2 738.6 768.4 815.4 824.9 14717.6 15811.4 15816.2 15817.9 15852.6 12345.0 12480.4 14212.8 14217.6 14424.7 657.7 682.1 683.8 793.5 842.9 857.7 858.6 867.4 871.3 874.4 926.8 926.9 927.3 927.4 928.8 922.4 924.2 924.6 924.9 925.1 519.6 538.1 588.7 656.3 683.5 14959.3 15010.8 15011.7 15013.3 15084.4 13563.8 13586.6 13586.7 13646.2 13660.9 12415.3 12529.1 12536.9 12847.0 12867.1 4390.3 4396.4 4445.2 4560.9 4573.2 103315.5 105354.0 106915.0 107608.0 107615.0 9283.3 10679.6 10902.5 10904.7 11095.7 21262.6 21474.1 21832.5 21926.9 21959.5 7700.7 7740.7 7752.1 7823.5 8009.0 4199.7 4286.5 4289.9 4327.6 4450.0 3384.4 3444.6 3487.0 3491.3 3501.2 628.9 632.9 634.1 645.1 650.5 519.0 520.9 541.8 584.0 610.9 7994.9 8429.7 9029.0 9163.6 9375.6 560.2 569.1 597.8 610.7 616.1 4283.6 4447.8 4470.2 4579.0 4676.7 77729.0 91779.5 93061.0 96291.6 103172.0 85151.1 88585.6 91063.0 91485.0 91730.1 80120.6 82117.0 83029.6 83338.3 84724.0 9800.1 9835.0 9864.3 9996.9 10015.2 46643.8 50343.0 51517.2 53873.5 54232.7 66536.3 66593.7 70393.0 72050.6 73853.0 13150.4 13196.9 13354.5 13387.3 13691.8 12155.4 14787.6 15040.7 15396.8 15644.4 13354.5 13505.5 13601.7 14108.5 14312.3 11185.8 13494.3 13812.7 14361.3 14365.2 13524.3 13634.1 13721.5 14157.2 14349.6 10623.2 11039.6 11052.7 11116.3 11327.1 11234.9 11310.6 11321.9 11355.9 11464.9 17:59:51 INFO - PROCESS | 1662 | -------- Summary: end -------- 17:59:51 INFO - PROCESS | 1662 | 17:59:51 INFO - TEST-INFO | 1662: exit 0 17:59:51 INFO - TEST-OK | dromaeo_css | took 1119265ms 17:59:51 INFO - TEST-START | kraken 17:59:51 INFO - operating with platform_type : mac_ 17:59:51 INFO - Initialising browser for kraken test... 17:59:51 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmp98igBx/profile http://localhost:49236/getInfo.html) 17:59:54 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 17:59:54 INFO - PROCESS | 1669 | colorDepth:24 17:59:54 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 17:59:54 INFO - PROCESS | 1669 | __metrics 17:59:54 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:59:54 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:59:55 INFO - TEST-INFO | 1669: exit 0 17:59:55 INFO - Browser initialized. 17:59:55 INFO - Running cycle 1/1 for kraken test... 17:59:55 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmp98igBx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:00:07 INFO - PROCESS | 1670 | RSS: Main: 229355520 18:00:07 INFO - PROCESS | 1670 | 18:00:09 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 18:00:10 INFO - PROCESS | 1670 | RSS: Main: 289021952 18:00:10 INFO - PROCESS | 1670 | 18:00:13 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 18:00:14 INFO - PROCESS | 1670 | RSS: Main: 291037184 18:00:14 INFO - PROCESS | 1670 | 18:00:17 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 18:00:18 INFO - PROCESS | 1670 | RSS: Main: 382619648 18:00:18 INFO - PROCESS | 1670 | 18:00:20 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 18:00:20 INFO - PROCESS | 1670 | RSS: Main: 284930048 18:00:20 INFO - PROCESS | 1670 | 18:00:22 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:00:23 INFO - PROCESS | 1670 | RSS: Main: 289841152 18:00:23 INFO - PROCESS | 1670 | 18:00:26 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 18:00:26 INFO - PROCESS | 1670 | RSS: Main: 332181504 18:00:26 INFO - PROCESS | 1670 | 18:00:29 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 18:00:30 INFO - PROCESS | 1670 | RSS: Main: 333348864 18:00:30 INFO - PROCESS | 1670 | 18:00:33 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 18:00:33 INFO - PROCESS | 1670 | RSS: Main: 329154560 18:00:33 INFO - PROCESS | 1670 | 18:00:35 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:00:35 INFO - PROCESS | 1670 | RSS: Main: 303857664 18:00:35 INFO - PROCESS | 1670 | 18:00:37 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:00:38 INFO - PROCESS | 1670 | RSS: Main: 307716096 18:00:38 INFO - PROCESS | 1670 | 18:00:40 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:00:41 INFO - PROCESS | 1670 | RSS: Main: 311844864 18:00:41 INFO - PROCESS | 1670 | 18:00:44 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:00:45 INFO - PROCESS | 1670 | RSS: Main: 325640192 18:00:45 INFO - PROCESS | 1670 | 18:00:48 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:00:48 INFO - PROCESS | 1670 | RSS: Main: 319569920 18:00:48 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 18:00:50 INFO - PROCESS | 1670 | RSS: Main: 363483136 18:00:50 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | __start_tp_report 18:00:50 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 18:00:50 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 18:00:50 INFO - PROCESS | 1670 | |i|pagename|runs| 18:00:50 INFO - PROCESS | 1670 | |0;ai-astar;105;114;114;113;113;114;113;113;116;158 18:00:50 INFO - PROCESS | 1670 | |1;audio-beat-detection;143;110;112;172;132;137;110;108;126;137 18:00:50 INFO - PROCESS | 1670 | |2;audio-dft;183;183;186;183;182;185;180;182;183;186 18:00:50 INFO - PROCESS | 1670 | |3;audio-fft;83;58;60;87;59;62;60;57;74;57 18:00:50 INFO - PROCESS | 1670 | |4;audio-oscillator;83;70;85;68;70;68;82;68;67;85 18:00:50 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;88;87;89;86;91;85;88;88;90;86 18:00:50 INFO - PROCESS | 1670 | |6;imaging-darkroom;96;95;96;98;96;95;95;97;95;101 18:00:50 INFO - PROCESS | 1670 | |7;imaging-desaturate;86;85;86;86;87;85;89;84;88;85 18:00:50 INFO - PROCESS | 1670 | |8;json-parse-financial;57;55;54;53;55;56;56;55;57;55 18:00:50 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;63;77;76;76;73;67;69;71;69;75 18:00:50 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;85;89;90;86;85;85;84;85;92;88 18:00:50 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;143;148;145;159;146;149;148;139;183;150 18:00:50 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;170;193;216;186;172;172;172;170;173;171 18:00:50 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;68;66;67;68;67;68;66;67;67;66 18:00:50 INFO - PROCESS | 1670 | __end_tp_report 18:00:50 INFO - PROCESS | 1670 | __start_cc_report 18:00:50 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,2067 18:00:50 INFO - PROCESS | 1670 | __end_cc_report 18:00:50 INFO - PROCESS | 1670 | __startTimestamp1482372050609__endTimestamp 18:00:50 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | ------- Summary: start ------- 18:00:50 INFO - PROCESS | 1670 | Number of tests: 14 18:00:50 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:117.30 Median:114.00 stddev:14.59 (12.8%) stddev-sans-first:14.78 18:00:50 INFO - PROCESS | 1670 | Values: 105.0 114.0 114.0 113.0 113.0 114.0 113.0 113.0 116.0 158.0 18:00:50 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:128.70 Median:134.50 stddev:20.12 (15.0%) stddev-sans-first:20.66 18:00:50 INFO - PROCESS | 1670 | Values: 143.0 110.0 112.0 172.0 132.0 137.0 110.0 108.0 126.0 137.0 18:00:50 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.00 stddev:1.89 (1.0%) stddev-sans-first:2.00 18:00:50 INFO - PROCESS | 1670 | Values: 183.0 183.0 186.0 183.0 182.0 185.0 180.0 182.0 183.0 186.0 18:00:50 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:65.70 Median:61.00 stddev:11.33 (18.6%) stddev-sans-first:10.15 18:00:50 INFO - PROCESS | 1670 | Values: 83.0 58.0 60.0 87.0 59.0 62.0 60.0 57.0 74.0 57.0 18:00:50 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:74.60 Median:76.00 stddev:7.97 (10.5%) stddev-sans-first:7.86 18:00:50 INFO - PROCESS | 1670 | Values: 83.0 70.0 85.0 68.0 70.0 68.0 82.0 68.0 67.0 85.0 18:00:50 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:88.00 stddev:1.87 (2.1%) stddev-sans-first:1.99 18:00:50 INFO - PROCESS | 1670 | Values: 88.0 87.0 89.0 86.0 91.0 85.0 88.0 88.0 90.0 86.0 18:00:50 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:96.00 stddev:1.90 (2.0%) stddev-sans-first:2.01 18:00:50 INFO - PROCESS | 1670 | Values: 96.0 95.0 96.0 98.0 96.0 95.0 95.0 97.0 95.0 101.0 18:00:50 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:86.10 Median:86.00 stddev:1.52 (1.8%) stddev-sans-first:1.62 18:00:50 INFO - PROCESS | 1670 | Values: 86.0 85.0 86.0 86.0 87.0 85.0 89.0 84.0 88.0 85.0 18:00:50 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:1.25 (2.3%) stddev-sans-first:1.17 18:00:50 INFO - PROCESS | 1670 | Values: 57.0 55.0 54.0 53.0 55.0 56.0 56.0 55.0 57.0 55.0 18:00:50 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:74.00 stddev:4.60 (6.2%) stddev-sans-first:3.68 18:00:50 INFO - PROCESS | 1670 | Values: 63.0 77.0 76.0 76.0 73.0 67.0 69.0 71.0 69.0 75.0 18:00:50 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:87.00 stddev:2.69 (3.1%) stddev-sans-first:2.76 18:00:50 INFO - PROCESS | 1670 | Values: 85.0 89.0 90.0 86.0 85.0 85.0 84.0 85.0 92.0 88.0 18:00:50 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:151.00 Median:148.50 stddev:12.38 (8.3%) stddev-sans-first:12.79 18:00:50 INFO - PROCESS | 1670 | Values: 143.0 148.0 145.0 159.0 146.0 149.0 148.0 139.0 183.0 150.0 18:00:50 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.50 Median:172.50 stddev:14.98 (8.7%) stddev-sans-first:15.49 18:00:50 INFO - PROCESS | 1670 | Values: 170.0 193.0 216.0 186.0 172.0 172.0 172.0 170.0 173.0 171.0 18:00:50 INFO - PROCESS | 1670 | 18:00:50 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 18:00:50 INFO - PROCESS | 1670 | Values: 68.0 66.0 67.0 68.0 67.0 68.0 66.0 67.0 67.0 66.0 18:00:50 INFO - PROCESS | 1670 | -------- Summary: end -------- 18:00:50 INFO - PROCESS | 1670 | 18:00:51 INFO - TEST-INFO | 1670: exit 0 18:00:51 INFO - TEST-OK | kraken | took 59660ms 18:00:51 INFO - SUITE-END | took 1178s 18:00:51 INFO - Completed test suite (00:19:39) 18:00:51 INFO - javascript benchmark 18:00:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2722.823016503927, 3285.934281314374, 3289.3421315736846, 3315.1712071982006, 3338.966610333896, 5394.541463975557, 5492.588055895814, 5526.309211348582, 5562.610617256793, 5595.18869763884, 5493.23094766733, 5501.559875209983, 5550.611457197998, 5558.277423934883, 5598.748056337475, 4626.421697287839, 5020.924686129711, 5038.59691224703, 5078.923816142761, 5093.236014597803, 4459.4202753641985, 5092.057969275677, 5188.740562971855, 5198.92201616976, 5234.267202591621, 5043.747812609392, 5053.671511351788, 5095.566876815476, 5130.07658621448, 5154.974225128851, 5106.923396149061, 5117.155669314596, 5122.667026643294, 5124.333836601218, 5127.2052831811125, 5010.7494625268955, 5076.13705670037, 5078.415982162025, 5081.237814327844, 5107.565856902168, 5477.534409575191, 5525.4474552544825, 5525.502704756591, 5538.778448862041, 5548.167774833767, 6026.306974697922, 6068.605540639845, 6078.908816367758, 6106.114613381035, 6116.052011938113, 5140.768665410065, 6170.19787427636, 6175.135481032659, 6196.318404975449, 6215.968920155416, 4760.833370832004, 5507.862303442366, 5509.256250406224, 5623.26897503326, 5665.433456654343, 6125.2460813874895, 6139.750513311054, 6175.536834737412, 6191.164192834, 6260.060990851409, 5911.201987731687, 5920.615160014585, 5922.0, 5931.940680593225, 5942.64344139353, 5935.376785437467, 6072.574919755663, 6086.817395478142, 6100.450959413674, 6101.450869421773, 5922.3485416604135, 5954.136650185699, 5955.642661440327, 5958.761649534057, 5967.1347654589845, 5064.0, 5938.703064846741, 6010.3689112643415, 6022.909656355158, 6031.909521357183, 4721.716696998123, 4764.166270902579, 4769.856904292877, 4773.618110551148, 4804.42346918372, 3641.32635462435, 4267.97866010668, 4277.144571085795, 4281.7002809803635, 4302.763348015889, 5483.862903427446, 5535.723213839292, 5613.747381367848, 5614.9612321720615, 5629.2681951346885, 6105.664188469588, 6107.450329470369, 6128.686460748404, 6129.632222066691, 6198.411150940653, 5607.383187849333, 5665.5467562594895, 5677.290338707661, 5677.80127695537, 5691.117876729114, 5297.17893726473, 5307.575393968474, 5310.946890531122, 5316.494932981361, 5334.7065911374475, 6114.449440885012, 6142.652254521207, 6169.290531588746, 6169.691515424301, 6216.098665693539, 5994.250718660168, 6063.242094738158, 6083.7870674526175, 6098.664573448503, 6114.2357205349335, 6182.0, 6188.876222475616, 6212.534059945432, 6230.6884655766125, 6248.281447633581, 5850.64896106235, 5862.149988251595, 5907.202527658711, 5963.493103086286, 5991.131285963598, 6021.909671355021, 6152.661603611844, 6171.876562468815, 6177.660228687465, 6188.9788184948975, 5929.140274660236, 5931.021381472009, 5951.345352011189, 5953.732082056405, 5960.850978725566, 5759.71201439918, 5807.070868660994, 5900.0, 5928.67392293428, 5961.910571341346, 5740.966626007192, 5752.712364381848, 5757.222774925332, 5761.991651460894, 5768.653880767168, 5855.180274761452, 5880.705964701833, 5882.294124704892, 5894.322152952293, 5899.085641725539, 5735.426457354231, 5741.62679425836, 5751.654900705971, 5752.741126649395, 5761.078227483583], "value": 5525.447719375617, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.8737004811648, 492.19771772011615, 493.6889759451545, 497.28639402457463, 497.5845169283648, 37855.0, 39673.80163099184, 39969.800150999276, 41807.37288940668, 41829.37255941163, 40751.0, 41150.971225719375, 41255.58744412555, 41281.38077928834, 41457.96355091124, 8382.371322150833, 8608.52653104079, 9383.953080234607, 9595.424274543515, 9613.711588652352, 11123.777524449506, 11415.600453984112, 11437.256578322382, 11594.246373985665, 11611.0, 11310.491027903723, 11391.430428478543, 11396.347529608202, 11403.885961140408, 11438.942805285962, 11272.929071738212, 11287.717807054807, 11352.829707554394, 11360.147988900824, 11379.032782213522, 11099.278546894426, 11154.498047587878, 11166.330020198815, 11170.553177872875, 11187.552497900155, 38847.61152388468, 39151.41272880909, 39182.62860799887, 39327.21345573072, 39362.80318598417, 3355.8489867956, 3463.8960831175104, 3498.7900725956524, 3549.378858699743, 3579.803110828929, 30013.699863001308, 30456.84771576128, 30587.2353191172, 30689.09495363548, 30827.845860770554, 3143.931063438419, 3157.3211759471824, 3238.5304130901122, 3298.7855789373616, 3299.554560134375, 322545.38727306447, 351184.0, 358278.0, 359681.0, 360434.0, 55197.17204241859, 55388.72305638446, 55390.72304638451, 55420.72289638526, 59881.70059149677, 62670.0, 62792.686036569525, 62830.0, 62906.0564091539, 62964.685176573825, 13778.448862045607, 15692.76460853088, 15936.601584960468, 15940.362385504683, 15956.521304360887, 10972.177086718528, 11230.831537526943, 11260.0, 11440.828387574193, 12163.2702037878, 16996.660066798595, 17091.059991700575, 17103.743443848103, 17117.22972466242, 17140.0, 7118.145822501229, 7483.8503229935095, 7512.6243687815395, 7534.208908064684, 7566.886496702554, 846.3144852669358, 868.4745728834091, 888.5246393179747, 920.1994264989502, 950.9619615215453, 28191.0, 29175.854120729262, 29201.707982920325, 29477.705222947498, 30015.849920750257, 987.0573602209872, 1032.936075841869, 1076.494047797534, 1080.135891286983, 1201.08117290273, 13440.932795336157, 14058.507952221828, 14330.0, 14353.0, 14488.275586220647, 595830.0, 597816.0, 599380.0, 599801.0009950009, 600174.9991250016, 50377.49622503801, 50624.24063639048, 50647.493525065016, 50753.746231269346, 50820.0, 1214.2289646074805, 1340.6538557524332, 1388.9305534723426, 1398.741232871922, 1402.845686974432, 25815.870920645277, 26431.86784066144, 26885.462290754465, 27055.0, 27116.593251101644, 45074.77462612797, 45423.77288113538, 45440.77279613581, 45472.54527454683, 45487.999999998676, 560633.0, 561874.1906290606, 562093.0, 562954.0, 563419.0, 21625.0, 22033.669494957267, 23753.64369534493, 24276.393090172885, 24525.386865327797, 38726.6127338723, 40487.0, 40768.0, 40768.36926523024, 40995.79502102471, 34306.48540271948, 34343.82828085843, 34467.0, 35416.114597135274, 35550.46674299836, 33784.986450406526, 34034.14914627154, 34584.0, 34897.82551087228, 34962.0, 33257.669693212, 33606.831965840014, 34060.489092664124, 34144.317113658086, 34253.65746342605, 27507.0, 30631.081067568008, 30849.95379065741, 30856.074317770504, 30979.845100774353, 19988.400347989584, 22881.77118228863, 23622.88188559046, 23632.763672363057, 24185.911633976866], "value": 19094.658587819402, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.13167344984424, 367.28929521376136, 368.2395852564454, 374.12828110502534, 396.19176879166486, 14628.414863405464, 14708.632284192901, 15633.5929766321, 19325.323613673525, 20546.280880169197, 19786.0, 20253.39239822804, 20692.172313107494, 20952.26667066653, 21163.68254476184, 5465.824847657753, 5721.399253078419, 5954.196183515213, 5968.731407086691, 5976.88046239075, 5527.640703354289, 5866.76532938682, 5922.466977971982, 5926.703664816763, 5938.079597662348, 5678.744456499468, 5793.942060579382, 5862.443067908542, 5876.647401155944, 5881.294244690643, 5926.822195334125, 6063.120847477136, 6075.939240607581, 6077.42264484871, 6077.5137988961, 5126.820561280338, 5348.866278343034, 5405.702686352249, 5837.883242335172, 5858.179854820286, 12844.614661560168, 12906.80639790404, 13085.738285234242, 13096.803547946789, 13512.256825874572, 1870.5884705364797, 2152.773958734326, 2158.333952405706, 2259.9435014124615, 2296.9310920672237, 9441.90558094424, 9549.665761698378, 9613.855792163124, 9950.054744799305, 10108.786945566579, 1756.130715295924, 1767.8232176782346, 1790.1496789025239, 1817.954551136219, 1870.2799422222406, 109038.45480772546, 115814.42092789483, 116058.0, 117237.0, 117427.41286293599, 11358.318500889807, 11452.141089418326, 11529.942350288362, 11617.991792831459, 11754.0, 14406.495772647908, 14424.134551926918, 14430.567082987527, 14447.78328325076, 14449.133052016912, 8224.588770561448, 8368.24685778283, 8393.202645748644, 8410.369222308229, 8498.830023399498, 8255.876161857577, 8282.213189746964, 8401.831963360699, 8453.873191902127, 8457.238848503664, 3799.9430008549894, 4420.403245561873, 4541.568550987651, 4554.590086892195, 4563.703359281636, 1878.474027272366, 1899.2497963304693, 1907.961840763177, 1919.865609407328, 1949.7952714965008, 788.8461749958703, 824.2169938558274, 930.9433792645397, 962.841131213356, 969.9418034917927, 20427.387178384673, 21339.57320853574, 21364.824934628745, 21392.358229253146, 21478.0, 818.55388813097, 895.4045559702855, 934.1825902335456, 941.6939494664261, 962.4197983501364, 10224.846627300596, 11233.438328083726, 11236.494357753922, 11270.0, 11278.379689117177, 502840.0, 514840.0, 526394.0, 526921.0, 529971.0, 84727.44175006893, 105020.0, 112876.0, 121537.0, 124629.37685311516, 978.2516374973009, 981.9934567068811, 1008.6671398438498, 1030.4744580264119, 1043.5147656339839, 17760.822391775917, 18275.908620456812, 18401.90799045996, 18771.530711732317, 18929.43211703651, 53289.73355133199, 53836.19245711239, 54044.64888377822, 55096.449035510734, 55311.44688553063, 74517.62741186259, 76014.4797104066, 77787.0, 78997.0, 79070.20929790629, 6005.699715014319, 7536.434767392577, 7570.280823321776, 7731.0, 7982.6008699565955, 10101.747456313651, 11993.800619937936, 12302.876971230173, 12489.875101248872, 12559.497620095459, 9215.723528294162, 10473.900240474944, 10501.264911456125, 10796.784064318826, 10898.945505272422, 9789.216862650828, 9982.60069597208, 10533.631322903662, 10866.239363244496, 10873.945630271797, 10814.945925270324, 10821.56713731442, 11087.279326843729, 11092.33445993243, 11179.88820111821, 7633.809154770953, 7844.921550784419, 7877.094134174643, 8101.068377136469, 8104.918950810416, 10223.539940702834, 10873.401962892116, 11166.44167791591, 11201.71995700114, 11239.100871930063], "value": 9121.02682991084, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.978190327145, 1501.3544176004314, 1698.804637466691, 1860.7022876339772, 1885.198790514031, 7833.960830195848, 8280.958595207016, 8286.337093032558, 8287.75136745897, 8298.502089874604, 7316.451266155046, 7542.962285188566, 7553.811154721135, 7829.843403131934, 8115.14790946951, 2124.405166553364, 2162.0703097667997, 2166.9349919502442, 2168.1002384010617, 2168.718066651333, 2272.4773302140434, 2277.350954977832, 2294.506681063571, 2299.8505097168713, 2304.9884750576307, 2249.5613355395703, 2255.4474153832252, 2268.7617800130997, 2277.6697378880135, 2280.315905228433, 2238.2278114050628, 2260.0, 2261.0729600863733, 2269.5347453771938, 2270.23946977761, 2247.7752224777555, 2283.703118594589, 2285.245868863271, 2286.7713228677167, 2289.210222473244, 7706.344960678293, 8129.796755081111, 8201.30288925442, 8209.0, 8235.670573177125, 4439.378487011821, 4963.900721985576, 5102.311187989611, 5106.872328191825, 5115.18157094863, 3234.660360662144, 3403.6936675699308, 3444.345574340867, 3452.7583069185166, 3454.2573346730323, 984.4683870709808, 1015.7308313296983, 1027.0, 1031.9174466042698, 1064.5050051725907, 10601.575936962512, 10622.415767132805, 10625.5218515167, 10634.0, 10741.087007604363, 3894.3963685628773, 4237.470316210473, 4418.403515525363, 4600.148972440109, 4616.238320677118, 9160.8625870612, 9164.816703665889, 9172.587233574504, 9176.632934682539, 9213.81572368549, 5031.547160755549, 5117.513836185556, 5137.409197942285, 5146.742662866842, 5155.304033955443, 4193.559676234013, 4370.21336159488, 4435.379046933432, 4570.131674981742, 4646.3727396801, 3484.1115515543374, 3681.2269423420844, 3737.8878633641034, 3765.9058523536582, 3780.243951209769, 1086.223350304536, 1189.607429548247, 1230.4893469210178, 1230.809224570193, 1245.5017992802952, 774.4578794843632, 830.4602008694397, 894.1773568317163, 896.4486840592988, 932.4032619123766, 5287.735613219324, 5602.943970560324, 5608.691521966331, 5742.7415766290615, 5948.970255148696, 828.941974061822, 903.75146834621, 942.6088173407959, 975.3513913247752, 997.0926456924165, 3628.546431696038, 3642.2351306225987, 3678.8528458861347, 3701.2967536168044, 3711.3319602471815, 9441.527923603793, 9854.211663066937, 9855.556499957376, 9887.30788844774, 9890.901090989142, 9822.312438129406, 9823.557939892722, 9833.16418104469, 9839.212862971088, 9855.605775769032, 7296.270372962767, 7602.885956710654, 7635.389168866477, 7655.349295309849, 7732.57470839098, 5496.4503549646315, 5608.270924779753, 5739.770409183586, 5770.221020162392, 5841.0, 8869.379143459895, 9139.725808225763, 9276.0, 9315.301352398732, 9332.72001839946, 9318.580663870278, 9336.719898403058, 9337.766555836159, 9344.486053267136, 9368.484733339732, 6990.755323563651, 7049.894251586333, 7123.893141602776, 7138.821529461805, 7155.642217889189, 7549.2073332299315, 7620.237976202336, 7696.807579810549, 7703.345215656732, 7713.845723085619, 6671.733130674718, 6787.457003439812, 6811.182658081062, 6974.442044636316, 7019.403350715246, 6806.9319306808275, 6883.827904302432, 6884.690188941609, 6912.688928998307, 6950.826229344307, 6273.749050037947, 6457.644829534421, 6474.1907261592305, 6586.110875031809, 6589.155036589763, 4115.9176816462905, 4701.717896926195, 4755.643326750576, 4795.18481858078, 4883.633727470383, 4345.97827010863, 4621.32990716351, 4761.619070474285, 4781.6891902026255, 4884.145274577006], "value": 4324.08968620344, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.74414515226596, 353.1594804365611, 356.8679588552236, 363.7417433622127, 363.89628955747617, 4476.798544065517, 4654.557817007383, 4665.3235280884255, 5026.82406115786, 5297.788088476466, 4644.0, 5108.182690769478, 5162.714946594327, 5205.219217117435, 5218.425973142951, 3300.950485742716, 3519.348920449725, 3675.5221821163345, 4016.871058339085, 4060.634542891139, 4101.241270364992, 4103.589641035903, 4106.301928672118, 4118.6499147572495, 4128.493100018487, 4075.144219713849, 4087.202995415895, 4093.5087789465306, 4113.814878330482, 4142.316517774563, 3335.5497007903864, 3752.662260396564, 3834.386498160281, 4111.403846442264, 4125.443065186191, 3148.8110713357273, 3482.8606855725993, 3600.559776089559, 3601.549806274216, 3604.279144171176, 4234.110836724291, 4395.384646149541, 4445.888852778707, 4989.706793516262, 5085.466026067246, 4466.151431228056, 4541.909161816745, 4650.488446270908, 4661.533846615312, 4669.603083737887, 4564.566366195206, 4673.948361618643, 5018.698878067327, 5488.121900495901, 5516.282883225195, 3453.4286899460685, 3974.205158968218, 3992.6606238469767, 4003.4395184674167, 4024.3359845625437, 4868.78090485929, 5447.891042179134, 5634.690092044895, 5658.179563963244, 5790.449907258803, 3744.4570537271943, 3913.7064720146104, 4086.9386959195635, 4112.758546592115, 4114.403411505315, 3569.23261498779, 4128.793560321972, 4152.43942067823, 4152.563980782034, 4188.769617671057, 4166.520850102277, 4464.6428285737065, 4602.378678878308, 4673.299005149255, 4755.953690188153, 5477.67133971963, 5497.8075767348755, 5516.4143306850065, 5520.503154716095, 5544.63959842609, 1192.2667559450874, 1307.9869201308056, 1332.5003123828565, 1339.2968691437075, 1339.604816579092, 870.1385628228008, 929.2751653710117, 944.3767113704922, 946.3659348236698, 947.6114792934864, 4780.402449693788, 4785.569298763128, 4788.880277993078, 4801.399825021872, 4813.278008298783, 4533.591976722045, 4847.612191024709, 5026.773795179226, 5050.989802039607, 5282.102042652758, 4172.415861779354, 4775.928361074587, 4812.374391329105, 4817.662763606584, 4818.325434439182, 2474.34429876083, 2527.4692314614135, 2529.2791554406904, 2606.413556949709, 2721.79586531007, 4716.339712440261, 5116.0, 5240.65935714185, 5390.649607775482, 5650.304908527425, 4662.650301227422, 5035.79856805731, 5400.486953739389, 5564.666120032811, 5833.620814647034, 5673.262475878109, 5899.292084949833, 5918.970405148033, 5924.5852790305125, 5941.405859414111, 5256.0, 5266.420693723764, 5273.815416460406, 5715.31416230055, 5777.660047680696, 5355.732213389393, 5456.0, 5598.740283436195, 5638.407967163389, 5670.682650649416, 5469.1951655954235, 5545.3622833373065, 5747.08046712524, 5768.913466298093, 5777.566682498914, 3513.648635136466, 3533.6113027566435, 3678.6505281998166, 3690.7047436204502, 3699.852005919733, 4405.180684361947, 5460.933512391241, 5684.7157642118555, 5691.658500489983, 5703.401142879938, 5051.206821578434, 5344.4922732340365, 5435.782568697208, 5488.670679759227, 5498.835034948958, 4652.883308006122, 5304.602154838325, 5425.4857023022605, 5498.477644623755, 5510.586705997146, 4207.221663992172, 4682.953170468251, 5182.196759502283, 5394.379646340564, 5409.729513524229, 4455.732656040648, 4554.9316760249285, 4928.334674818853, 5226.843194704165, 5274.76263568148, 4551.886202844956, 5342.492463215988, 5380.811671591476, 5418.106012507892, 5464.207689885024], "value": 3992.8504083932653, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.2437440687277, 738.597464381912, 768.4160038370836, 815.4006804998326, 824.8721448175535, 14717.558473245806, 15811.446599369025, 15816.20918954052, 15817.92091039546, 15852.603684907883, 12345.012399008081, 12480.375981200927, 14212.786808197885, 14217.573472795806, 14424.711505769877, 657.6645910585612, 682.0587589126998, 683.7914436096988, 793.4842352470882, 842.8525008123585, 857.6998050682242, 858.6264974735979, 867.3884911137665, 871.2855458524012, 874.4490970688457, 926.7590426489094, 926.8934072581671, 927.332320729074, 927.3832901120746, 928.7585227840742, 922.3727865051762, 924.2236521322121, 924.6393906376519, 924.9167574918256, 925.0887875442717, 519.566162254518, 538.0771976061075, 588.6732863260888, 656.3338211715113, 683.4873844616537, 14959.326830292663, 15010.774838377432, 15011.699766004727, 15013.324400402009, 15084.39662413502, 13563.796543051862, 13586.592402227949, 13586.660333491644, 13646.181229126285, 13660.931695341558, 12415.255084694947, 12529.122961392706, 12536.937315313366, 12847.036472264617, 12867.09930304879, 4390.275604525282, 4396.406485124499, 4445.244308467568, 4560.931586026212, 4573.176828170928, 103315.48342258316, 105353.99999999923, 106915.0, 107608.0, 107614.99999999921, 9283.25733941283, 10679.626213082505, 10902.454877256105, 10904.727381815359, 11095.667129986114, 21262.574748504943, 21474.14103435845, 21832.45418864541, 21926.89036554807, 21959.451013724785, 7700.730474433368, 7740.651670674833, 7752.147263800977, 7823.4523583349755, 8009.0, 4199.70602057853, 4286.5284818669925, 4289.871303860889, 4327.632151267115, 4449.998750281161, 3384.4415671414436, 3444.621091679913, 3487.0, 3491.284286721216, 3501.229729459515, 628.9496840252768, 632.9208848893888, 634.1122428599997, 645.1322970604623, 650.4731167754135, 518.9610779191576, 520.8906129712802, 541.7670401727295, 583.9722089123173, 610.9450149486479, 7994.880076798852, 8429.662813487514, 9029.0, 9163.58763855628, 9375.62497500106, 560.2408437506234, 569.1207085053519, 597.7967491053063, 610.6946526736632, 616.1281786272464, 4283.571642835754, 4447.755373454491, 4470.155140678419, 4579.0, 4676.672632915664, 77729.0, 91779.54110229407, 93061.0, 96291.55562666565, 103172.0, 85151.14848851557, 88585.55707221423, 91063.0, 91485.0, 91730.0826991735, 80120.59939700265, 82117.0, 83029.58485207656, 83338.333233335, 84724.0, 9800.059388300619, 9834.950825245827, 9864.309498335047, 9996.900030999597, 10015.24885633595, 46643.766781165876, 50343.0, 51517.227241590655, 53873.461265386846, 54232.746035238015, 66536.33463665302, 66593.66703166453, 70393.0, 72050.55898882098, 73853.0, 13150.408231629408, 13196.868031319564, 13354.465821367037, 13387.263700496565, 13691.794623080463, 12155.392230388623, 14787.556373308387, 15040.721538669335, 15396.84603153999, 15644.374225031326, 13354.532591359255, 13505.527306544223, 13601.727965440437, 14108.506202282872, 14312.284385780462, 11185.776284474428, 13494.257815820225, 13812.723745525234, 14361.281935902955, 14365.20991345486, 13524.256165910969, 13634.1137826041, 13721.45114195421, 14157.221352825281, 14349.64125896861, 10623.203259755704, 11039.613613523488, 11052.668419947415, 11116.277441966246, 11327.093832493545, 11234.887651123385, 11310.60412885545, 11321.943390282995, 11355.943220283845, 11464.885351146382], "value": 7425.006051287731, "unit": "score"}], "name": "dromaeo_css", "value": 7055.711738017337, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0, 116.0, 158.0], "value": 117.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 112.0, 172.0, 132.0, 137.0, 110.0, 108.0, 126.0, 137.0], "value": 128.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 186.0, 183.0, 182.0, 185.0, 180.0, 182.0, 183.0, 186.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 60.0, 87.0, 59.0, 62.0, 60.0, 57.0, 74.0, 57.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 85.0, 68.0, 70.0, 68.0, 82.0, 68.0, 67.0, 85.0], "value": 74.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 89.0, 86.0, 91.0, 85.0, 88.0, 88.0, 90.0, 86.0], "value": 87.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 98.0, 96.0, 95.0, 95.0, 97.0, 95.0, 101.0], "value": 96.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 86.0, 87.0, 85.0, 89.0, 84.0, 88.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 53.0, 55.0, 56.0, 56.0, 55.0, 57.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 77.0, 76.0, 76.0, 73.0, 67.0, 69.0, 71.0, 69.0, 75.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 90.0, 86.0, 85.0, 85.0, 84.0, 85.0, 92.0, 88.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 148.0, 145.0, 159.0, 146.0, 149.0, 148.0, 139.0, 183.0, 150.0], "value": 151.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 193.0, 216.0, 186.0, 172.0, 172.0, 172.0, 170.0, 173.0, 171.0], "value": 179.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 68.0, 67.0, 68.0, 66.0, 67.0, 67.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1451.2, "alertThreshold": 2.0}]} 18:00:51 INFO - Return code: 0 18:00:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:00:51 INFO - # TBPL SUCCESS # 18:00:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:00:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:00:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:00:51 INFO - 2016-12-21 18:00:51.953 screenresolution[1674:10907] starting screenresolution argv=screenresolution get 18:00:51 INFO - 2016-12-21 18:00:51.957 screenresolution[1674:10907] Display 0: 1600x1200x32@60 18:00:51 INFO - 2016-12-21 18:00:51.964 screenresolution[1675:10910] starting screenresolution argv=screenresolution list 18:00:51 INFO - Available Modes on Display 0 18:00:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:00:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:00:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:00:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:00:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:00:52 INFO - Intel Iris: 18:00:52 INFO - Chipset Model: Intel Iris 18:00:52 INFO - Type: GPU 18:00:52 INFO - Bus: Built-In 18:00:52 INFO - VRAM (Dynamic, Max): 1536 MB 18:00:52 INFO - Vendor: Intel (0x8086) 18:00:52 INFO - Device ID: 0x0a2e 18:00:52 INFO - Revision ID: 0x0009 18:00:52 INFO - Displays: 18:00:52 INFO - Display: 18:00:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:00:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:00:52 INFO - Display Serial Number: 1600x1200 60 18:00:52 INFO - Main Display: Yes 18:00:52 INFO - Mirror: Off 18:00:52 INFO - Online: Yes 18:00:52 INFO - Rotation: Supported 18:00:52 INFO - Return code: 0 18:00:52 INFO - Running post-action listener: _resource_record_post_action 18:00:52 INFO - [mozharness: 2016-12-22 02:00:52.212114Z] Finished run-tests step (success) 18:00:52 INFO - Running post-run listener: _resource_record_post_run 18:00:52 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 31235072; Write bytes: 553221632; Read time: 196; Write time: 1665 18:00:52 INFO - TinderboxPrint: CPU usage
53.7% 18:00:52 INFO - TinderboxPrint: I/O read bytes / time
31,235,072 / 196 18:00:52 INFO - TinderboxPrint: I/O write bytes / time
553,221,632 / 1,665 18:00:52 INFO - TinderboxPrint: CPU idle
2,228.1 (46.3%) 18:00:52 INFO - TinderboxPrint: CPU system
955.8 (19.9%) 18:00:52 INFO - TinderboxPrint: CPU user
1,625.9 (33.8%) 18:00:52 INFO - TinderboxPrint: Swap in / out
277,684,224 / 0 18:00:52 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 239393280; Write bytes: 234915840; Read time: 17505; Write time: 498 18:00:52 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 29338624; Write bytes: 298677760; Read time: 180; Write time: 1118 18:00:52 INFO - Running post-run listener: _upload_blobber_files 18:00:52 INFO - Blob upload gear active. 18:00:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:00:52 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 18:00:52 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'] 18:00:52 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 18:00:53 INFO - (blobuploader) - INFO - Open directory for files ... 18:00:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:00:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:00:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:00:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:00:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:00:54 INFO - (blobuploader) - INFO - Done attempting. 18:00:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:00:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:00:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:00:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:00:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:00:55 INFO - (blobuploader) - INFO - Done attempting. 18:00:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:00:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:00:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:00:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:00:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:00:56 INFO - (blobuploader) - INFO - Done attempting. 18:00:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:00:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:00:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:00:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:00:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:00:58 INFO - (blobuploader) - INFO - Done attempting. 18:00:58 INFO - (blobuploader) - INFO - Iteration through files over. 18:00:58 INFO - Return code: 0 18:00:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:00:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:00:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4fc715d2d740869f4a251328863f291869e81145c57694b037a0d1d041ad909ab2e0d99d2e9c355edabe07066150ee6976643c212a169f4ca98602ca15a2fc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bf29d02d3301e4d90abf77a610d59137d35b2936b80f6e1b22f4398989736192811264426c2746e3a96bdd3c570c88314dad501bdf96b80d2a7ca5390802597", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39f592640d9384a18a34542f2a84bf03d5eac58af72022d89a0e7c5d826aa38f937d1160f0e21f89b9ca02aa5ac67ab322afd61f5608e8682cae00ab7b5522c8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c2ea9f7f250859c295a95ffc1f66d9876447f07518efc4e0808c5ad09e910a833ec47bafea5ef1775f1460008ed9e8da2cf759bee5765c7b9b161eb65466b26"} 18:00:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:00:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:00:58 INFO - Contents: 18:00:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4fc715d2d740869f4a251328863f291869e81145c57694b037a0d1d041ad909ab2e0d99d2e9c355edabe07066150ee6976643c212a169f4ca98602ca15a2fc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bf29d02d3301e4d90abf77a610d59137d35b2936b80f6e1b22f4398989736192811264426c2746e3a96bdd3c570c88314dad501bdf96b80d2a7ca5390802597", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39f592640d9384a18a34542f2a84bf03d5eac58af72022d89a0e7c5d826aa38f937d1160f0e21f89b9ca02aa5ac67ab322afd61f5608e8682cae00ab7b5522c8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c2ea9f7f250859c295a95ffc1f66d9876447f07518efc4e0808c5ad09e910a833ec47bafea5ef1775f1460008ed9e8da2cf759bee5765c7b9b161eb65466b26"} 18:00:58 INFO - Running post-run listener: copy_logs_to_upload_dir 18:00:58 INFO - Copying logs to upload dir... 18:00:58 INFO - mkdir: /builds/slave/test/build/upload/logs 18:00:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.176745 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-12-21 18:00:58.864295) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 18:00:58.868429) ========= 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.vVrUzExWMc/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.BCfuo8ppxM/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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/a4fc715d2d740869f4a251328863f291869e81145c57694b037a0d1d041ad909ab2e0d99d2e9c355edabe07066150ee6976643c212a169f4ca98602ca15a2fc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bf29d02d3301e4d90abf77a610d59137d35b2936b80f6e1b22f4398989736192811264426c2746e3a96bdd3c570c88314dad501bdf96b80d2a7ca5390802597", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39f592640d9384a18a34542f2a84bf03d5eac58af72022d89a0e7c5d826aa38f937d1160f0e21f89b9ca02aa5ac67ab322afd61f5608e8682cae00ab7b5522c8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c2ea9f7f250859c295a95ffc1f66d9876447f07518efc4e0808c5ad09e910a833ec47bafea5ef1775f1460008ed9e8da2cf759bee5765c7b9b161eb65466b26"} build_url:https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010978 build_url: 'https://queue.taskcluster.net/v1/task/AwtP1ACgQjCaTTnHpG2djg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4fc715d2d740869f4a251328863f291869e81145c57694b037a0d1d041ad909ab2e0d99d2e9c355edabe07066150ee6976643c212a169f4ca98602ca15a2fc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bf29d02d3301e4d90abf77a610d59137d35b2936b80f6e1b22f4398989736192811264426c2746e3a96bdd3c570c88314dad501bdf96b80d2a7ca5390802597", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39f592640d9384a18a34542f2a84bf03d5eac58af72022d89a0e7c5d826aa38f937d1160f0e21f89b9ca02aa5ac67ab322afd61f5608e8682cae00ab7b5522c8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c2ea9f7f250859c295a95ffc1f66d9876447f07518efc4e0808c5ad09e910a833ec47bafea5ef1775f1460008ed9e8da2cf759bee5765c7b9b161eb65466b26"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 18:00:58.902877) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 18:00:58.903204) ========= 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.vVrUzExWMc/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.BCfuo8ppxM/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.005084 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 18:00:58.951677) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 18:00:58.951996) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 18:00:58.952312) ========= ========= Total master_lag: 0.18 =========