builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0223 starttime: 1480429489.36 results: success (0) buildid: 20161129030222 builduid: bc89033538dd4d76a5cd6a607395a896 revision: f8107cf961444a8d7fdc2c0f446238af9893f875 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 06:24:49.363334) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 06:24:49.363846) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 06:24:49.364120) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 06:24:49.390988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 06:24:49.391356) ========= 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.kSVDu3HSpY/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.7Jyba4I2Ct/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-29 06:24:49-- 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% 171M=0s 2016-11-29 06:24:49 (171 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108210 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 06:24:49.523664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 06:24:49.524005) ========= 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.kSVDu3HSpY/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.7Jyba4I2Ct/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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.024239 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 06:24:49.574484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 06:24:49.575248) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f8107cf961444a8d7fdc2c0f446238af9893f875 --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 f8107cf961444a8d7fdc2c0f446238af9893f875 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kSVDu3HSpY/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.7Jyba4I2Ct/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-29 06:24:49,675 truncating revision to first 12 chars 2016-11-29 06:24:49,675 Setting DEBUG logging. 2016-11-29 06:24:49,675 attempt 1/10 2016-11-29 06:24:49,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f8107cf96144?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 06:24:50,475 unpacking tar archive at: mozilla-central-f8107cf96144/testing/mozharness/ program finished with exit code 0 elapsedTime=1.056830 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 06:24:50.667380) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 06:24:50.667684) ========= script_repo_revision: f8107cf961444a8d7fdc2c0f446238af9893f875 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 06:24:50.668062) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 06:24:50.668325) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 06:24:50.692900) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-11-29 06:24:50.693223) ========= /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.kSVDu3HSpY/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.7Jyba4I2Ct/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 06:24:50 INFO - MultiFileLogger online at 20161129 06:24:50 in /builds/slave/test 06:24:50 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 06:24:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:24:50 INFO - {'append_to_log': False, 06:24:50 INFO - 'base_work_dir': '/builds/slave/test', 06:24:50 INFO - 'blob_upload_branch': 'Firefox', 06:24:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:24:50 INFO - 'branch': 'Firefox', 06:24:50 INFO - 'buildbot_json_path': 'buildprops.json', 06:24:50 INFO - 'config_files': ('talos/mac_config.py',), 06:24:50 INFO - 'default_actions': ('clobber', 06:24:50 INFO - 'read-buildbot-config', 06:24:50 INFO - 'download-and-extract', 06:24:50 INFO - 'populate-webroot', 06:24:50 INFO - 'create-virtualenv', 06:24:50 INFO - 'install', 06:24:50 INFO - 'run-tests'), 06:24:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:24:50 INFO - 'download_minidump_stackwalk': True, 06:24:50 INFO - 'download_symbols': 'ondemand', 06:24:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:24:50 INFO - 'tooltool.py': '/tools/tooltool.py', 06:24:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:24:50 INFO - '/tools/misc-python/virtualenv.py')}, 06:24:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:24:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:24:50 INFO - 'installer_path': 'installer.exe', 06:24:50 INFO - 'log_level': 'info', 06:24:50 INFO - 'log_name': 'talos', 06:24:50 INFO - 'log_to_console': True, 06:24:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:24:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:24:50 INFO - 'opt_config_files': (), 06:24:50 INFO - 'pip_index': False, 06:24:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:24:50 INFO - 'cmd': ('bash', 06:24:50 INFO - '-c', 06:24:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:24:50 INFO - 'enabled': True, 06:24:50 INFO - 'halt_on_failure': False, 06:24:50 INFO - 'name': 'check_screen_resolution'},), 06:24:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:24:50 INFO - 'cmd': ('bash', 06:24:50 INFO - '-c', 06:24:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:24:50 INFO - 'enabled': True, 06:24:50 INFO - 'halt_on_failure': False, 06:24:50 INFO - 'name': 'check_screen_resolution'},), 06:24:50 INFO - 'run_cmd_checks_enabled': True, 06:24:50 INFO - 'sps_profile': False, 06:24:50 INFO - 'sps_profile_interval': 0, 06:24:50 INFO - 'suite': 'dromaeojs', 06:24:50 INFO - 'system_bits': '32', 06:24:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:24:50 INFO - 'title': 't-yosemite-r7-0223', 06:24:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:24:50 INFO - 'use_talos_json': True, 06:24:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:24:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:24:50 INFO - 'work_dir': 'build'} 06:24:50 INFO - [mozharness: 2016-11-29 14:24:50.897631Z] Running clobber step. 06:24:50 INFO - Running pre-action listener: _resource_record_pre_action 06:24:50 INFO - Running main action method: clobber 06:24:50 INFO - rmtree: /builds/slave/test/build 06:24:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:24:53 INFO - Running post-action listener: _resource_record_post_action 06:24:53 INFO - [mozharness: 2016-11-29 14:24:53.568839Z] Finished clobber step (success) 06:24:53 INFO - [mozharness: 2016-11-29 14:24:53.568967Z] Running read-buildbot-config step. 06:24:53 INFO - Running pre-action listener: _resource_record_pre_action 06:24:53 INFO - Running main action method: read_buildbot_config 06:24:53 INFO - Using buildbot properties: 06:24:53 INFO - { 06:24:53 INFO - "project": "", 06:24:53 INFO - "product": "firefox", 06:24:53 INFO - "script_repo_revision": "production", 06:24:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:24:53 INFO - "repository": "", 06:24:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:24:53 INFO - "buildid": "20161129030222", 06:24:53 INFO - "stage_platform": "macosx64", 06:24:53 INFO - "basedir": "/builds/slave/test", 06:24:53 INFO - "nightly_build": "True", 06:24:53 INFO - "buildnumber": 3, 06:24:53 INFO - "slavename": "t-yosemite-r7-0223", 06:24:53 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:24:53 INFO - "platform": "yosemite_r7", 06:24:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:24:53 INFO - "branch": "mozilla-central", 06:24:53 INFO - "repo_path": "mozilla-central", 06:24:53 INFO - "revision": "f8107cf961444a8d7fdc2c0f446238af9893f875", 06:24:53 INFO - "pgo_build": "False", 06:24:53 INFO - "builduid": "bc89033538dd4d76a5cd6a607395a896", 06:24:53 INFO - "slavebuilddir": "test" 06:24:53 INFO - } 06:24:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 06:24:53 INFO - Running post-action listener: _resource_record_post_action 06:24:53 INFO - [mozharness: 2016-11-29 14:24:53.572337Z] Finished read-buildbot-config step (success) 06:24:53 INFO - [mozharness: 2016-11-29 14:24:53.572424Z] Running download-and-extract step. 06:24:53 INFO - Running pre-action listener: _resource_record_pre_action 06:24:53 INFO - Running main action method: download_and_extract 06:24:53 INFO - mkdir: /builds/slave/test/build/tests 06:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:53 INFO - trying https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 06:24:53 INFO - Downloading https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/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 06:24:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/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 06:24:54 INFO - Downloaded 1199 bytes. 06:24:54 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 06:24:54 INFO - Using the following test package requirements: 06:24:54 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 06:24:54 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:24:54 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 06:24:54 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:24:54 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 06:24:54 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:24:54 INFO - u'jsshell-mac.zip'], 06:24:54 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:24:54 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 06:24:54 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 06:24:54 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:24:54 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 06:24:54 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:24:54 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 06:24:54 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:24:54 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 06:24:54 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:24:54 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 06:24:54 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:24:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 06:24:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:24:54 INFO - Fetch https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 06:24:55 INFO - Http code: 200 06:24:55 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 06:24:55 INFO - x-amz-cf-id: c_G65DLdSuNNgzOiy16Vw6FV2McspC4BftQLS5yT3-9eyE3zcIWTGA== 06:24:55 INFO - x-amz-version-id: mKaXAMhoB.d_UKUk18R6UJya6l2qO7YN 06:24:55 INFO - Expected file size: 16284943 06:24:55 INFO - Obtained file size: 16284943 06:25:02 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 06:25:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 06:25:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:25:02 INFO - Fetch https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 06:25:02 INFO - Http code: 200 06:25:02 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 06:25:02 INFO - x-amz-cf-id: HXNjnvH2MTJ4jD6j2-wmuIvLFi0WUawsn5PvB6YwtzMlZxbMZuC8og== 06:25:02 INFO - x-amz-version-id: mKaXAMhoB.d_UKUk18R6UJya6l2qO7YN 06:25:03 INFO - Expected file size: 16284943 06:25:03 INFO - Obtained file size: 16284943 06:25:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 06:25:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:25:09 INFO - Fetch https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 06:25:10 INFO - Http code: 200 06:25:10 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 06:25:10 INFO - x-amz-cf-id: -bJlOFepNJbRmLap-1iZ655LqltV8mImG6xyvvdpsgXTXjyTSPRydQ== 06:25:10 INFO - x-amz-version-id: sr80JKp75alrPSvC.2LHQAEoq7F3pUH4 06:25:11 INFO - Expected file size: 14409702 06:25:11 INFO - Obtained file size: 14409702 06:25:11 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')]} 06:25:11 INFO - trying https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:25:11 INFO - Downloading https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 06:25:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/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 06:25:14 INFO - Downloaded 107718638 bytes. 06:25:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:25:14 INFO - mkdir: /builds/slave/test/properties 06:25:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:25:14 INFO - Writing to file /builds/slave/test/properties/build_url 06:25:14 INFO - Contents: 06:25:14 INFO - build_url:https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:25:15 INFO - Running post-action listener: _resource_record_post_action 06:25:15 INFO - Running post-action listener: set_extra_try_arguments 06:25:15 INFO - [mozharness: 2016-11-29 14:25:15.645828Z] Finished download-and-extract step (success) 06:25:15 INFO - [mozharness: 2016-11-29 14:25:15.645942Z] Running populate-webroot step. 06:25:15 INFO - Running pre-action listener: _resource_record_pre_action 06:25:15 INFO - Running main action method: populate_webroot 06:25:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:25:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:25:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:25:15 INFO - '--tppagecycles', 06:25:15 INFO - '7'], 06:25:15 INFO - 'tests': ['tsvgm']}}, 06:25:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:25:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:25:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:25:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:25:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:25:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:25:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:25:15 INFO - 'talos_options': ['--disable-e10s'], 06:25:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:25:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:25:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:25:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:25:15 INFO - 'talos_options': ['--disable-e10s'], 06:25:15 INFO - 'tests': ['damp', 'tps']}, 06:25:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:25:15 INFO - 'tests': ['damp', 'tps']}, 06:25:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:25:15 INFO - 'tests': ['dromaeo_dom']}, 06:25:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:25:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:25:15 INFO - 'tests': ['basic_compositor_video']}, 06:25:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:25:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:25:15 INFO - 'tests': ['a11yr', 06:25:15 INFO - 'ts_paint', 06:25:15 INFO - 'tpaint', 06:25:15 INFO - 'sessionrestore', 06:25:15 INFO - 'sessionrestore_no_auto_restore', 06:25:15 INFO - 'tabpaint']}, 06:25:15 INFO - 'other-e10s': {'tests': ['a11yr', 06:25:15 INFO - 'ts_paint', 06:25:15 INFO - 'tpaint', 06:25:15 INFO - 'sessionrestore', 06:25:15 INFO - 'sessionrestore_no_auto_restore', 06:25:15 INFO - 'tabpaint']}, 06:25:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:25:15 INFO - 'ts_paint', 06:25:15 INFO - 'tpaint', 06:25:15 INFO - 'sessionrestore', 06:25:15 INFO - 'sessionrestore_no_auto_restore', 06:25:15 INFO - 'tabpaint']}, 06:25:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:25:15 INFO - 'ts_paint', 06:25:15 INFO - 'tpaint', 06:25:15 INFO - 'sessionrestore', 06:25:15 INFO - 'sessionrestore_no_auto_restore', 06:25:15 INFO - 'tabpaint']}, 06:25:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:25:15 INFO - 'tests': ['a11yr', 06:25:15 INFO - 'ts_paint', 06:25:15 INFO - 'tpaint', 06:25:15 INFO - 'sessionrestore', 06:25:15 INFO - 'sessionrestore_no_auto_restore', 06:25:15 INFO - 'tabpaint']}, 06:25:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:25:15 INFO - 'tests': ['a11yr', 06:25:15 INFO - 'ts_paint', 06:25:15 INFO - 'tpaint', 06:25:15 INFO - 'sessionrestore', 06:25:15 INFO - 'sessionrestore_no_auto_restore', 06:25:15 INFO - 'tabpaint']}, 06:25:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:25:15 INFO - 'tests': ['tsvgx', 06:25:15 INFO - 'tsvgr_opacity', 06:25:15 INFO - 'tart', 06:25:15 INFO - 'tscrollx', 06:25:15 INFO - 'cart', 06:25:15 INFO - 'tsvg_static']}, 06:25:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:25:15 INFO - 'tsvgr_opacity', 06:25:15 INFO - 'tart', 06:25:15 INFO - 'tscrollx', 06:25:15 INFO - 'cart', 06:25:15 INFO - 'tsvg_static']}, 06:25:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:25:15 INFO - 'talos_options': ['--disable-e10s'], 06:25:15 INFO - 'tests': ['tp5o']}, 06:25:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:25:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:25:15 INFO - 'talos_options': ['--disable-e10s', 06:25:15 INFO - '--xperf_path', 06:25:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:25:15 INFO - 'tests': ['tp5n']}, 06:25:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:25:15 INFO - 'talos_options': ['--xperf_path', 06:25:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:25:15 INFO - 'tests': ['tp5n']}}, 06:25:15 INFO - 'talos.zip': {'path': '', 06:25:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:25:15 INFO - Running post-action listener: _resource_record_post_action 06:25:15 INFO - [mozharness: 2016-11-29 14:25:15.664273Z] Finished populate-webroot step (success) 06:25:15 INFO - [mozharness: 2016-11-29 14:25:15.664383Z] Running create-virtualenv step. 06:25:15 INFO - Running pre-action listener: _resource_record_pre_action 06:25:15 INFO - Running main action method: create_virtualenv 06:25:15 INFO - Creating virtualenv /builds/slave/test/build/venv 06:25:15 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 06:25:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:25:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:25:15 INFO - Using real prefix '/tools/python27' 06:25:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:25:16 INFO - Installing distribute.............................................................................................................................................................................................done. 06:25:19 INFO - Installing pip.................done. 06:25:19 INFO - Return code: 0 06:25:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:25:19 INFO - Reading from file tmpfile_stdout 06:25:19 INFO - Output received: 06:25:19 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) 06:25:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cae03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca56570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc89b473550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f6d30>, '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 0x10c75ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8eeb20>, '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.kSVDu3HSpY/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.7Jyba4I2Ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 06:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:25:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kSVDu3HSpY/Render', 06:25:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:19 INFO - 'HOME': '/Users/cltbld', 06:25:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:19 INFO - 'LOGNAME': 'cltbld', 06:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:19 INFO - 'MOZ_NO_REMOTE': '1', 06:25:19 INFO - 'NO_EM_RESTART': '1', 06:25:19 INFO - 'PAGER': '/bin/cat', 06:25:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:19 INFO - 'PWD': '/builds/slave/test', 06:25:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:19 INFO - 'SHELL': '/bin/bash', 06:25:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Jyba4I2Ct/Listeners', 06:25:19 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 06:25:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:19 INFO - 'USER': 'cltbld', 06:25:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:19 INFO - 'XPC_FLAGS': '0x0', 06:25:19 INFO - 'XPC_SERVICE_NAME': '0', 06:25:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:19 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 06:25:19 INFO - Cleaning up... 06:25:19 INFO - Return code: 0 06:25:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cae03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca56570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc89b473550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f6d30>, '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 0x10c75ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8eeb20>, '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.kSVDu3HSpY/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.7Jyba4I2Ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 06:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:25:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kSVDu3HSpY/Render', 06:25:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:19 INFO - 'HOME': '/Users/cltbld', 06:25:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:19 INFO - 'LOGNAME': 'cltbld', 06:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:19 INFO - 'MOZ_NO_REMOTE': '1', 06:25:19 INFO - 'NO_EM_RESTART': '1', 06:25:19 INFO - 'PAGER': '/bin/cat', 06:25:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:19 INFO - 'PWD': '/builds/slave/test', 06:25:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:19 INFO - 'SHELL': '/bin/bash', 06:25:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Jyba4I2Ct/Listeners', 06:25:19 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 06:25:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:19 INFO - 'USER': 'cltbld', 06:25:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:19 INFO - 'XPC_FLAGS': '0x0', 06:25:19 INFO - 'XPC_SERVICE_NAME': '0', 06:25:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:20 INFO - Downloading/unpacking psutil>=3.1.1 06:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:25:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:25:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:25:24 INFO - Installing collected packages: psutil 06:25:24 INFO - Running setup.py install for psutil 06:25:24 INFO - building 'psutil._psutil_osx' extension 06:25:24 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 06:25:24 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 06:25:24 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 06:25:24 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 06:25:24 INFO - building 'psutil._psutil_posix' extension 06:25:24 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 06:25:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:25:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:25:24 INFO - ^ 06:25:24 INFO - 1 warning generated. 06:25:24 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 06:25:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:25:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:25:25 INFO - Successfully installed psutil 06:25:25 INFO - Cleaning up... 06:25:25 INFO - Return code: 0 06:25:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:25:25 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')]} 06:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:25 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')]} 06:25:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:25 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 0x10cae03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca56570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc89b473550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f6d30>, '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 0x10c75ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8eeb20>, '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.kSVDu3HSpY/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.7Jyba4I2Ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 06:25:25 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 06:25:25 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 06:25:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kSVDu3HSpY/Render', 06:25:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:25 INFO - 'HOME': '/Users/cltbld', 06:25:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:25 INFO - 'LOGNAME': 'cltbld', 06:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:25 INFO - 'MOZ_NO_REMOTE': '1', 06:25:25 INFO - 'NO_EM_RESTART': '1', 06:25:25 INFO - 'PAGER': '/bin/cat', 06:25:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:25 INFO - 'PWD': '/builds/slave/test', 06:25:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:25 INFO - 'SHELL': '/bin/bash', 06:25:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Jyba4I2Ct/Listeners', 06:25:25 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 06:25:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:25 INFO - 'USER': 'cltbld', 06:25:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:25 INFO - 'XPC_FLAGS': '0x0', 06:25:25 INFO - 'XPC_SERVICE_NAME': '0', 06:25:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:25:25 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 06:25:25 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 06:25:25 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 06:25:25 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 06:25:25 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 06:25:25 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 06:25:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:25:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:25:28 INFO - Installing collected packages: mozsystemmonitor 06:25:28 INFO - Running setup.py install for mozsystemmonitor 06:25:28 INFO - Successfully installed mozsystemmonitor 06:25:28 INFO - Cleaning up... 06:25:28 INFO - Return code: 0 06:25:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cae03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca56570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc89b473550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f6d30>, '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 0x10c75ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8eeb20>, '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.kSVDu3HSpY/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.7Jyba4I2Ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 06:25:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:25:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kSVDu3HSpY/Render', 06:25:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:28 INFO - 'HOME': '/Users/cltbld', 06:25:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:28 INFO - 'LOGNAME': 'cltbld', 06:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:28 INFO - 'MOZ_NO_REMOTE': '1', 06:25:28 INFO - 'NO_EM_RESTART': '1', 06:25:28 INFO - 'PAGER': '/bin/cat', 06:25:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:28 INFO - 'PWD': '/builds/slave/test', 06:25:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:28 INFO - 'SHELL': '/bin/bash', 06:25:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Jyba4I2Ct/Listeners', 06:25:28 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 06:25:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:28 INFO - 'USER': 'cltbld', 06:25:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:28 INFO - 'XPC_FLAGS': '0x0', 06:25:28 INFO - 'XPC_SERVICE_NAME': '0', 06:25:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:28 INFO - Downloading/unpacking jsonschema==2.5.1 06:25:28 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 06:25:28 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 06:25:28 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 06:25:28 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 06:25:28 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 06:25:28 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 06:25:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:25:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:25:31 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 06:25:31 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 06:25:31 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 06:25:31 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 06:25:31 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 06:25:31 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 06:25:31 INFO - Downloading functools32-3.2.3-2.tar.gz 06:25:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:25:31 INFO - warning: no files found matching '*.txt' 06:25:31 INFO - no previously-included directories found matching 'build' 06:25:31 INFO - no previously-included directories found matching 'dist' 06:25:31 INFO - no previously-included directories found matching '.git*' 06:25:31 INFO - Installing collected packages: jsonschema, functools32 06:25:31 INFO - Running setup.py install for functools32 06:25:31 INFO - warning: no files found matching '*.txt' 06:25:31 INFO - no previously-included directories found matching 'build' 06:25:31 INFO - no previously-included directories found matching 'dist' 06:25:31 INFO - no previously-included directories found matching '.git*' 06:25:31 INFO - Successfully installed jsonschema functools32 06:25:31 INFO - Cleaning up... 06:25:32 INFO - Return code: 0 06:25:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:25:32 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')]} 06:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:32 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')]} 06:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:32 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 0x10cae03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca56570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc89b473550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f6d30>, '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 0x10c75ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8eeb20>, '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.kSVDu3HSpY/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.7Jyba4I2Ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 06:25:32 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 06:25:32 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 06:25:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kSVDu3HSpY/Render', 06:25:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:32 INFO - 'HOME': '/Users/cltbld', 06:25:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:32 INFO - 'LOGNAME': 'cltbld', 06:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:32 INFO - 'MOZ_NO_REMOTE': '1', 06:25:32 INFO - 'NO_EM_RESTART': '1', 06:25:32 INFO - 'PAGER': '/bin/cat', 06:25:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:32 INFO - 'PWD': '/builds/slave/test', 06:25:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:32 INFO - 'SHELL': '/bin/bash', 06:25:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Jyba4I2Ct/Listeners', 06:25:32 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 06:25:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:32 INFO - 'USER': 'cltbld', 06:25:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:32 INFO - 'XPC_FLAGS': '0x0', 06:25:32 INFO - 'XPC_SERVICE_NAME': '0', 06:25:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:25:32 INFO - Cleaning up... 06:25:32 INFO - Return code: 0 06:25:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:25:32 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')]} 06:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:32 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')]} 06:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:32 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 0x10cae03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca56570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc89b473550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f6d30>, '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 0x10c75ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8eeb20>, '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.kSVDu3HSpY/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.7Jyba4I2Ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 06:25:32 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 06:25:32 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 06:25:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kSVDu3HSpY/Render', 06:25:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:32 INFO - 'HOME': '/Users/cltbld', 06:25:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:32 INFO - 'LOGNAME': 'cltbld', 06:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:32 INFO - 'MOZ_NO_REMOTE': '1', 06:25:32 INFO - 'NO_EM_RESTART': '1', 06:25:32 INFO - 'PAGER': '/bin/cat', 06:25:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:32 INFO - 'PWD': '/builds/slave/test', 06:25:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:32 INFO - 'SHELL': '/bin/bash', 06:25:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Jyba4I2Ct/Listeners', 06:25:32 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 06:25:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:32 INFO - 'USER': 'cltbld', 06:25:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:32 INFO - 'XPC_FLAGS': '0x0', 06:25:32 INFO - 'XPC_SERVICE_NAME': '0', 06:25:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:32 INFO - Downloading/unpacking blobuploader==1.2.4 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25:35 INFO - Downloading blobuploader-1.2.4.tar.gz 06:25:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:25:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:25:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:36 INFO - Downloading docopt-0.6.1.tar.gz 06:25:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:25:36 INFO - Installing collected packages: blobuploader, requests, docopt 06:25:36 INFO - Running setup.py install for blobuploader 06:25:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:25:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:25:36 INFO - Running setup.py install for requests 06:25:37 INFO - Running setup.py install for docopt 06:25:37 INFO - Successfully installed blobuploader requests docopt 06:25:37 INFO - Cleaning up... 06:25:37 INFO - Return code: 0 06:25:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:37 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 0x10cae03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca56570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc89b473550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f6d30>, '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 0x10c75ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8eeb20>, '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.kSVDu3HSpY/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.7Jyba4I2Ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 06:25:37 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 06:25:37 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 06:25:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kSVDu3HSpY/Render', 06:25:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:37 INFO - 'HOME': '/Users/cltbld', 06:25:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:37 INFO - 'LOGNAME': 'cltbld', 06:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:37 INFO - 'MOZ_NO_REMOTE': '1', 06:25:37 INFO - 'NO_EM_RESTART': '1', 06:25:37 INFO - 'PAGER': '/bin/cat', 06:25:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:37 INFO - 'PWD': '/builds/slave/test', 06:25:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:37 INFO - 'SHELL': '/bin/bash', 06:25:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Jyba4I2Ct/Listeners', 06:25:37 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 06:25:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:37 INFO - 'USER': 'cltbld', 06:25:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:37 INFO - 'XPC_FLAGS': '0x0', 06:25:37 INFO - 'XPC_SERVICE_NAME': '0', 06:25:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:25:37 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-9Y84ER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:25:37 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-vDLWCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:25:37 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-KQG21O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:25:37 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-yhrvxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:25:37 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-tewQnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:25:38 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-dgEu8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:25:38 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-k5aOv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:25:38 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-1FBYWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:25:38 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-eQeoZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:25:38 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-_GZpAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:25:38 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-b2pGCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:25:38 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-H0gx5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:25:38 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-AbKdPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:25:38 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-NUi7mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:39 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-2l2KEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:25:39 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-uQ8HNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:25:39 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-SKXFlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:25:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:25:39 INFO - Running setup.py install for manifestparser 06:25:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:25:39 INFO - Running setup.py install for mozcrash 06:25:39 INFO - Running setup.py install for mozdebug 06:25:39 INFO - Running setup.py install for mozdevice 06:25:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:25:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:25:39 INFO - Running setup.py install for mozfile 06:25:40 INFO - Running setup.py install for mozhttpd 06:25:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:25:40 INFO - Running setup.py install for mozinfo 06:25:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:25:40 INFO - Running setup.py install for mozInstall 06:25:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:25:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:25:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:25:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:25:40 INFO - Running setup.py install for mozleak 06:25:40 INFO - Running setup.py install for mozlog 06:25:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:25:40 INFO - Running setup.py install for moznetwork 06:25:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:25:40 INFO - Running setup.py install for mozprocess 06:25:41 INFO - Running setup.py install for mozprofile 06:25:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:25:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:25:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:25:41 INFO - Running setup.py install for mozrunner 06:25:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:25:41 INFO - Running setup.py install for mozscreenshot 06:25:41 INFO - Running setup.py install for moztest 06:25:41 INFO - Running setup.py install for mozversion 06:25:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:25:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:25:41 INFO - Cleaning up... 06:25:41 INFO - Return code: 0 06:25:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:41 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 0x10cae03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca56570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc89b473550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f6d30>, '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 0x10c75ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8eeb20>, '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.kSVDu3HSpY/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.7Jyba4I2Ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 06:25:41 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 06:25:41 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 06:25:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kSVDu3HSpY/Render', 06:25:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:41 INFO - 'HOME': '/Users/cltbld', 06:25:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:41 INFO - 'LOGNAME': 'cltbld', 06:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:41 INFO - 'MOZ_NO_REMOTE': '1', 06:25:41 INFO - 'NO_EM_RESTART': '1', 06:25:41 INFO - 'PAGER': '/bin/cat', 06:25:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:41 INFO - 'PWD': '/builds/slave/test', 06:25:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:41 INFO - 'SHELL': '/bin/bash', 06:25:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Jyba4I2Ct/Listeners', 06:25:41 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 06:25:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:41 INFO - 'USER': 'cltbld', 06:25:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:41 INFO - 'XPC_FLAGS': '0x0', 06:25:41 INFO - 'XPC_SERVICE_NAME': '0', 06:25:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:25:42 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-ZIMSmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:25:42 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)) 06:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:25:42 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-4GVvXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:25:42 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)) 06:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:25:42 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-Yvv66m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:25:42 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)) 06:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:25:42 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-B3K7fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:25:42 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)) 06:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:25:42 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-Ckvw4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:25:42 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)) 06:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:25:42 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-0fDEUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:25:42 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)) 06:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:25:42 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-a2lNjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:25:42 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)) 06:25:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:25:42 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-p6Y1YZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:25:43 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)) 06:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:25:43 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-Kk6R9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:25:43 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)) 06:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:25:43 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-i_BfVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:25:43 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)) 06:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:25:43 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-PtoPp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:25:43 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)) 06:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:25:43 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-eWrcYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:25:43 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)) 06:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:25:43 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-gBwYis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:25:43 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)) 06:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:25:43 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-YiviM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:25:43 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)) 06:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:43 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-T7cNzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:43 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)) 06:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:25:43 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-lwC3_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:25:43 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)) 06:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:25:43 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-NiVqvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:25:43 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)) 06:25:43 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)) 06:25:43 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)) 06:25:43 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)) 06:25:43 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)) 06:25:43 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)) 06:25:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:46 INFO - Downloading blessings-1.6.tar.gz 06:25:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:25:46 INFO - Installing collected packages: blessings 06:25:46 INFO - Running setup.py install for blessings 06:25:46 INFO - Successfully installed blessings 06:25:46 INFO - Cleaning up... 06:25:47 INFO - Return code: 0 06:25:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:47 INFO - Reading from file tmpfile_stdout 06:25:47 INFO - Current package versions: 06:25:47 INFO - blessings == 1.6 06:25:47 INFO - blobuploader == 1.2.4 06:25:47 INFO - docopt == 0.6.1 06:25:47 INFO - functools32 == 3.2.3-2 06:25:47 INFO - jsonschema == 2.5.1 06:25:47 INFO - manifestparser == 1.1 06:25:47 INFO - mozInstall == 1.12 06:25:47 INFO - mozcrash == 1.0 06:25:47 INFO - mozdebug == 0.1 06:25:47 INFO - mozdevice == 0.49 06:25:47 INFO - mozfile == 1.2 06:25:47 INFO - mozhttpd == 0.7 06:25:47 INFO - mozinfo == 0.9 06:25:47 INFO - mozleak == 0.1 06:25:47 INFO - mozlog == 3.4 06:25:47 INFO - moznetwork == 0.27 06:25:47 INFO - mozprocess == 0.23 06:25:47 INFO - mozprofile == 0.28 06:25:47 INFO - mozrunner == 6.13 06:25:47 INFO - mozscreenshot == 0.1 06:25:47 INFO - mozsystemmonitor == 0.3 06:25:47 INFO - moztest == 0.7 06:25:47 INFO - mozversion == 1.4 06:25:47 INFO - psutil == 3.1.1 06:25:47 INFO - requests == 1.2.3 06:25:47 INFO - wsgiref == 0.1.2 06:25:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:47 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 0x10cae03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca56570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc89b473550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f6d30>, '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 0x10c75ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8eeb20>, '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.kSVDu3HSpY/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.7Jyba4I2Ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 06:25:47 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 06:25:47 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 06:25:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kSVDu3HSpY/Render', 06:25:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:47 INFO - 'HOME': '/Users/cltbld', 06:25:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:47 INFO - 'LOGNAME': 'cltbld', 06:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:47 INFO - 'MOZ_NO_REMOTE': '1', 06:25:47 INFO - 'NO_EM_RESTART': '1', 06:25:47 INFO - 'PAGER': '/bin/cat', 06:25:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:47 INFO - 'PWD': '/builds/slave/test', 06:25:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:47 INFO - 'SHELL': '/bin/bash', 06:25:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Jyba4I2Ct/Listeners', 06:25:47 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 06:25:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:47 INFO - 'USER': 'cltbld', 06:25:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:47 INFO - 'XPC_FLAGS': '0x0', 06:25:47 INFO - 'XPC_SERVICE_NAME': '0', 06:25:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:47 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)) 06:25:47 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)) 06:25:47 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)) 06:25:47 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)) 06:25:47 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)) 06:25:47 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)) 06:25:47 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)) 06:25:47 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)) 06:25:47 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)) 06:25:47 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)) 06:25:47 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)) 06:25:47 INFO - Cleaning up... 06:25:47 INFO - Return code: 0 06:25:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:47 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 0x10cae03f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca56570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc89b473550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8f6d30>, '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 0x10c75ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8eeb20>, '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.kSVDu3HSpY/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.7Jyba4I2Ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 06:25:47 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 06:25:47 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 06:25:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kSVDu3HSpY/Render', 06:25:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:47 INFO - 'HOME': '/Users/cltbld', 06:25:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:47 INFO - 'LOGNAME': 'cltbld', 06:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:47 INFO - 'MOZ_NO_REMOTE': '1', 06:25:47 INFO - 'NO_EM_RESTART': '1', 06:25:47 INFO - 'PAGER': '/bin/cat', 06:25:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:47 INFO - 'PWD': '/builds/slave/test', 06:25:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:47 INFO - 'SHELL': '/bin/bash', 06:25:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Jyba4I2Ct/Listeners', 06:25:47 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 06:25:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:47 INFO - 'USER': 'cltbld', 06:25:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:47 INFO - 'XPC_FLAGS': '0x0', 06:25:47 INFO - 'XPC_SERVICE_NAME': '0', 06:25:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:25:47 INFO - Cleaning up... 06:25:47 INFO - Return code: 0 06:25:47 INFO - Running post-action listener: _resource_record_post_action 06:25:47 INFO - Running post-action listener: _start_resource_monitoring 06:25:47 INFO - Starting resource monitoring. 06:25:47 INFO - [mozharness: 2016-11-29 14:25:47.840334Z] Finished create-virtualenv step (success) 06:25:47 INFO - [mozharness: 2016-11-29 14:25:47.841336Z] Running install step. 06:25:47 INFO - Running pre-action listener: _resource_record_pre_action 06:25:47 INFO - Running main action method: install 06:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:48 INFO - Reading from file tmpfile_stdout 06:25:48 INFO - Detecting whether we're running mozinstall >=1.0... 06:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:25:48 INFO - Reading from file tmpfile_stdout 06:25:48 INFO - Output received: 06:25:48 INFO - Usage: mozinstall [options] installer 06:25:48 INFO - Options: 06:25:48 INFO - -h, --help show this help message and exit 06:25:48 INFO - -d DEST, --destination=DEST 06:25:48 INFO - Directory to install application into. [default: 06:25:48 INFO - "/builds/slave/test"] 06:25:48 INFO - --app=APP Application being installed. [default: firefox] 06:25:48 INFO - mkdir: /builds/slave/test/build/application 06:25:48 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'] 06:25:48 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 06:26:21 INFO - Reading from file tmpfile_stdout 06:26:21 INFO - Output received: 06:26:21 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 06:26:21 INFO - Running post-action listener: _resource_record_post_action 06:26:21 INFO - [mozharness: 2016-11-29 14:26:21.490459Z] Finished install step (success) 06:26:21 INFO - [mozharness: 2016-11-29 14:26:21.490606Z] Running run-tests step. 06:26:21 INFO - Running pre-action listener: _resource_record_pre_action 06:26:21 INFO - Running main action method: run_tests 06:26:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:26:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:26:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:26:21 INFO - 2016-11-29 06:26:21.504 screenresolution[1633:7720] starting screenresolution argv=screenresolution get 06:26:21 INFO - 2016-11-29 06:26:21.507 screenresolution[1633:7720] Display 0: 1600x1200x32@60 06:26:21 INFO - 2016-11-29 06:26:21.513 screenresolution[1634:7722] starting screenresolution argv=screenresolution list 06:26:21 INFO - Available Modes on Display 0 06:26:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:26:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:26:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:26:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:26:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:26:21 INFO - Intel Iris: 06:26:21 INFO - Chipset Model: Intel Iris 06:26:21 INFO - Type: GPU 06:26:21 INFO - Bus: Built-In 06:26:21 INFO - VRAM (Dynamic, Max): 1536 MB 06:26:21 INFO - Vendor: Intel (0x8086) 06:26:21 INFO - Device ID: 0x0a2e 06:26:21 INFO - Revision ID: 0x0009 06:26:21 INFO - Displays: 06:26:21 INFO - Display: 06:26:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:26:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:26:21 INFO - Display Serial Number: 1600x1200 60 06:26:21 INFO - Main Display: Yes 06:26:21 INFO - Mirror: Off 06:26:21 INFO - Online: Yes 06:26:21 INFO - Rotation: Supported 06:26:21 INFO - Return code: 0 06:26:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:26:21 INFO - Python 2.7.3 06:26:21 INFO - Return code: 0 06:26:21 INFO - grabbing minidump binary from tooltool 06:26: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')]} 06:26:21 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 0x10c8f6d30>, '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 0x10c75ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8eeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:26:21 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 06:26:21 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 06:26:21 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 06:26:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:26:21 INFO - Return code: 0 06:26:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:26:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:26:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:26:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:26:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:26:21 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0223', '--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 06:26:21 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0223 --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 06:26:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kSVDu3HSpY/Render', 06:26:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:26:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:26:21 INFO - 'HOME': '/Users/cltbld', 06:26:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:26:21 INFO - 'LOGNAME': 'cltbld', 06:26:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:26:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:21 INFO - 'MOZ_NO_REMOTE': '1', 06:26:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:26:21 INFO - 'NO_EM_RESTART': '1', 06:26:21 INFO - 'PAGER': '/bin/cat', 06:26:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:21 INFO - 'PWD': '/builds/slave/test', 06:26:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:26:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:26:21 INFO - 'SHELL': '/bin/bash', 06:26:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Jyba4I2Ct/Listeners', 06:26:21 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 06:26:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:26:21 INFO - 'USER': 'cltbld', 06:26:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:26:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:21 INFO - 'XPC_FLAGS': '0x0', 06:26:21 INFO - 'XPC_SERVICE_NAME': '0', 06:26:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:26:21 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0223', '--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 06:26:22 INFO - mozversion application_buildid: 20161129030222 06:26:22 INFO - mozversion application_changeset: f8107cf961444a8d7fdc2c0f446238af9893f875 06:26:22 INFO - mozversion application_display_name: Nightly 06:26:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:26:22 INFO - mozversion application_name: Firefox 06:26:22 INFO - mozversion application_remotingname: firefox 06:26:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:26:22 INFO - mozversion application_vendor: Mozilla 06:26:22 INFO - mozversion application_version: 53.0a1 06:26:22 INFO - mozversion platform_buildid: 20161129030222 06:26:22 INFO - mozversion platform_changeset: f8107cf961444a8d7fdc2c0f446238af9893f875 06:26:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:26:22 INFO - mozversion platform_version: 53.0a1 06:26:22 INFO - using testdate: 1480429582 06:26:22 INFO - actual date: 1480429582 06:26:22 INFO - starting webserver on 'localhost:49244' 06:26:22 INFO - SUITE-START | Running 2 tests 06:26:22 INFO - TEST-START | dromaeo_css 06:26:22 INFO - operating with platform_type : mac_ 06:26:22 INFO - Initialising browser for dromaeo_css test... 06:26:22 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/tmpmSy8LZ/profile http://localhost:49244/getInfo.html) 06:26:24 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 06:26:24 INFO - PROCESS | 1644 | colorDepth:24 06:26:24 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 06:26:24 INFO - PROCESS | 1644 | __metrics 06:26:24 INFO - PROCESS | 1644 | 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" 06:26:24 INFO - PROCESS | 1644 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:26:25 INFO - TEST-INFO | 1644: exit 0 06:26:25 INFO - Browser initialized. 06:26:25 INFO - Running cycle 1/1 for dromaeo_css test... 06:26:25 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/tmpmSy8LZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:26:38 INFO - PROCESS | 1648 | RSS: Main: 245575680 06:26:38 INFO - PROCESS | 1648 | 06:27:29 INFO - PROCESS | 1648 | 1480429649470 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] 06:29:42 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 06:29:44 INFO - PROCESS | 1648 | RSS: Main: 347795456 06:29:44 INFO - PROCESS | 1648 | 06:32:47 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 06:32:48 INFO - PROCESS | 1648 | RSS: Main: 372772864 06:32:48 INFO - PROCESS | 1648 | 06:35:50 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 06:35:51 INFO - PROCESS | 1648 | RSS: Main: 332668928 06:35:51 INFO - PROCESS | 1648 | 06:38:53 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 06:38:54 INFO - PROCESS | 1648 | RSS: Main: 339881984 06:38:54 INFO - PROCESS | 1648 | 06:41:57 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 06:41:58 INFO - PROCESS | 1648 | RSS: Main: 329715712 06:41:58 INFO - PROCESS | 1648 | 06:45:01 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 06:45:01 INFO - PROCESS | 1648 | RSS: Main: 398368768 06:45:01 INFO - PROCESS | 1648 | 06:45:01 INFO - PROCESS | 1648 | __start_tp_report 06:45:01 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 06:45:01 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 06:45:01 INFO - PROCESS | 1648 | |i|pagename|runs| 06:45:01 INFO - PROCESS | 1648 | |0;dojo.html;2960.230340111571;3318.435865902796;3344.5317655528215;3347.7489188310883;3386.6951974322324;4624.699394539352;5530.474604912527;5579.972100139494;5584.636998595089;5600.467955544227;4644.5123262057505;5599.944000559994;5674.858128546778;5712.771489140429;5725.770969161239;4547.408836851205;4952.653314268003;5046.899062018758;5120.23196520523;5127.230915362707;5157.484251574831;5206.140986737184;5232.607554433433;5233.3981592116825;5269.394019687747;5045.495450454925;5151.381834179903;5167.147420675622;5179.430262671103;5234.424213336549;4162.313218318974;5081.898362032775;5117.181250999822;5145;5152.690838549662;5120.052790233819;5130.871728206787;5130.948690513122;5131;5136.101182293084;5651.011073062197;5653.4911857932575;5662.292213473316;5666.433356664342;5679.204911312419;5981.162637230791;6082.665453400105;6094.451499365034;6109.480694141003;6149.169862068608;6269.780557680505;6271.153394291803;6281.591696539756;6284.34014428483;6289.622622642656;5708.343540492813;5750.539956803445;5771.249737534177;5779.971100144472;5819.534437245053;6165.04441811511;6215.005599104122;6219.129321894939;6228.937710622927;6315.147455093595;6093.451589356979;6134.447899689049;6148.415900489446;6148.9692551536955;6152.354002829638;6257.7184026718905;6263.123162757218;6264.5301602380005;6275.278342990523;6281.591696539802;5977.820665379959;6029.095635654599;6101.816945491642;6168;6194.752209911643;6096.451319381277;6112.113743507255;6141.915626108588;6154.7230374633245;6240.344763799826;4870.853874383774;4871.244957031666;4881.219004959189;4896.46138924718;4903.779329930162;4372.125574885035;4393.802278897458;4398.824047038082;4405.9866230766465;4431.180231657154;4597.42532183477;5151.356080489939;5402.297701298806;5619.690916999604;5679.148127780783;6162.137300777895;6182.629042257479;6189.752409903554;6197.628142311476;6203;5650.915236271459;5668.744906479218;5679.460451257124;5683;5685.204071430003;5303.814366497154;5331;5368.436314186954;5384.434634363413;5401.054815407288;6330.588511746721;6340.524460665469;6346.30190679025;6354.6822658867795;6361.61830290184;4836.613070954386;6054.969725151346;6061.060535616986;6086.452219300284;6293.181886354744;5260.289860868734;6176.598521096114;6291.402316779899;6351.68241587928;6359.459445947146;5159.509846564571;6094.9085763714465;6144.662043587646;6167.290761562478;6168.105624684305;6063.514918806573;6117.296510901303;6233.407826256498;6241.3134555197985;6248.343923888108;5151.6908985461;5963.850903727442;5964.433378829004;6010.918034753787;6084.421979911901;6064.818055458343;6089.786857460145;6094.939050609437;6097.969510152421;6106.08408738675;5689.146628005832;5901.704914754331;5907.586468947133;5911.7930872420975;5916.940830591811;5823.854403639943;5996.160537524837;6025.156478092983;6069.575129740876;6140.017597184429;5848.152017957457;5906.911396328973;5916.437938395846;5924.289085309791;5947.04847224442 06:45:01 INFO - PROCESS | 1648 | |1;ext.html;484.2083193977846;499.2202797028593;501.49098664855154;506.2937202602371;510.72420892717935;30073.548896766537;30649;31372.05883823489;31450.213744656394;31461.842690786572;40371;41801.372979405336;41910.37134442978;43800.56199438005;43824;9318;9454.669086581971;9467.195288400495;9474.19469345103;9485.62057517702;8468.618912148937;9305.11601397866;9438.952805235964;9446.291528135383;9452.19656329213;8568.78578035551;11119.72200694981;11349.375784331858;11360.204785665006;11598.130140239517;11326.980571748541;11368.488418021208;11387;11388.373639449826;11392.658220253406;8434.156584341517;8859.734207973772;9280.35037547372;11153.832692509537;11159.330440173615;30529;38283.80858095692;38837.02907427309;38969.41545876814;40152;3313.122022663996;3366.293078453528;3477.061193477772;3579.982100089509;3800.2399520095814;29657.70342296571;30071;30315.696843031506;30529.694703052908;30629.38741225163;3071.754259659222;3176.8411579421168;3188;3233.547303377529;3294.5058241264;318954;321335;321484;321717.39141304145;321980;57326.566835829435;57461.712691436274;57503.1374529374;57550.848983020944;57561.42438575561;60605;60664;60807.479813004145;60837.69581152066;60872.78254434886;14512.709745805025;15099.39602415891;15102.773458398133;15141.545753627408;15149.469768558047;11657.417129143509;11733.120015998835;11737.530498780125;11744.412779361168;11744.94127529374;11978.04175665962;14542.854571454362;15730.528084157264;16438.260278287507;16473.01161930288;5865.765369385177;6960.686769095301;6987.406070483964;7105.25394833535;7159.248278930741;821.6343727041528;843.8059246373246;987.8518222266574;1041.4532370505394;1122.7024838417826;25358.239252822445;28802.84788608432;28803.711962880523;29435.558466623017;29461.11616651504;876.4303202918154;1058.862347894784;1077.9676609701721;1094;1176.588194132064;14966.578175073351;15013.174275414738;15072.573873405565;15371;15442.768358474632;539687;767511;776206;776759;777048.1147594226;48555.02889942181;49487.25769113466;49490.25764613534;56140.43859561434;57058.429415706145;1195.754870251579;1309.2537253765263;1386.2791348498927;1387.070662656023;1392.1090502078475;24104.87947560251;29711.40577188401;31237.375252495276;31315.84342078275;32472;54958.45041549533;56870.7156464215;59003.409965899795;59220.70389648024;61474;384562;411527;414278;548686;592776;41578.168436631706;41597.168056639304;42168.578314216466;42346;42827.357589635554;45845.77077114727;45920.770396147804;46835.76582117204;46936.7653161732;47124.52875471202;38247.80876095602;38360.2327953445;38719.80640096894;40436.59563404328;40767.796161019;38270;38400.80799596096;38584;39720.80139599399;40033;37472.437913430775;37957.810210948766;38285;38354.42468362921;38410.80794596009;31022.68977310198;33393.83303083469;34132.829335854156;34335;34474;23000.76999229986;24922;24939.127130550343;25193.748062519142;25770.226893193234 06:45:01 INFO - PROCESS | 1648 | |2;jquery.html;312.0684756003328;322.77405815928853;362.7587654209951;366.29671031619307;374.3897447161128;14199.503017394392;15586.766198507017;18610;18795.62408751824;20269.885156316395;18034.458966231035;18473.261069557237;18702.532436689056;18842.05789710516;18860.962647054406;5377.381601115882;5503.449655034495;5643.858903527424;5710.857228569277;5711.05767548354;3981.7411868228473;5592.0773072443;5715.342735585398;5728;5733.312002559699;4183.3097538906195;4192.4759405074365;6245.718942647592;6303.747850085991;6310.621362718229;6219.484189190545;6268.122462855158;6295.338989406115;6297.118403423525;6302.369763023684;5199.454057323965;5408.188771684239;5412.431694672042;5412.56699464042;5424.864378390572;22318.665220021714;23489.41276468085;24047.879760601085;24136.75863241363;24325.391865203335;2236.888155592214;2243.596152692515;2480.4790993891306;2771;2847.7579405750535;9495.003024682377;9528.82337457225;9546.522673866279;9963.252756043326;9988.95005524975;1762.55936015996;1777.9377721779806;1783.4025601423539;1800.3968670495399;1806.6838303297002;92755.53622231845;100276;111434.3284850728;118618.99999999914;118737;9284.675036373694;10114.393136411838;10260.538275777608;11040.834387484194;11192.832107518394;12375.638679745221;13507.122037067558;13609.455621775216;13740.312984350743;14107.858921410654;7854.136045035041;7877.960610197027;7903.774914888201;8020.679172833022;8066.7579972600915;7682.692692292246;7694.499857509244;7695.769126926201;7848.372130229682;7856.803579910548;4358.128374325148;4359.215341238544;4365.869023929287;4378.5183629800695;4428.7121337112985;1692.889962152456;1820.854331653491;1830.423416623786;1879.3140503716045;1880.877742946704;869.5956380283199;872.4285592936636;873.2097451806126;945.3382632157517;956.5695437053354;14845;18848.15183316754;19488.343490803156;19765.505862353268;20204.292849750484;891.7681402835309;897.1297841094129;920.2959735802117;960.3949511807516;975.9512024398751;9899.27769863279;10336.379817210842;10338.328008679411;10339.224558158168;10394.428306443218;431696;438869.8056509697;499076;503229.4838525784;510975;137785;138580.30709846588;140900;142150;142513.28743356216;974.1962880623514;986.8125056239148;1040.6513817871098;1042.61944390297;1043.8642976413018;16965.575860603585;17941.641167176844;18074;18457.892526448457;18814.811851881306;54072.72963635156;54375.64060898351;55602.49788759435;56290.718546407006;57197.71401142968;74287;80376.59811700904;80474;81082;83582.16417835745;6587.341265873374;7556.1310449299035;7679.078510578766;7715.92284077152;7755.650995705094;10053.69838904834;11780.410979450822;12087;12089.576864810042;12126.211796233216;9443.575039123118;10078.395296281953;10156.441395723306;10443.112335451571;10529.526171322155;9300.534973251446;9444.622215111318;9896.554655040396;9906.554205060645;10005.549750261402;10163.136133428445;10245.080152156599;10319.793604128026;10386.272960892968;10414.323069000491;6684.866302674017;7029;7037.085178926707;7262.782116536512;7818.765437036898;8317.792055198668;9995.100440960348;10199.7450063749;10224.028717271847;10843.783124337628 06:45:01 INFO - PROCESS | 1648 | |3;mootools.html;1365.2218235605708;1456.2063675296965;1487.330701184467;1643.621966947602;1830.4417152768408;7411.4070874330055;7776.416768742346;8062.516249025062;8285.585720713956;8314.501129932209;8203.138670439608;8308.91691083089;8311.958440207805;8312.376571757111;8331.87502187466;1999.3602047344782;2265.082641530179;2300.1374484568287;2302.24026071396;2306.123673004256;1745.4240100766717;2221.9555608887813;2293.5298263855952;2297.023764899919;2310.376198426424;2284.2918695204457;2284.9200277990276;2287.2680742162515;2292.277932451281;2294.105298933409;2230.788075132868;2282.954340913189;2290.919817806369;2293.4266433391567;2293.715519309192;1840.392670418772;2274.863508189514;2302.5625131225183;2302.9654555181687;2304.8156147508157;8227.095019547845;8231.876521852177;8279;8308.376871734645;8380.790480237982;4925.064237794843;5112.258722485256;5116.846494605168;5125.615578831603;5126.2054381570915;3321.64624318735;3332.8500217490273;3416.5558477398026;3434.347473979936;3450;881.5460038080394;999.8050380175796;1077.9676609701721;1082.0532034469838;1082.0955118990555;10821.945890270577;10903.182261330432;10925.508352124174;10960.177986651033;10997.505112269968;4398.208322501916;4492;4670.80894371933;4673.883152921204;4700.294955756595;9325.440473571607;9331.860022099674;9345.626174952926;9351.018143094878;9353.532323383804;4277.443932288783;5100.974495127575;5110.48895110486;5110.8466745997675;5115.283860259567;4603.424571928509;4639.652026098056;4645.9303110453375;4650;4707.646926480527;3701.40777475608;3707.721920855947;3752.8686495973056;3802.2585595809105;3826.0730541136054;1236.3262022197923;1239.2750241108872;1245.862955074941;1252.0296770003138;1255.8492980842175;763.267263427105;807.1968391450545;868.1362044765499;871.5250188647076;888.5823662878437;5570.972145139248;5647.322321321468;5670.06443936754;5701.572382071361;5840.591158618856;423.94276772635914;427.9465066866642;429.2788115965208;433.9674524410619;442.25259311763017;3858.4405261237525;3865.536135663682;3949.526056873136;3952.7628342299554;4029.37544680575;9460.290478214161;9955.950220248853;9957.253206009578;9981.650642227487;9982.750431239132;9418.19945304643;9658.3722058066;9839.016098390104;9840.11438970496;10023.649172278936;6814.284500127515;7101.573905565682;7490.363319117827;7683.385329173652;7743.845123097619;5523.226748255328;5547.472990065938;5644.463775941279;5737.483626473638;6008.429199226067;9160.221381182673;9170.770730731785;9175.128362805523;9300.162985331353;9345.112214339626;9281.350305478552;9374.5781439834;9499.240060794982;9501.334906556474;9502.952485237529;6984.825379365353;7212.386947109554;7218.855622887408;7430.814229644302;7532.510386824839;7585.469017168745;7819.648115834915;7902.446828721934;7905.090914544671;7951.085625153181;7037.1555413350725;7047.647617618996;7056.294370562902;7056.894146587702;7078.1506219254015;6803.387695107464;6813.250542440427;6888.138982627172;6980.476464265099;7022.08712867324;6502.122213501306;6628.966855165693;6636.701348439428;6637.867242655217;6638.701258443478;4691.390119284471;4773.785179666854;4849.563539281482;4897.853064408074;4919.901601967869;3825.5026846509777;4694.718316900997;4734.976325118352;4967.776450059829;5045.646804723781 06:45:01 INFO - PROCESS | 1648 | |4;prototype.html;292.83454848010877;304.73792538416956;308.2509501910358;314.1032352633231;314.5784648570916;5236.92144617831;5253.343332083489;5256.369235691723;5258.949809110712;5264.289320941672;4739.81504623844;5186.377634683843;5195.454477279888;5224.570574682772;5255.579553635709;3303.8182899940493;3673.577538583057;3760.5111335526344;3883.611638836108;3916.5900275900653;3087.367089746597;3654.3422184006868;3847.9610505163587;3987.7806720630356;4054.5337286212166;3411.317736452707;3967.2462232175794;3988.3020471417385;4001.7799021053975;4039.40443524809;3210.871565137392;3291.4240007998505;3755.004923695223;3832.938243847607;4016.49793775778;3441.8451169697173;3453.792772433662;3457.9827100864336;3477.3914564951033;3486.6164721880573;4239.1521695660995;4620.653450991189;4712.6229901607785;4810.39870016248;5115.825774046016;4155.002799328139;4521.502634710179;4555.703879247872;4582.587567118975;4591.701539399962;4930.778114984834;5431.375391829951;5466.9179962300595;5481.369642491085;5489.58828087891;3291.2923721399775;3477.661100476335;3693.6306369362846;3748.7947804627197;3807.8766763804742;4726.432828060655;5000.224965130447;5455.344918904344;5711.286089238845;5721.7711291548285;3317.8506967186536;3590.3178396105177;3774.8867533974026;3791.962080379216;3839.5968423315708;3829.2532956073296;3841.250956063541;3847.7498962567342;3849.4418309344987;3889.2221555688975;4321.601511161336;4495.348174514677;4515.932261016087;4518.502964673883;4553.590176884097;4595.172868883633;4879.536444037882;5413.458654134633;5474.972625136849;5521.432533871769;1117.284937639911;1214.9453274602663;1217.8538575370835;1233.6669099343128;1241.522014024607;739.8901647528706;797.8244786147038;836.8744039267176;839.6683310092479;843.6751850537587;4340.370646256339;4946.703197808143;5120.462351453119;5143.665661731976;5159.613029022838;4753.809847606126;5570.359408667974;5663.688497132614;5706.087026075891;5752.884942301131;4957.4886852964355;5203.855151866584;5208.687478751287;5217.269582258411;5241.868953276198;2261.5250797332415;2438.5854404751235;2718.7417195366406;2721.8094733368475;2831.844248566307;4788.209945358977;5493.835184944458;5524.254225679562;5598.524125449301;5598.58010649203;4553.180427523078;4641.489436162019;5204.479552044841;5324.1747529133045;5428.674279543161;4794.568488836021;5123.590112790967;5398.541124004503;5401;5549.833504994856;4559.635229181591;5250.763715632729;5264.684118952875;5293.60297977661;5332.33345831771;4725.385699859134;5205.349331333583;5245.826275103507;5262.605304602093;5728.598998070262;4986.933036182794;5907.675077870758;5968.820935371946;5980.880382392241;5994.490468310242;3250.7724459287624;3386.559747232844;3825.846966121324;3853.306404847154;3862.710296727813;4966.8758281043265;5036.622253331088;5057.887264801738;5792.82621521355;5835.67903765297;5507.7246137693755;5522.779088836402;5527.861803454945;5582.581306402118;5652.3217213934595;5126.871828204325;5298.860744939857;5489.752961116679;5537.42183477723;5573.442655734556;5093.122385851982;5281.102212623787;5379.569634429315;5383.327084114486;5448.972755136199;4539.432570928634;5266.865510574181;5439.700816455133;5519.530839878656;5554.833354999357;4695.55830967888;5306.628536002443;5434.510894019557;5487.835364939058;5494.532964698045 06:45:01 INFO - PROCESS | 1648 | |5;yui.html;681.2131987554375;715.7244460882558;716.6667499612679;760.3043215457857;764.3426653078349;14757.409703611842;15545.300461479232;15559.92220038901;15582.142982135992;15600;13786.448542058331;13900.957428192876;13909.956753243521;13914.095583787046;13934.721305573883;638.7987783848096;658.6180015590945;661.7683810666276;811.8254575266317;827.1563005734148;797.0475282037967;821.6179476543406;823.7281697039992;824.3281725393815;827.2224109337234;859.256742917375;872.1322284327103;873.0004145253681;874.45783614159;876.303338845616;867.9479231246114;869.652139144341;870.0690261420219;870.277669534285;870.6169285514353;499.865305755932;510.2066286923832;517.4721783780523;645.6094063091856;645.6126324205486;11805.822912656316;11867.881321186764;11884.821727674092;12673;13080.738385232336;13637.249951252677;13734;14103.294835258299;14292.642683932881;14583.854161458356;11242;11268.985791278825;11317.207795454322;11400.25898316615;11558.364289964049;3645.4167333226824;3650.5450882214927;3717.442383642448;3721.1999420124803;3783.2244389900006;112096;116276;116446.25330620048;117714.99999999914;119017;10329.741756455998;10465.47672616366;10494.73763155912;10551.894481055091;10792.838107428395;22944.4263893404;22947.770522294897;22952.540949180922;22964.540709186058;22994.8850255751;7701.768946931601;7785.688572457038;7794.844103117905;7973.8405231896195;8021.197880212048;4069.89825254371;4110.917781644351;4142.627163555295;4151.564085771011;4214.030772922245;3315.3700796849002;3411.914702132417;3428.708559772397;3504.0889368763796;3523.207278362348;599.9220101386792;607.738672370876;624.8188025472652;626.0484064222447;636.933122022181;557.2950217974266;611.3061674998909;627.4133685004535;635.463033736492;637.5154882289494;8570.271526920156;8678.956605216934;8891.288696904361;9011.684591039282;9152;573.896698594257;621.3662064693987;636.7803107927757;641.4323323858418;661.1438187547138;3462.532558104674;4200.831966721297;4434.600885920283;4501.257292546693;4534.183846907588;88872;92693.53653231691;96595;101093.98906010993;101273;84696;90144;91983;92007;93988.06011939792;50741;76348;77080.2291977073;77534.22465775383;79630.6018469904;7619.08570971487;9023.909760902307;9458.527073646428;9476.95261523688;9574.808503830023;43736.78131609321;53360.73319633377;53824;54887.72556137194;55910.72044639751;71022;73025;75838.62080689562;76594.61702691451;76984;10434.37393756377;11944.880551194377;12056.578019769266;12191.245414288613;12268.570600028956;13606.319684015562;13925.582232533041;13944;14081.295935203403;14220.146791192561;12838.42227099764;12936.935315323362;12983.156094853804;13145.60563183106;13287.867121328663;11480.483378248166;11511;11660.591879284184;12425.19236249641;12833.614991550268;12325.691857703629;12333.876661233631;12574.811377829523;12597.874021260037;12615.936920315708;10044.698659040241;10190.949045254727;10197.643082492077;10320.638777642747;10767.946160269463;10601.469926503798;10812.243142979916;10872.782544349227;10882.075023623082;10896.400697961688 06:45:01 INFO - PROCESS | 1648 | __end_tp_report 06:45:01 INFO - PROCESS | 1648 | __start_cc_report 06:45:01 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1753 06:45:01 INFO - PROCESS | 1648 | __end_cc_report 06:45:01 INFO - PROCESS | 1648 | __startTimestamp1480430701813__endTimestamp 06:45:01 INFO - PROCESS | 1648 | 06:45:01 INFO - PROCESS | 1648 | ------- Summary: start ------- 06:45:01 INFO - PROCESS | 1648 | Number of tests: 6 06:45:01 INFO - PROCESS | 1648 | 06:45:01 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5640.09 Median:5901.70 stddev:679.15 (11.5%) stddev-sans-first:647.88 06:45:01 INFO - PROCESS | 1648 | Values: 2960.2 3318.4 3344.5 3347.7 3386.7 4624.7 5530.5 5580.0 5584.6 5600.5 4644.5 5599.9 5674.9 5712.8 5725.8 4547.4 4952.7 5046.9 5120.2 5127.2 5157.5 5206.1 5232.6 5233.4 5269.4 5045.5 5151.4 5167.1 5179.4 5234.4 4162.3 5081.9 5117.2 5145.0 5152.7 5120.1 5130.9 5130.9 5131.0 5136.1 5651.0 5653.5 5662.3 5666.4 5679.2 5981.2 6082.7 6094.5 6109.5 6149.2 6269.8 6271.2 6281.6 6284.3 6289.6 5708.3 5750.5 5771.2 5780.0 5819.5 6165.0 6215.0 6219.1 6228.9 6315.1 6093.5 6134.4 6148.4 6149.0 6152.4 6257.7 6263.1 6264.5 6275.3 6281.6 5977.8 6029.1 6101.8 6168.0 6194.8 6096.5 6112.1 6141.9 6154.7 6240.3 4870.9 4871.2 4881.2 4896.5 4903.8 4372.1 4393.8 4398.8 4406.0 4431.2 4597.4 5151.4 5402.3 5619.7 5679.1 6162.1 6182.6 6189.8 6197.6 6203.0 5650.9 5668.7 5679.5 5683.0 5685.2 5303.8 5331.0 5368.4 5384.4 5401.1 6330.6 6340.5 6346.3 6354.7 6361.6 4836.6 6055.0 6061.1 6086.5 6293.2 5260.3 6176.6 6291.4 6351.7 6359.5 5159.5 6094.9 6144.7 6167.3 6168.1 6063.5 6117.3 6233.4 6241.3 6248.3 5151.7 5963.9 5964.4 6010.9 6084.4 6064.8 6089.8 6094.9 6098.0 6106.1 5689.1 5901.7 5907.6 5911.8 5916.9 5823.9 5996.2 6025.2 6069.6 6140.0 5848.2 5906.9 5916.4 5924.3 5947.0 06:45:01 INFO - PROCESS | 1648 | 06:45:01 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:64857.23 Median:38258.90 stddev:144687.07 (378.2%) stddev-sans-first:145012.23 06:45:01 INFO - PROCESS | 1648 | Values: 484.2 499.2 501.5 506.3 510.7 30073.5 30649.0 31372.1 31450.2 31461.8 40371.0 41801.4 41910.4 43800.6 43824.0 9318.0 9454.7 9467.2 9474.2 9485.6 8468.6 9305.1 9439.0 9446.3 9452.2 8568.8 11119.7 11349.4 11360.2 11598.1 11327.0 11368.5 11387.0 11388.4 11392.7 8434.2 8859.7 9280.4 11153.8 11159.3 30529.0 38283.8 38837.0 38969.4 40152.0 3313.1 3366.3 3477.1 3580.0 3800.2 29657.7 30071.0 30315.7 30529.7 30629.4 3071.8 3176.8 3188.0 3233.5 3294.5 318954.0 321335.0 321484.0 321717.4 321980.0 57326.6 57461.7 57503.1 57550.8 57561.4 60605.0 60664.0 60807.5 60837.7 60872.8 14512.7 15099.4 15102.8 15141.5 15149.5 11657.4 11733.1 11737.5 11744.4 11744.9 11978.0 14542.9 15730.5 16438.3 16473.0 5865.8 6960.7 6987.4 7105.3 7159.2 821.6 843.8 987.9 1041.5 1122.7 25358.2 28802.8 28803.7 29435.6 29461.1 876.4 1058.9 1078.0 1094.0 1176.6 14966.6 15013.2 15072.6 15371.0 15442.8 539687.0 767511.0 776206.0 776759.0 777048.1 48555.0 49487.3 49490.3 56140.4 57058.4 1195.8 1309.3 1386.3 1387.1 1392.1 24104.9 29711.4 31237.4 31315.8 32472.0 54958.5 56870.7 59003.4 59220.7 61474.0 384562.0 411527.0 414278.0 548686.0 592776.0 41578.2 41597.2 42168.6 42346.0 42827.4 45845.8 45920.8 46835.8 46936.8 47124.5 38247.8 38360.2 38719.8 40436.6 40767.8 38270.0 38400.8 38584.0 39720.8 40033.0 37472.4 37957.8 38285.0 38354.4 38410.8 31022.7 33393.8 34132.8 34335.0 34474.0 23000.8 24922.0 24939.1 25193.7 25770.2 06:45:01 INFO - PROCESS | 1648 | 06:45:01 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:31249.15 Median:217944.24 stddev:81486.66 (37.4%) stddev-sans-first:81682.14 06:45:01 INFO - PROCESS | 1648 | Values: 312.1 322.8 362.8 366.3 374.4 14199.5 15586.8 18610.0 18795.6 20269.9 18034.5 18473.3 18702.5 18842.1 18861.0 5377.4 5503.4 5643.9 5710.9 5711.1 3981.7 5592.1 5715.3 5728.0 5733.3 4183.3 4192.5 6245.7 6303.7 6310.6 6219.5 6268.1 6295.3 6297.1 6302.4 5199.5 5408.2 5412.4 5412.6 5424.9 22318.7 23489.4 24047.9 24136.8 24325.4 2236.9 2243.6 2480.5 2771.0 2847.8 9495.0 9528.8 9546.5 9963.3 9989.0 1762.6 1777.9 1783.4 1800.4 1806.7 92755.5 100276.0 111434.3 118619.0 118737.0 9284.7 10114.4 10260.5 11040.8 11192.8 12375.6 13507.1 13609.5 13740.3 14107.9 7854.1 7878.0 7903.8 8020.7 8066.8 7682.7 7694.5 7695.8 7848.4 7856.8 4358.1 4359.2 4365.9 4378.5 4428.7 1692.9 1820.9 1830.4 1879.3 1880.9 869.6 872.4 873.2 945.3 956.6 14845.0 18848.2 19488.3 19765.5 20204.3 891.8 897.1 920.3 960.4 976.0 9899.3 10336.4 10338.3 10339.2 10394.4 431696.0 438869.8 499076.0 503229.5 510975.0 137785.0 138580.3 140900.0 142150.0 142513.3 974.2 986.8 1040.7 1042.6 1043.9 16965.6 17941.6 18074.0 18457.9 18814.8 54072.7 54375.6 55602.5 56290.7 57197.7 74287.0 80376.6 80474.0 81082.0 83582.2 6587.3 7556.1 7679.1 7715.9 7755.7 10053.7 11780.4 12087.0 12089.6 12126.2 9443.6 10078.4 10156.4 10443.1 10529.5 9300.5 9444.6 9896.6 9906.6 10005.5 10163.1 10245.1 10319.8 10386.3 10414.3 6684.9 7029.0 7037.1 7262.8 7818.8 8317.8 9995.1 10199.7 10224.0 10843.8 06:45:01 INFO - PROCESS | 1648 | 06:45:01 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5378.25 Median:5116.07 stddev:2980.59 (58.3%) stddev-sans-first:2973.70 06:45:01 INFO - PROCESS | 1648 | Values: 1365.2 1456.2 1487.3 1643.6 1830.4 7411.4 7776.4 8062.5 8285.6 8314.5 8203.1 8308.9 8312.0 8312.4 8331.9 1999.4 2265.1 2300.1 2302.2 2306.1 1745.4 2222.0 2293.5 2297.0 2310.4 2284.3 2284.9 2287.3 2292.3 2294.1 2230.8 2283.0 2290.9 2293.4 2293.7 1840.4 2274.9 2302.6 2303.0 2304.8 8227.1 8231.9 8279.0 8308.4 8380.8 4925.1 5112.3 5116.8 5125.6 5126.2 3321.6 3332.9 3416.6 3434.3 3450.0 881.5 999.8 1078.0 1082.1 1082.1 10821.9 10903.2 10925.5 10960.2 10997.5 4398.2 4492.0 4670.8 4673.9 4700.3 9325.4 9331.9 9345.6 9351.0 9353.5 4277.4 5101.0 5110.5 5110.8 5115.3 4603.4 4639.7 4645.9 4650.0 4707.6 3701.4 3707.7 3752.9 3802.3 3826.1 1236.3 1239.3 1245.9 1252.0 1255.8 763.3 807.2 868.1 871.5 888.6 5571.0 5647.3 5670.1 5701.6 5840.6 423.9 427.9 429.3 434.0 442.3 3858.4 3865.5 3949.5 3952.8 4029.4 9460.3 9956.0 9957.3 9981.7 9982.8 9418.2 9658.4 9839.0 9840.1 10023.6 6814.3 7101.6 7490.4 7683.4 7743.8 5523.2 5547.5 5644.5 5737.5 6008.4 9160.2 9170.8 9175.1 9300.2 9345.1 9281.4 9374.6 9499.2 9501.3 9503.0 6984.8 7212.4 7218.9 7430.8 7532.5 7585.5 7819.6 7902.4 7905.1 7951.1 7037.2 7047.6 7056.3 7056.9 7078.2 6803.4 6813.3 6888.1 6980.5 7022.1 6502.1 6629.0 6636.7 6637.9 6638.7 4691.4 4773.8 4849.6 4897.9 4919.9 3825.5 4694.7 4735.0 4967.8 5045.6 06:45:01 INFO - PROCESS | 1648 | 06:45:01 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4376.65 Median:4962.18 stddev:1365.86 (27.5%) stddev-sans-first:1334.86 06:45:01 INFO - PROCESS | 1648 | Values: 292.8 304.7 308.3 314.1 314.6 5236.9 5253.3 5256.4 5258.9 5264.3 4739.8 5186.4 5195.5 5224.6 5255.6 3303.8 3673.6 3760.5 3883.6 3916.6 3087.4 3654.3 3848.0 3987.8 4054.5 3411.3 3967.2 3988.3 4001.8 4039.4 3210.9 3291.4 3755.0 3832.9 4016.5 3441.8 3453.8 3458.0 3477.4 3486.6 4239.2 4620.7 4712.6 4810.4 5115.8 4155.0 4521.5 4555.7 4582.6 4591.7 4930.8 5431.4 5466.9 5481.4 5489.6 3291.3 3477.7 3693.6 3748.8 3807.9 4726.4 5000.2 5455.3 5711.3 5721.8 3317.9 3590.3 3774.9 3792.0 3839.6 3829.3 3841.3 3847.7 3849.4 3889.2 4321.6 4495.3 4515.9 4518.5 4553.6 4595.2 4879.5 5413.5 5475.0 5521.4 1117.3 1214.9 1217.9 1233.7 1241.5 739.9 797.8 836.9 839.7 843.7 4340.4 4946.7 5120.5 5143.7 5159.6 4753.8 5570.4 5663.7 5706.1 5752.9 4957.5 5203.9 5208.7 5217.3 5241.9 2261.5 2438.6 2718.7 2721.8 2831.8 4788.2 5493.8 5524.3 5598.5 5598.6 4553.2 4641.5 5204.5 5324.2 5428.7 4794.6 5123.6 5398.5 5401.0 5549.8 4559.6 5250.8 5264.7 5293.6 5332.3 4725.4 5205.3 5245.8 5262.6 5728.6 4986.9 5907.7 5968.8 5980.9 5994.5 3250.8 3386.6 3825.8 3853.3 3862.7 4966.9 5036.6 5057.9 5792.8 5835.7 5507.7 5522.8 5527.9 5582.6 5652.3 5126.9 5298.9 5489.8 5537.4 5573.4 5093.1 5281.1 5379.6 5383.3 5449.0 4539.4 5266.9 5439.7 5519.5 5554.8 4695.6 5306.6 5434.5 5487.8 5494.5 06:45:01 INFO - PROCESS | 1648 | 06:45:01 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:20411.20 Median:4147.10 stddev:30153.53 (727.1%) stddev-sans-first:30201.73 06:45:01 INFO - PROCESS | 1648 | Values: 681.2 715.7 716.7 760.3 764.3 14757.4 15545.3 15559.9 15582.1 15600.0 13786.4 13901.0 13910.0 13914.1 13934.7 638.8 658.6 661.8 811.8 827.2 797.0 821.6 823.7 824.3 827.2 859.3 872.1 873.0 874.5 876.3 867.9 869.7 870.1 870.3 870.6 499.9 510.2 517.5 645.6 645.6 11805.8 11867.9 11884.8 12673.0 13080.7 13637.2 13734.0 14103.3 14292.6 14583.9 11242.0 11269.0 11317.2 11400.3 11558.4 3645.4 3650.5 3717.4 3721.2 3783.2 112096.0 116276.0 116446.3 117715.0 119017.0 10329.7 10465.5 10494.7 10551.9 10792.8 22944.4 22947.8 22952.5 22964.5 22994.9 7701.8 7785.7 7794.8 7973.8 8021.2 4069.9 4110.9 4142.6 4151.6 4214.0 3315.4 3411.9 3428.7 3504.1 3523.2 599.9 607.7 624.8 626.0 636.9 557.3 611.3 627.4 635.5 637.5 8570.3 8679.0 8891.3 9011.7 9152.0 573.9 621.4 636.8 641.4 661.1 3462.5 4200.8 4434.6 4501.3 4534.2 88872.0 92693.5 96595.0 101094.0 101273.0 84696.0 90144.0 91983.0 92007.0 93988.1 50741.0 76348.0 77080.2 77534.2 79630.6 7619.1 9023.9 9458.5 9477.0 9574.8 43736.8 53360.7 53824.0 54887.7 55910.7 71022.0 73025.0 75838.6 76594.6 76984.0 10434.4 11944.9 12056.6 12191.2 12268.6 13606.3 13925.6 13944.0 14081.3 14220.1 12838.4 12936.9 12983.2 13145.6 13287.9 11480.5 11511.0 11660.6 12425.2 12833.6 12325.7 12333.9 12574.8 12597.9 12615.9 10044.7 10190.9 10197.6 10320.6 10767.9 10601.5 10812.2 10872.8 10882.1 10896.4 06:45:01 INFO - PROCESS | 1648 | -------- Summary: end -------- 06:45:01 INFO - PROCESS | 1648 | 06:45:02 INFO - TEST-INFO | 1648: exit 0 06:45:02 INFO - TEST-OK | dromaeo_css | took 1120467ms 06:45:02 INFO - TEST-START | kraken 06:45:02 INFO - operating with platform_type : mac_ 06:45:02 INFO - Initialising browser for kraken test... 06:45:02 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/tmpEP3w9k/profile http://localhost:49244/getInfo.html) 06:45:05 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 06:45:05 INFO - PROCESS | 1654 | colorDepth:24 06:45:05 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 06:45:05 INFO - PROCESS | 1654 | __metrics 06:45:05 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:45:05 INFO - PROCESS | 1654 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:45:06 INFO - TEST-INFO | 1654: exit 0 06:45:06 INFO - Browser initialized. 06:45:06 INFO - Running cycle 1/1 for kraken test... 06:45:06 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/tmpEP3w9k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:45:18 INFO - PROCESS | 1656 | RSS: Main: 245309440 06:45:18 INFO - PROCESS | 1656 | 06:45:21 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 06:45:22 INFO - PROCESS | 1656 | RSS: Main: 296738816 06:45:22 INFO - PROCESS | 1656 | 06:45:25 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 06:45:25 INFO - PROCESS | 1656 | RSS: Main: 298905600 06:45:25 INFO - PROCESS | 1656 | 06:45:29 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 06:45:29 INFO - PROCESS | 1656 | RSS: Main: 391770112 06:45:29 INFO - PROCESS | 1656 | 06:45:31 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 06:45:32 INFO - PROCESS | 1656 | RSS: Main: 292790272 06:45:32 INFO - PROCESS | 1656 | 06:45:34 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:45:34 INFO - PROCESS | 1656 | RSS: Main: 293474304 06:45:34 INFO - PROCESS | 1656 | 06:45:37 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 06:45:38 INFO - PROCESS | 1656 | RSS: Main: 336207872 06:45:38 INFO - PROCESS | 1656 | 06:45:41 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 06:45:41 INFO - PROCESS | 1656 | RSS: Main: 340258816 06:45:41 INFO - PROCESS | 1656 | 06:45:44 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 06:45:45 INFO - PROCESS | 1656 | RSS: Main: 335634432 06:45:45 INFO - PROCESS | 1656 | 06:45:47 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:45:47 INFO - PROCESS | 1656 | RSS: Main: 312430592 06:45:47 INFO - PROCESS | 1656 | 06:45:49 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:45:50 INFO - PROCESS | 1656 | RSS: Main: 316362752 06:45:50 INFO - PROCESS | 1656 | 06:45:52 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:45:53 INFO - PROCESS | 1656 | RSS: Main: 319062016 06:45:53 INFO - PROCESS | 1656 | 06:45:56 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:45:56 INFO - PROCESS | 1656 | RSS: Main: 335601664 06:45:56 INFO - PROCESS | 1656 | 06:45:59 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:46:00 INFO - PROCESS | 1656 | RSS: Main: 329138176 06:46:00 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 06:46:02 INFO - PROCESS | 1656 | RSS: Main: 373170176 06:46:02 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | __start_tp_report 06:46:02 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 06:46:02 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 06:46:02 INFO - PROCESS | 1656 | |i|pagename|runs| 06:46:02 INFO - PROCESS | 1656 | |0;ai-astar;114;117;115;116;115;115;115;115;116;116 06:46:02 INFO - PROCESS | 1656 | |1;audio-beat-detection;173;142;140;132;134;145;143;123;130;99 06:46:02 INFO - PROCESS | 1656 | |2;audio-dft;183;184;181;186;183;182;193;245;181;183 06:46:02 INFO - PROCESS | 1656 | |3;audio-fft;78;60;59;86;62;61;58;58;76;58 06:46:02 INFO - PROCESS | 1656 | |4;audio-oscillator;88;72;85;70;68;69;82;68;68;82 06:46:02 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;89;86;88;86;89;85;89;86;89;84 06:46:02 INFO - PROCESS | 1656 | |6;imaging-darkroom;104;137;94;94;94;93;93;94;93;93 06:46:02 INFO - PROCESS | 1656 | |7;imaging-desaturate;86;84;85;87;87;85;99;132;141;85 06:46:02 INFO - PROCESS | 1656 | |8;json-parse-financial;57;55;55;54;56;57;56;56;55;56 06:46:02 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;63;72;78;73;71;68;68;70;71;72 06:46:02 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;88;87;88;88;86;87;87;87;87;89 06:46:02 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;157;161;161;177;162;156;159;148;194;165 06:46:02 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;216;235;179;174;176;175;172;172;174;178 06:46:02 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;71;70;69;69;70;71;69;69;70;69 06:46:02 INFO - PROCESS | 1656 | __end_tp_report 06:46:02 INFO - PROCESS | 1656 | __start_cc_report 06:46:02 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2059 06:46:02 INFO - PROCESS | 1656 | __end_cc_report 06:46:02 INFO - PROCESS | 1656 | __startTimestamp1480430762613__endTimestamp 06:46:02 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | ------- Summary: start ------- 06:46:02 INFO - PROCESS | 1656 | Number of tests: 14 06:46:02 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.50 stddev:0.84 (0.7%) stddev-sans-first:0.73 06:46:02 INFO - PROCESS | 1656 | Values: 114.0 117.0 115.0 116.0 115.0 115.0 115.0 115.0 116.0 116.0 06:46:02 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:142.50 stddev:18.69 (13.1%) stddev-sans-first:14.28 06:46:02 INFO - PROCESS | 1656 | Values: 173.0 142.0 140.0 132.0 134.0 145.0 143.0 123.0 130.0 99.0 06:46:02 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:190.10 Median:183.50 stddev:19.60 (10.7%) stddev-sans-first:20.62 06:46:02 INFO - PROCESS | 1656 | Values: 183.0 184.0 181.0 186.0 183.0 182.0 193.0 245.0 181.0 183.0 06:46:02 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:65.60 Median:61.50 stddev:10.33 (16.8%) stddev-sans-first:9.93 06:46:02 INFO - PROCESS | 1656 | Values: 78.0 60.0 59.0 86.0 62.0 61.0 58.0 58.0 76.0 58.0 06:46:02 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:77.00 stddev:8.05 (10.5%) stddev-sans-first:7.08 06:46:02 INFO - PROCESS | 1656 | Values: 88.0 72.0 85.0 70.0 68.0 69.0 82.0 68.0 68.0 82.0 06:46:02 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:88.50 stddev:1.91 (2.2%) stddev-sans-first:1.90 06:46:02 INFO - PROCESS | 1656 | Values: 89.0 86.0 88.0 86.0 89.0 85.0 89.0 86.0 89.0 84.0 06:46:02 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:98.90 Median:93.50 stddev:13.80 (14.8%) stddev-sans-first:14.51 06:46:02 INFO - PROCESS | 1656 | Values: 104.0 137.0 94.0 94.0 94.0 93.0 93.0 94.0 93.0 93.0 06:46:02 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:85.50 stddev:21.31 (24.9%) stddev-sans-first:22.22 06:46:02 INFO - PROCESS | 1656 | Values: 86.0 84.0 85.0 87.0 87.0 85.0 99.0 132.0 141.0 85.0 06:46:02 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:0.95 (1.7%) stddev-sans-first:0.88 06:46:02 INFO - PROCESS | 1656 | Values: 57.0 55.0 55.0 54.0 56.0 57.0 56.0 56.0 55.0 56.0 06:46:02 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.50 stddev:3.89 (5.4%) stddev-sans-first:3.00 06:46:02 INFO - PROCESS | 1656 | Values: 63.0 72.0 78.0 73.0 71.0 68.0 68.0 70.0 71.0 72.0 06:46:02 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.50 stddev:0.84 (1.0%) stddev-sans-first:0.87 06:46:02 INFO - PROCESS | 1656 | Values: 88.0 87.0 88.0 88.0 86.0 87.0 87.0 87.0 87.0 89.0 06:46:02 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:164.00 Median:161.50 stddev:12.85 (8.0%) stddev-sans-first:13.38 06:46:02 INFO - PROCESS | 1656 | Values: 157.0 161.0 161.0 177.0 162.0 156.0 159.0 148.0 194.0 165.0 06:46:02 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.10 Median:177.00 stddev:21.88 (12.4%) stddev-sans-first:20.14 06:46:02 INFO - PROCESS | 1656 | Values: 216.0 235.0 179.0 174.0 176.0 175.0 172.0 172.0 174.0 178.0 06:46:02 INFO - PROCESS | 1656 | 06:46:02 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 06:46:02 INFO - PROCESS | 1656 | Values: 71.0 70.0 69.0 69.0 70.0 71.0 69.0 69.0 70.0 69.0 06:46:02 INFO - PROCESS | 1656 | -------- Summary: end -------- 06:46:02 INFO - PROCESS | 1656 | 06:46:03 INFO - TEST-INFO | 1656: exit 0 06:46:03 INFO - TEST-OK | kraken | took 61123ms 06:46:03 INFO - SUITE-END | took 1181s 06:46:03 INFO - Completed test suite (00:19:41) 06:46:03 INFO - javascript benchmark 06:46:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2960.230340111571, 3318.435865902796, 3344.5317655528215, 3347.7489188310883, 3386.6951974322324, 4624.699394539352, 5530.474604912527, 5579.972100139494, 5584.636998595089, 5600.467955544227, 4644.5123262057505, 5599.944000559994, 5674.858128546778, 5712.771489140429, 5725.770969161239, 4547.408836851205, 4952.653314268003, 5046.899062018758, 5120.23196520523, 5127.230915362707, 5157.484251574831, 5206.140986737184, 5232.607554433433, 5233.3981592116825, 5269.394019687747, 5045.495450454925, 5151.381834179903, 5167.147420675622, 5179.430262671103, 5234.424213336549, 4162.313218318974, 5081.898362032775, 5117.181250999822, 5145.0, 5152.690838549662, 5120.052790233819, 5130.871728206787, 5130.948690513122, 5131.0, 5136.101182293084, 5651.011073062197, 5653.4911857932575, 5662.292213473316, 5666.433356664342, 5679.204911312419, 5981.162637230791, 6082.665453400105, 6094.451499365034, 6109.480694141003, 6149.169862068608, 6269.780557680505, 6271.153394291803, 6281.591696539756, 6284.34014428483, 6289.622622642656, 5708.343540492813, 5750.539956803445, 5771.249737534177, 5779.971100144472, 5819.534437245053, 6165.04441811511, 6215.005599104122, 6219.129321894939, 6228.937710622927, 6315.147455093595, 6093.451589356979, 6134.447899689049, 6148.415900489446, 6148.9692551536955, 6152.354002829638, 6257.7184026718905, 6263.123162757218, 6264.5301602380005, 6275.278342990523, 6281.591696539802, 5977.820665379959, 6029.095635654599, 6101.816945491642, 6168.0, 6194.752209911643, 6096.451319381277, 6112.113743507255, 6141.915626108588, 6154.7230374633245, 6240.344763799826, 4870.853874383774, 4871.244957031666, 4881.219004959189, 4896.46138924718, 4903.779329930162, 4372.125574885035, 4393.802278897458, 4398.824047038082, 4405.9866230766465, 4431.180231657154, 4597.42532183477, 5151.356080489939, 5402.297701298806, 5619.690916999604, 5679.148127780783, 6162.137300777895, 6182.629042257479, 6189.752409903554, 6197.628142311476, 6203.0, 5650.915236271459, 5668.744906479218, 5679.460451257124, 5683.0, 5685.204071430003, 5303.814366497154, 5331.0, 5368.436314186954, 5384.434634363413, 5401.054815407288, 6330.588511746721, 6340.524460665469, 6346.30190679025, 6354.6822658867795, 6361.61830290184, 4836.613070954386, 6054.969725151346, 6061.060535616986, 6086.452219300284, 6293.181886354744, 5260.289860868734, 6176.598521096114, 6291.402316779899, 6351.68241587928, 6359.459445947146, 5159.509846564571, 6094.9085763714465, 6144.662043587646, 6167.290761562478, 6168.105624684305, 6063.514918806573, 6117.296510901303, 6233.407826256498, 6241.3134555197985, 6248.343923888108, 5151.6908985461, 5963.850903727442, 5964.433378829004, 6010.918034753787, 6084.421979911901, 6064.818055458343, 6089.786857460145, 6094.939050609437, 6097.969510152421, 6106.08408738675, 5689.146628005832, 5901.704914754331, 5907.586468947133, 5911.7930872420975, 5916.940830591811, 5823.854403639943, 5996.160537524837, 6025.156478092983, 6069.575129740876, 6140.017597184429, 5848.152017957457, 5906.911396328973, 5916.437938395846, 5924.289085309791, 5947.04847224442], "value": 5596.699735698353, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.2083193977846, 499.2202797028593, 501.49098664855154, 506.2937202602371, 510.72420892717935, 30073.548896766537, 30649.0, 31372.05883823489, 31450.213744656394, 31461.842690786572, 40371.0, 41801.372979405336, 41910.37134442978, 43800.56199438005, 43824.0, 9318.0, 9454.669086581971, 9467.195288400495, 9474.19469345103, 9485.62057517702, 8468.618912148937, 9305.11601397866, 9438.952805235964, 9446.291528135383, 9452.19656329213, 8568.78578035551, 11119.72200694981, 11349.375784331858, 11360.204785665006, 11598.130140239517, 11326.980571748541, 11368.488418021208, 11387.0, 11388.373639449826, 11392.658220253406, 8434.156584341517, 8859.734207973772, 9280.35037547372, 11153.832692509537, 11159.330440173615, 30529.0, 38283.80858095692, 38837.02907427309, 38969.41545876814, 40152.0, 3313.122022663996, 3366.293078453528, 3477.061193477772, 3579.982100089509, 3800.2399520095814, 29657.70342296571, 30071.0, 30315.696843031506, 30529.694703052908, 30629.38741225163, 3071.754259659222, 3176.8411579421168, 3188.0, 3233.547303377529, 3294.5058241264, 318954.0, 321335.0, 321484.0, 321717.39141304145, 321980.0, 57326.566835829435, 57461.712691436274, 57503.1374529374, 57550.848983020944, 57561.42438575561, 60605.0, 60664.0, 60807.479813004145, 60837.69581152066, 60872.78254434886, 14512.709745805025, 15099.39602415891, 15102.773458398133, 15141.545753627408, 15149.469768558047, 11657.417129143509, 11733.120015998835, 11737.530498780125, 11744.412779361168, 11744.94127529374, 11978.04175665962, 14542.854571454362, 15730.528084157264, 16438.260278287507, 16473.01161930288, 5865.765369385177, 6960.686769095301, 6987.406070483964, 7105.25394833535, 7159.248278930741, 821.6343727041528, 843.8059246373246, 987.8518222266574, 1041.4532370505394, 1122.7024838417826, 25358.239252822445, 28802.84788608432, 28803.711962880523, 29435.558466623017, 29461.11616651504, 876.4303202918154, 1058.862347894784, 1077.9676609701721, 1094.0, 1176.588194132064, 14966.578175073351, 15013.174275414738, 15072.573873405565, 15371.0, 15442.768358474632, 539687.0, 767511.0, 776206.0, 776759.0, 777048.1147594226, 48555.02889942181, 49487.25769113466, 49490.25764613534, 56140.43859561434, 57058.429415706145, 1195.754870251579, 1309.2537253765263, 1386.2791348498927, 1387.070662656023, 1392.1090502078475, 24104.87947560251, 29711.40577188401, 31237.375252495276, 31315.84342078275, 32472.0, 54958.45041549533, 56870.7156464215, 59003.409965899795, 59220.70389648024, 61474.0, 384562.0, 411527.0, 414278.0, 548686.0, 592776.0, 41578.168436631706, 41597.168056639304, 42168.578314216466, 42346.0, 42827.357589635554, 45845.77077114727, 45920.770396147804, 46835.76582117204, 46936.7653161732, 47124.52875471202, 38247.80876095602, 38360.2327953445, 38719.80640096894, 40436.59563404328, 40767.796161019, 38270.0, 38400.80799596096, 38584.0, 39720.80139599399, 40033.0, 37472.437913430775, 37957.810210948766, 38285.0, 38354.42468362921, 38410.80794596009, 31022.68977310198, 33393.83303083469, 34132.829335854156, 34335.0, 34474.0, 23000.76999229986, 24922.0, 24939.127130550343, 25193.748062519142, 25770.226893193234], "value": 19550.09773827151, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.0684756003328, 322.77405815928853, 362.7587654209951, 366.29671031619307, 374.3897447161128, 14199.503017394392, 15586.766198507017, 18610.0, 18795.62408751824, 20269.885156316395, 18034.458966231035, 18473.261069557237, 18702.532436689056, 18842.05789710516, 18860.962647054406, 5377.381601115882, 5503.449655034495, 5643.858903527424, 5710.857228569277, 5711.05767548354, 3981.7411868228473, 5592.0773072443, 5715.342735585398, 5728.0, 5733.312002559699, 4183.3097538906195, 4192.4759405074365, 6245.718942647592, 6303.747850085991, 6310.621362718229, 6219.484189190545, 6268.122462855158, 6295.338989406115, 6297.118403423525, 6302.369763023684, 5199.454057323965, 5408.188771684239, 5412.431694672042, 5412.56699464042, 5424.864378390572, 22318.665220021714, 23489.41276468085, 24047.879760601085, 24136.75863241363, 24325.391865203335, 2236.888155592214, 2243.596152692515, 2480.4790993891306, 2771.0, 2847.7579405750535, 9495.003024682377, 9528.82337457225, 9546.522673866279, 9963.252756043326, 9988.95005524975, 1762.55936015996, 1777.9377721779806, 1783.4025601423539, 1800.3968670495399, 1806.6838303297002, 92755.53622231845, 100276.0, 111434.3284850728, 118618.99999999914, 118737.0, 9284.675036373694, 10114.393136411838, 10260.538275777608, 11040.834387484194, 11192.832107518394, 12375.638679745221, 13507.122037067558, 13609.455621775216, 13740.312984350743, 14107.858921410654, 7854.136045035041, 7877.960610197027, 7903.774914888201, 8020.679172833022, 8066.7579972600915, 7682.692692292246, 7694.499857509244, 7695.769126926201, 7848.372130229682, 7856.803579910548, 4358.128374325148, 4359.215341238544, 4365.869023929287, 4378.5183629800695, 4428.7121337112985, 1692.889962152456, 1820.854331653491, 1830.423416623786, 1879.3140503716045, 1880.877742946704, 869.5956380283199, 872.4285592936636, 873.2097451806126, 945.3382632157517, 956.5695437053354, 14845.0, 18848.15183316754, 19488.343490803156, 19765.505862353268, 20204.292849750484, 891.7681402835309, 897.1297841094129, 920.2959735802117, 960.3949511807516, 975.9512024398751, 9899.27769863279, 10336.379817210842, 10338.328008679411, 10339.224558158168, 10394.428306443218, 431696.0, 438869.8056509697, 499076.0, 503229.4838525784, 510975.0, 137785.0, 138580.30709846588, 140900.0, 142150.0, 142513.28743356216, 974.1962880623514, 986.8125056239148, 1040.6513817871098, 1042.61944390297, 1043.8642976413018, 16965.575860603585, 17941.641167176844, 18074.0, 18457.892526448457, 18814.811851881306, 54072.72963635156, 54375.64060898351, 55602.49788759435, 56290.718546407006, 57197.71401142968, 74287.0, 80376.59811700904, 80474.0, 81082.0, 83582.16417835745, 6587.341265873374, 7556.1310449299035, 7679.078510578766, 7715.92284077152, 7755.650995705094, 10053.69838904834, 11780.410979450822, 12087.0, 12089.576864810042, 12126.211796233216, 9443.575039123118, 10078.395296281953, 10156.441395723306, 10443.112335451571, 10529.526171322155, 9300.534973251446, 9444.622215111318, 9896.554655040396, 9906.554205060645, 10005.549750261402, 10163.136133428445, 10245.080152156599, 10319.793604128026, 10386.272960892968, 10414.323069000491, 6684.866302674017, 7029.0, 7037.085178926707, 7262.782116536512, 7818.765437036898, 8317.792055198668, 9995.100440960348, 10199.7450063749, 10224.028717271847, 10843.783124337628], "value": 9038.196143890786, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.2218235605708, 1456.2063675296965, 1487.330701184467, 1643.621966947602, 1830.4417152768408, 7411.4070874330055, 7776.416768742346, 8062.516249025062, 8285.585720713956, 8314.501129932209, 8203.138670439608, 8308.91691083089, 8311.958440207805, 8312.376571757111, 8331.87502187466, 1999.3602047344782, 2265.082641530179, 2300.1374484568287, 2302.24026071396, 2306.123673004256, 1745.4240100766717, 2221.9555608887813, 2293.5298263855952, 2297.023764899919, 2310.376198426424, 2284.2918695204457, 2284.9200277990276, 2287.2680742162515, 2292.277932451281, 2294.105298933409, 2230.788075132868, 2282.954340913189, 2290.919817806369, 2293.4266433391567, 2293.715519309192, 1840.392670418772, 2274.863508189514, 2302.5625131225183, 2302.9654555181687, 2304.8156147508157, 8227.095019547845, 8231.876521852177, 8279.0, 8308.376871734645, 8380.790480237982, 4925.064237794843, 5112.258722485256, 5116.846494605168, 5125.615578831603, 5126.2054381570915, 3321.64624318735, 3332.8500217490273, 3416.5558477398026, 3434.347473979936, 3450.0, 881.5460038080394, 999.8050380175796, 1077.9676609701721, 1082.0532034469838, 1082.0955118990555, 10821.945890270577, 10903.182261330432, 10925.508352124174, 10960.177986651033, 10997.505112269968, 4398.208322501916, 4492.0, 4670.80894371933, 4673.883152921204, 4700.294955756595, 9325.440473571607, 9331.860022099674, 9345.626174952926, 9351.018143094878, 9353.532323383804, 4277.443932288783, 5100.974495127575, 5110.48895110486, 5110.8466745997675, 5115.283860259567, 4603.424571928509, 4639.652026098056, 4645.9303110453375, 4650.0, 4707.646926480527, 3701.40777475608, 3707.721920855947, 3752.8686495973056, 3802.2585595809105, 3826.0730541136054, 1236.3262022197923, 1239.2750241108872, 1245.862955074941, 1252.0296770003138, 1255.8492980842175, 763.267263427105, 807.1968391450545, 868.1362044765499, 871.5250188647076, 888.5823662878437, 5570.972145139248, 5647.322321321468, 5670.06443936754, 5701.572382071361, 5840.591158618856, 423.94276772635914, 427.9465066866642, 429.2788115965208, 433.9674524410619, 442.25259311763017, 3858.4405261237525, 3865.536135663682, 3949.526056873136, 3952.7628342299554, 4029.37544680575, 9460.290478214161, 9955.950220248853, 9957.253206009578, 9981.650642227487, 9982.750431239132, 9418.19945304643, 9658.3722058066, 9839.016098390104, 9840.11438970496, 10023.649172278936, 6814.284500127515, 7101.573905565682, 7490.363319117827, 7683.385329173652, 7743.845123097619, 5523.226748255328, 5547.472990065938, 5644.463775941279, 5737.483626473638, 6008.429199226067, 9160.221381182673, 9170.770730731785, 9175.128362805523, 9300.162985331353, 9345.112214339626, 9281.350305478552, 9374.5781439834, 9499.240060794982, 9501.334906556474, 9502.952485237529, 6984.825379365353, 7212.386947109554, 7218.855622887408, 7430.814229644302, 7532.510386824839, 7585.469017168745, 7819.648115834915, 7902.446828721934, 7905.090914544671, 7951.085625153181, 7037.1555413350725, 7047.647617618996, 7056.294370562902, 7056.894146587702, 7078.1506219254015, 6803.387695107464, 6813.250542440427, 6888.138982627172, 6980.476464265099, 7022.08712867324, 6502.122213501306, 6628.966855165693, 6636.701348439428, 6637.867242655217, 6638.701258443478, 4691.390119284471, 4773.785179666854, 4849.563539281482, 4897.853064408074, 4919.901601967869, 3825.5026846509777, 4694.718316900997, 4734.976325118352, 4967.776450059829, 5045.646804723781], "value": 4270.565255969102, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.83454848010877, 304.73792538416956, 308.2509501910358, 314.1032352633231, 314.5784648570916, 5236.92144617831, 5253.343332083489, 5256.369235691723, 5258.949809110712, 5264.289320941672, 4739.81504623844, 5186.377634683843, 5195.454477279888, 5224.570574682772, 5255.579553635709, 3303.8182899940493, 3673.577538583057, 3760.5111335526344, 3883.611638836108, 3916.5900275900653, 3087.367089746597, 3654.3422184006868, 3847.9610505163587, 3987.7806720630356, 4054.5337286212166, 3411.317736452707, 3967.2462232175794, 3988.3020471417385, 4001.7799021053975, 4039.40443524809, 3210.871565137392, 3291.4240007998505, 3755.004923695223, 3832.938243847607, 4016.49793775778, 3441.8451169697173, 3453.792772433662, 3457.9827100864336, 3477.3914564951033, 3486.6164721880573, 4239.1521695660995, 4620.653450991189, 4712.6229901607785, 4810.39870016248, 5115.825774046016, 4155.002799328139, 4521.502634710179, 4555.703879247872, 4582.587567118975, 4591.701539399962, 4930.778114984834, 5431.375391829951, 5466.9179962300595, 5481.369642491085, 5489.58828087891, 3291.2923721399775, 3477.661100476335, 3693.6306369362846, 3748.7947804627197, 3807.8766763804742, 4726.432828060655, 5000.224965130447, 5455.344918904344, 5711.286089238845, 5721.7711291548285, 3317.8506967186536, 3590.3178396105177, 3774.8867533974026, 3791.962080379216, 3839.5968423315708, 3829.2532956073296, 3841.250956063541, 3847.7498962567342, 3849.4418309344987, 3889.2221555688975, 4321.601511161336, 4495.348174514677, 4515.932261016087, 4518.502964673883, 4553.590176884097, 4595.172868883633, 4879.536444037882, 5413.458654134633, 5474.972625136849, 5521.432533871769, 1117.284937639911, 1214.9453274602663, 1217.8538575370835, 1233.6669099343128, 1241.522014024607, 739.8901647528706, 797.8244786147038, 836.8744039267176, 839.6683310092479, 843.6751850537587, 4340.370646256339, 4946.703197808143, 5120.462351453119, 5143.665661731976, 5159.613029022838, 4753.809847606126, 5570.359408667974, 5663.688497132614, 5706.087026075891, 5752.884942301131, 4957.4886852964355, 5203.855151866584, 5208.687478751287, 5217.269582258411, 5241.868953276198, 2261.5250797332415, 2438.5854404751235, 2718.7417195366406, 2721.8094733368475, 2831.844248566307, 4788.209945358977, 5493.835184944458, 5524.254225679562, 5598.524125449301, 5598.58010649203, 4553.180427523078, 4641.489436162019, 5204.479552044841, 5324.1747529133045, 5428.674279543161, 4794.568488836021, 5123.590112790967, 5398.541124004503, 5401.0, 5549.833504994856, 4559.635229181591, 5250.763715632729, 5264.684118952875, 5293.60297977661, 5332.33345831771, 4725.385699859134, 5205.349331333583, 5245.826275103507, 5262.605304602093, 5728.598998070262, 4986.933036182794, 5907.675077870758, 5968.820935371946, 5980.880382392241, 5994.490468310242, 3250.7724459287624, 3386.559747232844, 3825.846966121324, 3853.306404847154, 3862.710296727813, 4966.8758281043265, 5036.622253331088, 5057.887264801738, 5792.82621521355, 5835.67903765297, 5507.7246137693755, 5522.779088836402, 5527.861803454945, 5582.581306402118, 5652.3217213934595, 5126.871828204325, 5298.860744939857, 5489.752961116679, 5537.42183477723, 5573.442655734556, 5093.122385851982, 5281.102212623787, 5379.569634429315, 5383.327084114486, 5448.972755136199, 4539.432570928634, 5266.865510574181, 5439.700816455133, 5519.530839878656, 5554.833354999357, 4695.55830967888, 5306.628536002443, 5434.510894019557, 5487.835364939058, 5494.532964698045], "value": 3937.6426608884135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.2131987554375, 715.7244460882558, 716.6667499612679, 760.3043215457857, 764.3426653078349, 14757.409703611842, 15545.300461479232, 15559.92220038901, 15582.142982135992, 15600.0, 13786.448542058331, 13900.957428192876, 13909.956753243521, 13914.095583787046, 13934.721305573883, 638.7987783848096, 658.6180015590945, 661.7683810666276, 811.8254575266317, 827.1563005734148, 797.0475282037967, 821.6179476543406, 823.7281697039992, 824.3281725393815, 827.2224109337234, 859.256742917375, 872.1322284327103, 873.0004145253681, 874.45783614159, 876.303338845616, 867.9479231246114, 869.652139144341, 870.0690261420219, 870.277669534285, 870.6169285514353, 499.865305755932, 510.2066286923832, 517.4721783780523, 645.6094063091856, 645.6126324205486, 11805.822912656316, 11867.881321186764, 11884.821727674092, 12673.0, 13080.738385232336, 13637.249951252677, 13734.0, 14103.294835258299, 14292.642683932881, 14583.854161458356, 11242.0, 11268.985791278825, 11317.207795454322, 11400.25898316615, 11558.364289964049, 3645.4167333226824, 3650.5450882214927, 3717.442383642448, 3721.1999420124803, 3783.2244389900006, 112096.0, 116276.0, 116446.25330620048, 117714.99999999914, 119017.0, 10329.741756455998, 10465.47672616366, 10494.73763155912, 10551.894481055091, 10792.838107428395, 22944.4263893404, 22947.770522294897, 22952.540949180922, 22964.540709186058, 22994.8850255751, 7701.768946931601, 7785.688572457038, 7794.844103117905, 7973.8405231896195, 8021.197880212048, 4069.89825254371, 4110.917781644351, 4142.627163555295, 4151.564085771011, 4214.030772922245, 3315.3700796849002, 3411.914702132417, 3428.708559772397, 3504.0889368763796, 3523.207278362348, 599.9220101386792, 607.738672370876, 624.8188025472652, 626.0484064222447, 636.933122022181, 557.2950217974266, 611.3061674998909, 627.4133685004535, 635.463033736492, 637.5154882289494, 8570.271526920156, 8678.956605216934, 8891.288696904361, 9011.684591039282, 9152.0, 573.896698594257, 621.3662064693987, 636.7803107927757, 641.4323323858418, 661.1438187547138, 3462.532558104674, 4200.831966721297, 4434.600885920283, 4501.257292546693, 4534.183846907588, 88872.0, 92693.53653231691, 96595.0, 101093.98906010993, 101273.0, 84696.0, 90144.0, 91983.0, 92007.0, 93988.06011939792, 50741.0, 76348.0, 77080.2291977073, 77534.22465775383, 79630.6018469904, 7619.08570971487, 9023.909760902307, 9458.527073646428, 9476.95261523688, 9574.808503830023, 43736.78131609321, 53360.73319633377, 53824.0, 54887.72556137194, 55910.72044639751, 71022.0, 73025.0, 75838.62080689562, 76594.61702691451, 76984.0, 10434.37393756377, 11944.880551194377, 12056.578019769266, 12191.245414288613, 12268.570600028956, 13606.319684015562, 13925.582232533041, 13944.0, 14081.295935203403, 14220.146791192561, 12838.42227099764, 12936.935315323362, 12983.156094853804, 13145.60563183106, 13287.867121328663, 11480.483378248166, 11511.0, 11660.591879284184, 12425.19236249641, 12833.614991550268, 12325.691857703629, 12333.876661233631, 12574.811377829523, 12597.874021260037, 12615.936920315708, 10044.698659040241, 10190.949045254727, 10197.643082492077, 10320.638777642747, 10767.946160269463, 10601.469926503798, 10812.243142979916, 10872.782544349227, 10882.075023623082, 10896.400697961688], "value": 7173.151925037933, "unit": "score"}], "name": "dromaeo_css", "value": 7016.285160269075, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 115.0, 116.0, 115.0, 115.0, 115.0, 115.0, 116.0, 116.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 142.0, 140.0, 132.0, 134.0, 145.0, 143.0, 123.0, 130.0, 99.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 181.0, 186.0, 183.0, 182.0, 193.0, 245.0, 181.0, 183.0], "value": 190.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 60.0, 59.0, 86.0, 62.0, 61.0, 58.0, 58.0, 76.0, 58.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 85.0, 70.0, 68.0, 69.0, 82.0, 68.0, 68.0, 82.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 86.0, 89.0, 85.0, 89.0, 86.0, 89.0, 84.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 137.0, 94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 93.0, 93.0], "value": 98.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 87.0, 87.0, 85.0, 99.0, 132.0, 141.0, 85.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 54.0, 56.0, 57.0, 56.0, 56.0, 55.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 72.0, 78.0, 73.0, 71.0, 68.0, 68.0, 70.0, 71.0, 72.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 88.0, 86.0, 87.0, 87.0, 87.0, 87.0, 89.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 161.0, 161.0, 177.0, 162.0, 156.0, 159.0, 148.0, 194.0, 165.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [216.0, 235.0, 179.0, 174.0, 176.0, 175.0, 172.0, 172.0, 174.0, 178.0], "value": 185.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 69.0, 69.0, 70.0, 71.0, 69.0, 69.0, 70.0, 69.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1498.0000000000002, "alertThreshold": 2.0}]} 06:46:03 INFO - Return code: 0 06:46:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:46:03 INFO - # TBPL SUCCESS # 06:46:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:46:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:46:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:46:03 INFO - 2016-11-29 06:46:03.938 screenresolution[1660:9938] starting screenresolution argv=screenresolution get 06:46:03 INFO - 2016-11-29 06:46:03.942 screenresolution[1660:9938] Display 0: 1600x1200x32@60 06:46:03 INFO - 2016-11-29 06:46:03.949 screenresolution[1661:9941] starting screenresolution argv=screenresolution list 06:46:03 INFO - Available Modes on Display 0 06:46:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:46:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:46:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:46:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:46:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:46:04 INFO - Intel Iris: 06:46:04 INFO - Chipset Model: Intel Iris 06:46:04 INFO - Type: GPU 06:46:04 INFO - Bus: Built-In 06:46:04 INFO - VRAM (Dynamic, Max): 1536 MB 06:46:04 INFO - Vendor: Intel (0x8086) 06:46:04 INFO - Device ID: 0x0a2e 06:46:04 INFO - Revision ID: 0x0009 06:46:04 INFO - Displays: 06:46:04 INFO - Display: 06:46:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:46:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:46:04 INFO - Display Serial Number: 1600x1200 60 06:46:04 INFO - Main Display: Yes 06:46:04 INFO - Mirror: Off 06:46:04 INFO - Online: Yes 06:46:04 INFO - Rotation: Supported 06:46:04 INFO - Return code: 0 06:46:04 INFO - Running post-action listener: _resource_record_post_action 06:46:04 INFO - [mozharness: 2016-11-29 14:46:04.202590Z] Finished run-tests step (success) 06:46:04 INFO - Running post-run listener: _resource_record_post_run 06:46:04 INFO - Total resource usage - Wall time: 1215s; CPU: 53.0%; Read bytes: 32283648; Write bytes: 691538944; Read time: 198; Write time: 1991 06:46:04 INFO - TinderboxPrint: CPU usage
53.5% 06:46:04 INFO - TinderboxPrint: I/O read bytes / time
32,283,648 / 198 06:46:04 INFO - TinderboxPrint: I/O write bytes / time
691,538,944 / 1,991 06:46:04 INFO - TinderboxPrint: CPU idle
2,261.5 (46.5%) 06:46:04 INFO - TinderboxPrint: CPU system
971.6 (20.0%) 06:46:04 INFO - TinderboxPrint: CPU user
1,628.5 (33.5%) 06:46:04 INFO - TinderboxPrint: Swap in / out
411,721,728 / 0 06:46:04 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 370457088; Write bytes: 367793664; Read time: 28133; Write time: 791 06:46:04 INFO - run-tests - Wall time: 1183s; CPU: 53.0%; Read bytes: 30477312; Write bytes: 304276992; Read time: 181; Write time: 1148 06:46:04 INFO - Running post-run listener: _upload_blobber_files 06:46:04 INFO - Blob upload gear active. 06:46:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:46:04 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 06:46:04 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'] 06:46:04 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 06:46:05 INFO - (blobuploader) - INFO - Open directory for files ... 06:46:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:46:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:46:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:46:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:46:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:46:05 INFO - (blobuploader) - INFO - Done attempting. 06:46:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:46:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:46:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:46:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:46:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:46:06 INFO - (blobuploader) - INFO - Done attempting. 06:46:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:46:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:46:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:46:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:46:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:46:09 INFO - (blobuploader) - INFO - Done attempting. 06:46:09 INFO - (blobuploader) - INFO - Iteration through files over. 06:46:09 INFO - Return code: 0 06:46:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:46:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:46:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b729fbaf3a1ec276b6ff55993d9837eb8f059763e8b0c9059dc7c2e4d5567d53a3ab77ea127aec3833043a6c35a1a52e9a0b8ff399332707ee9628e79a8029a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0876b78b10eeaaf4564274b8943aed2134e0f6116f6dfe4496b46ae3ef87261e48b2c40b55dc645c20c56a07737d0abec29227b0f32a04b0a0ba6f1c7ac5ddb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50066e155c654ad594db52749f694b3ac1366a3ea0ce48f4a775d003f6b8d6eca4689824074edf141e00032782454f68131154ab9113b369289a486361986fde"} 06:46:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:46:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:46:09 INFO - Contents: 06:46:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b729fbaf3a1ec276b6ff55993d9837eb8f059763e8b0c9059dc7c2e4d5567d53a3ab77ea127aec3833043a6c35a1a52e9a0b8ff399332707ee9628e79a8029a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0876b78b10eeaaf4564274b8943aed2134e0f6116f6dfe4496b46ae3ef87261e48b2c40b55dc645c20c56a07737d0abec29227b0f32a04b0a0ba6f1c7ac5ddb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50066e155c654ad594db52749f694b3ac1366a3ea0ce48f4a775d003f6b8d6eca4689824074edf141e00032782454f68131154ab9113b369289a486361986fde"} 06:46:09 INFO - Running post-run listener: copy_logs_to_upload_dir 06:46:09 INFO - Copying logs to upload dir... 06:46:09 INFO - mkdir: /builds/slave/test/build/upload/logs 06:46:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.964454 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-11-29 06:46:09.696611) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 06:46:09.700041) ========= 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.kSVDu3HSpY/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.7Jyba4I2Ct/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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/1b729fbaf3a1ec276b6ff55993d9837eb8f059763e8b0c9059dc7c2e4d5567d53a3ab77ea127aec3833043a6c35a1a52e9a0b8ff399332707ee9628e79a8029a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0876b78b10eeaaf4564274b8943aed2134e0f6116f6dfe4496b46ae3ef87261e48b2c40b55dc645c20c56a07737d0abec29227b0f32a04b0a0ba6f1c7ac5ddb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50066e155c654ad594db52749f694b3ac1366a3ea0ce48f4a775d003f6b8d6eca4689824074edf141e00032782454f68131154ab9113b369289a486361986fde"} build_url:https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010971 build_url: 'https://queue.taskcluster.net/v1/task/OgYVCpFgQjm6tEKbakqyTg/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/1b729fbaf3a1ec276b6ff55993d9837eb8f059763e8b0c9059dc7c2e4d5567d53a3ab77ea127aec3833043a6c35a1a52e9a0b8ff399332707ee9628e79a8029a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0876b78b10eeaaf4564274b8943aed2134e0f6116f6dfe4496b46ae3ef87261e48b2c40b55dc645c20c56a07737d0abec29227b0f32a04b0a0ba6f1c7ac5ddb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50066e155c654ad594db52749f694b3ac1366a3ea0ce48f4a775d003f6b8d6eca4689824074edf141e00032782454f68131154ab9113b369289a486361986fde"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 06:46:09.734878) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 06:46:09.735205) ========= 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.kSVDu3HSpY/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.7Jyba4I2Ct/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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.005052 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 06:46:09.785546) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 06:46:09.786006) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 06:46:09.786515) ========= ========= Total master_lag: 0.19 =========