builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0031 starttime: 1477758245.08 results: success (0) buildid: 20161029062601 builduid: 9c14fce5b57f453e81ed5d50bb1d4cb7 revision: 1b170b39ed6bdbde366233ab84594bdaaa960a5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 09:24:05.081886) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 09:24:05.082335) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 09:24:05.082603) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 09:24:05.107912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:24:05.108322) ========= 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.wP1CeuJ8jp/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.EyUv6TItdI/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-29 09:24:05-- 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% 39.9M=0s 2016-10-29 09:24:05 (39.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121657 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:24:05.253135) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:24:05.253450) ========= 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.wP1CeuJ8jp/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.EyUv6TItdI/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.026250 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:24:05.303092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-29 09:24:05.303559) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1b170b39ed6bdbde366233ab84594bdaaa960a5a --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 1b170b39ed6bdbde366233ab84594bdaaa960a5a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wP1CeuJ8jp/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.EyUv6TItdI/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-29 09:24:05,380 truncating revision to first 12 chars 2016-10-29 09:24:05,380 Setting DEBUG logging. 2016-10-29 09:24:05,380 attempt 1/10 2016-10-29 09:24:05,380 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1b170b39ed6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-29 09:24:06,499 unpacking tar archive at: mozilla-central-1b170b39ed6b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.362953 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-29 09:24:06.689552) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 09:24:06.689942) ========= script_repo_revision: 1b170b39ed6bdbde366233ab84594bdaaa960a5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 09:24:06.690435) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 09:24:06.690706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 09:24:06.709852) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-29 09:24:06.710325) ========= /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.wP1CeuJ8jp/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.EyUv6TItdI/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 09:24:06 INFO - MultiFileLogger online at 20161029 09:24:06 in /builds/slave/test 09:24:06 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 09:24:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:24:06 INFO - {'append_to_log': False, 09:24:06 INFO - 'base_work_dir': '/builds/slave/test', 09:24:06 INFO - 'blob_upload_branch': 'Firefox', 09:24:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:24:06 INFO - 'branch': 'Firefox', 09:24:06 INFO - 'buildbot_json_path': 'buildprops.json', 09:24:06 INFO - 'config_files': ('talos/mac_config.py',), 09:24:06 INFO - 'default_actions': ('clobber', 09:24:06 INFO - 'read-buildbot-config', 09:24:06 INFO - 'download-and-extract', 09:24:06 INFO - 'populate-webroot', 09:24:06 INFO - 'create-virtualenv', 09:24:06 INFO - 'install', 09:24:06 INFO - 'run-tests'), 09:24:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:24:06 INFO - 'download_minidump_stackwalk': True, 09:24:06 INFO - 'download_symbols': 'ondemand', 09:24:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:24:06 INFO - 'tooltool.py': '/tools/tooltool.py', 09:24:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:24:06 INFO - '/tools/misc-python/virtualenv.py')}, 09:24:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:24:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:24:06 INFO - 'installer_path': 'installer.exe', 09:24:06 INFO - 'log_level': 'info', 09:24:06 INFO - 'log_name': 'talos', 09:24:06 INFO - 'log_to_console': True, 09:24:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:24:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:24:06 INFO - 'opt_config_files': (), 09:24:06 INFO - 'pip_index': False, 09:24:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:24:06 INFO - 'cmd': ('bash', 09:24:06 INFO - '-c', 09:24:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:24:06 INFO - 'enabled': True, 09:24:06 INFO - 'halt_on_failure': False, 09:24:06 INFO - 'name': 'check_screen_resolution'},), 09:24:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:24:06 INFO - 'cmd': ('bash', 09:24:06 INFO - '-c', 09:24:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:24:06 INFO - 'enabled': True, 09:24:06 INFO - 'halt_on_failure': False, 09:24:06 INFO - 'name': 'check_screen_resolution'},), 09:24:06 INFO - 'run_cmd_checks_enabled': True, 09:24:06 INFO - 'sps_profile': False, 09:24:06 INFO - 'sps_profile_interval': 0, 09:24:06 INFO - 'suite': 'dromaeojs', 09:24:06 INFO - 'system_bits': '32', 09:24:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:24:06 INFO - 'title': 't-yosemite-r7-0031', 09:24:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:24:06 INFO - 'use_talos_json': True, 09:24:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:24:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:24:06 INFO - 'work_dir': 'build'} 09:24:06 INFO - [mozharness: 2016-10-29 16:24:06.914563Z] Running clobber step. 09:24:06 INFO - Running pre-action listener: _resource_record_pre_action 09:24:06 INFO - Running main action method: clobber 09:24:06 INFO - rmtree: /builds/slave/test/build 09:24:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:24:09 INFO - Running post-action listener: _resource_record_post_action 09:24:09 INFO - [mozharness: 2016-10-29 16:24:09.156293Z] Finished clobber step (success) 09:24:09 INFO - [mozharness: 2016-10-29 16:24:09.156426Z] Running read-buildbot-config step. 09:24:09 INFO - Running pre-action listener: _resource_record_pre_action 09:24:09 INFO - Running main action method: read_buildbot_config 09:24:09 INFO - Using buildbot properties: 09:24:09 INFO - { 09:24:09 INFO - "project": "", 09:24:09 INFO - "product": "firefox", 09:24:09 INFO - "script_repo_revision": "production", 09:24:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:24:09 INFO - "repository": "", 09:24:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:24:09 INFO - "buildid": "20161029062601", 09:24:09 INFO - "stage_platform": "macosx64", 09:24:09 INFO - "basedir": "/builds/slave/test", 09:24:09 INFO - "nightly_build": "True", 09:24:09 INFO - "buildnumber": 66, 09:24:09 INFO - "slavename": "t-yosemite-r7-0031", 09:24:09 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:24:09 INFO - "platform": "yosemite_r7", 09:24:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:24:09 INFO - "branch": "mozilla-central", 09:24:09 INFO - "repo_path": "mozilla-central", 09:24:09 INFO - "revision": "1b170b39ed6bdbde366233ab84594bdaaa960a5a", 09:24:09 INFO - "pgo_build": "False", 09:24:09 INFO - "builduid": "9c14fce5b57f453e81ed5d50bb1d4cb7", 09:24:09 INFO - "slavebuilddir": "test" 09:24:09 INFO - } 09:24:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 09:24:09 INFO - Running post-action listener: _resource_record_post_action 09:24:09 INFO - [mozharness: 2016-10-29 16:24:09.161485Z] Finished read-buildbot-config step (success) 09:24:09 INFO - [mozharness: 2016-10-29 16:24:09.161706Z] Running download-and-extract step. 09:24:09 INFO - Running pre-action listener: _resource_record_pre_action 09:24:09 INFO - Running main action method: download_and_extract 09:24:09 INFO - mkdir: /builds/slave/test/build/tests 09:24:09 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')]} 09:24:09 INFO - trying https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 09:24:09 INFO - Downloading https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:24:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 09:24:10 INFO - Downloaded 1199 bytes. 09:24:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:24:10 INFO - Using the following test package requirements: 09:24:10 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:24:10 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:24:10 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 09:24:10 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:24:10 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 09:24:10 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:24:10 INFO - u'jsshell-mac.zip'], 09:24:10 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:24:10 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 09:24:10 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:24:10 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:24:10 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 09:24:10 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:24:10 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 09:24:10 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:24:10 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 09:24:10 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:24:10 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 09:24:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:24:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:24:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:24:10 INFO - Fetch https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:24:11 INFO - Http code: 200 09:24:11 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 09:24:11 INFO - x-amz-cf-id: mkkfLNgZvjnbmhsgE4cUai-SMgI-GKKH-SFjEXP8WnK79J1WZh1c8Q== 09:24:11 INFO - x-amz-version-id: HW3ft5yw1SHcFxJJk7n5aSl9v2LtXEjj 09:24:11 INFO - Expected file size: 16391772 09:24:11 INFO - Obtained file size: 16391772 09:24:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:24:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:24:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:24:18 INFO - Fetch https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:24:18 INFO - Http code: 200 09:24:18 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 09:24:18 INFO - x-amz-cf-id: TASl14zB7jsE_Q00dr8LL571RpMsyN8Aj3TE1_Gqujm2NVB4OfFCBw== 09:24:18 INFO - x-amz-version-id: HW3ft5yw1SHcFxJJk7n5aSl9v2LtXEjj 09:24:19 INFO - Expected file size: 16391772 09:24:19 INFO - Obtained file size: 16391772 09:24:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 09:24:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:24:25 INFO - Fetch https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 09:24:26 INFO - Http code: 200 09:24:26 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 09:24:26 INFO - x-amz-cf-id: cLB2R_YY6ABMoEbxfY1JovTEICLexPvEAh8I-q4WMIot3d7oEa6KVw== 09:24:26 INFO - x-amz-version-id: 3JvNHSguuu.CqgE0yjZpeJnIbLAY9eJ5 09:24:26 INFO - Expected file size: 14409038 09:24:26 INFO - Obtained file size: 14409038 09:24:27 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')]} 09:24:27 INFO - trying https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:24:27 INFO - Downloading https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 09:24:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 09:24:29 INFO - Downloaded 112183969 bytes. 09:24:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:24:29 INFO - mkdir: /builds/slave/test/properties 09:24:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:24:29 INFO - Writing to file /builds/slave/test/properties/build_url 09:24:29 INFO - Contents: 09:24:29 INFO - build_url:https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:24:30 INFO - Running post-action listener: _resource_record_post_action 09:24:30 INFO - Running post-action listener: set_extra_try_arguments 09:24:30 INFO - [mozharness: 2016-10-29 16:24:30.923917Z] Finished download-and-extract step (success) 09:24:30 INFO - [mozharness: 2016-10-29 16:24:30.924030Z] Running populate-webroot step. 09:24:30 INFO - Running pre-action listener: _resource_record_pre_action 09:24:30 INFO - Running main action method: populate_webroot 09:24:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:24:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:24:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:24:30 INFO - '--tppagecycles', 09:24:30 INFO - '7'], 09:24:30 INFO - 'tests': ['tsvgm']}}, 09:24:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:24:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:24:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:24:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:24:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:24:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:24:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:30 INFO - 'talos_options': ['--disable-e10s'], 09:24:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:30 INFO - 'talos_options': ['--disable-e10s'], 09:24:30 INFO - 'tests': ['damp', 'tps']}, 09:24:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:30 INFO - 'tests': ['damp', 'tps']}, 09:24:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:24:30 INFO - 'tests': ['dromaeo_dom']}, 09:24:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:24:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:24:30 INFO - 'tests': ['basic_compositor_video']}, 09:24:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:24:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:24:30 INFO - 'tests': ['a11yr', 09:24:30 INFO - 'ts_paint', 09:24:30 INFO - 'tpaint', 09:24:30 INFO - 'sessionrestore', 09:24:30 INFO - 'sessionrestore_no_auto_restore', 09:24:30 INFO - 'tabpaint']}, 09:24:30 INFO - 'other-e10s': {'tests': ['a11yr', 09:24:30 INFO - 'ts_paint', 09:24:30 INFO - 'tpaint', 09:24:30 INFO - 'sessionrestore', 09:24:30 INFO - 'sessionrestore_no_auto_restore', 09:24:30 INFO - 'tabpaint']}, 09:24:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:24:30 INFO - 'ts_paint', 09:24:30 INFO - 'tpaint', 09:24:30 INFO - 'sessionrestore', 09:24:30 INFO - 'sessionrestore_no_auto_restore', 09:24:30 INFO - 'tabpaint']}, 09:24:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:24:30 INFO - 'ts_paint', 09:24:30 INFO - 'tpaint', 09:24:30 INFO - 'sessionrestore', 09:24:30 INFO - 'sessionrestore_no_auto_restore', 09:24:30 INFO - 'tabpaint']}, 09:24:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:24:30 INFO - 'tests': ['a11yr', 09:24:30 INFO - 'ts_paint', 09:24:30 INFO - 'tpaint', 09:24:30 INFO - 'sessionrestore', 09:24:30 INFO - 'sessionrestore_no_auto_restore', 09:24:30 INFO - 'tabpaint']}, 09:24:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:24:30 INFO - 'tests': ['a11yr', 09:24:30 INFO - 'ts_paint', 09:24:30 INFO - 'tpaint', 09:24:30 INFO - 'sessionrestore', 09:24:30 INFO - 'sessionrestore_no_auto_restore', 09:24:30 INFO - 'tabpaint']}, 09:24:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:24:30 INFO - 'tests': ['tsvgx', 09:24:30 INFO - 'tsvgr_opacity', 09:24:30 INFO - 'tart', 09:24:30 INFO - 'tscrollx', 09:24:30 INFO - 'cart']}, 09:24:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:24:30 INFO - 'tsvgr_opacity', 09:24:30 INFO - 'tart', 09:24:30 INFO - 'tscrollx', 09:24:30 INFO - 'cart']}, 09:24:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:30 INFO - 'talos_options': ['--disable-e10s'], 09:24:30 INFO - 'tests': ['tp5o']}, 09:24:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:30 INFO - 'tests': ['tp5o']}, 09:24:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:30 INFO - 'talos_options': ['--disable-e10s', 09:24:30 INFO - '--xperf_path', 09:24:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:30 INFO - 'tests': ['tp5n']}, 09:24:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:30 INFO - 'talos_options': ['--xperf_path', 09:24:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:30 INFO - 'tests': ['tp5n']}}, 09:24:30 INFO - 'talos.zip': {'path': '', 09:24:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:24:30 INFO - Running post-action listener: _resource_record_post_action 09:24:30 INFO - [mozharness: 2016-10-29 16:24:30.942702Z] Finished populate-webroot step (success) 09:24:30 INFO - [mozharness: 2016-10-29 16:24:30.942813Z] Running create-virtualenv step. 09:24:30 INFO - Running pre-action listener: _resource_record_pre_action 09:24:30 INFO - Running main action method: create_virtualenv 09:24:30 INFO - Creating virtualenv /builds/slave/test/build/venv 09:24:30 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 09:24:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:24:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:24:31 INFO - Using real prefix '/tools/python27' 09:24:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:24:31 INFO - Installing distribute.............................................................................................................................................................................................done. 09:24:34 INFO - Installing pip.................done. 09:24:34 INFO - Return code: 0 09:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:24:34 INFO - Reading from file tmpfile_stdout 09:24:34 INFO - Output received: 09:24:34 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) 09:24:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106994490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10690a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab094b0f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067a8d30>, '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 0x1065cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067a0b20>, '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.wP1CeuJ8jp/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.EyUv6TItdI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 09:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:24:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wP1CeuJ8jp/Render', 09:24:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:34 INFO - 'HOME': '/Users/cltbld', 09:24:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:34 INFO - 'LOGNAME': 'cltbld', 09:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:34 INFO - 'MOZ_NO_REMOTE': '1', 09:24:34 INFO - 'NO_EM_RESTART': '1', 09:24:34 INFO - 'PAGER': '/bin/cat', 09:24:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:34 INFO - 'PWD': '/builds/slave/test', 09:24:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:34 INFO - 'SHELL': '/bin/bash', 09:24:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EyUv6TItdI/Listeners', 09:24:34 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 09:24:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:34 INFO - 'USER': 'cltbld', 09:24:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:34 INFO - 'XPC_FLAGS': '0x0', 09:24:34 INFO - 'XPC_SERVICE_NAME': '0', 09:24:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:35 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 09:24:35 INFO - Cleaning up... 09:24:35 INFO - Return code: 0 09:24:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106994490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10690a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab094b0f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067a8d30>, '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 0x1065cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067a0b20>, '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.wP1CeuJ8jp/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.EyUv6TItdI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 09:24:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wP1CeuJ8jp/Render', 09:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:35 INFO - 'HOME': '/Users/cltbld', 09:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:35 INFO - 'LOGNAME': 'cltbld', 09:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:35 INFO - 'MOZ_NO_REMOTE': '1', 09:24:35 INFO - 'NO_EM_RESTART': '1', 09:24:35 INFO - 'PAGER': '/bin/cat', 09:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:35 INFO - 'PWD': '/builds/slave/test', 09:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:35 INFO - 'SHELL': '/bin/bash', 09:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EyUv6TItdI/Listeners', 09:24:35 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 09:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:35 INFO - 'USER': 'cltbld', 09:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:35 INFO - 'XPC_FLAGS': '0x0', 09:24:35 INFO - 'XPC_SERVICE_NAME': '0', 09:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:35 INFO - Downloading/unpacking psutil>=3.1.1 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:24:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:38 INFO - Installing collected packages: psutil 09:24:38 INFO - Running setup.py install for psutil 09:24:38 INFO - building 'psutil._psutil_osx' extension 09:24:38 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 09:24:39 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 09:24:39 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 09:24:39 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 09:24:39 INFO - building 'psutil._psutil_posix' extension 09:24:39 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 09:24:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:24:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:24:39 INFO - ^ 09:24:39 INFO - 1 warning generated. 09:24:39 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 09:24:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:40 INFO - Successfully installed psutil 09:24:40 INFO - Cleaning up... 09:24:40 INFO - Return code: 0 09:24:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106994490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10690a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab094b0f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067a8d30>, '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 0x1065cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067a0b20>, '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.wP1CeuJ8jp/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.EyUv6TItdI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 09:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:24:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wP1CeuJ8jp/Render', 09:24:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:40 INFO - 'HOME': '/Users/cltbld', 09:24:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:40 INFO - 'LOGNAME': 'cltbld', 09:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:40 INFO - 'MOZ_NO_REMOTE': '1', 09:24:40 INFO - 'NO_EM_RESTART': '1', 09:24:40 INFO - 'PAGER': '/bin/cat', 09:24:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:40 INFO - 'PWD': '/builds/slave/test', 09:24:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:40 INFO - 'SHELL': '/bin/bash', 09:24:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EyUv6TItdI/Listeners', 09:24:40 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 09:24:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:40 INFO - 'USER': 'cltbld', 09:24:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:40 INFO - 'XPC_FLAGS': '0x0', 09:24:40 INFO - 'XPC_SERVICE_NAME': '0', 09:24:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:24:40 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 09:24:40 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 09:24:40 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 09:24:40 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 09:24:40 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 09:24:40 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 09:24:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:24:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:24:42 INFO - Installing collected packages: mozsystemmonitor 09:24:42 INFO - Running setup.py install for mozsystemmonitor 09:24:43 INFO - Successfully installed mozsystemmonitor 09:24:43 INFO - Cleaning up... 09:24:43 INFO - Return code: 0 09:24:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106994490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10690a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab094b0f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067a8d30>, '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 0x1065cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067a0b20>, '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.wP1CeuJ8jp/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.EyUv6TItdI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 09:24:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:24:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wP1CeuJ8jp/Render', 09:24:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:43 INFO - 'HOME': '/Users/cltbld', 09:24:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:43 INFO - 'LOGNAME': 'cltbld', 09:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:43 INFO - 'MOZ_NO_REMOTE': '1', 09:24:43 INFO - 'NO_EM_RESTART': '1', 09:24:43 INFO - 'PAGER': '/bin/cat', 09:24:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:43 INFO - 'PWD': '/builds/slave/test', 09:24:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:43 INFO - 'SHELL': '/bin/bash', 09:24:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EyUv6TItdI/Listeners', 09:24:43 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 09:24:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:43 INFO - 'USER': 'cltbld', 09:24:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:43 INFO - 'XPC_FLAGS': '0x0', 09:24:43 INFO - 'XPC_SERVICE_NAME': '0', 09:24:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:43 INFO - Downloading/unpacking jsonschema==2.5.1 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:24:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:46 INFO - Downloading functools32-3.2.3-2.tar.gz 09:24:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:24:46 INFO - warning: no files found matching '*.txt' 09:24:46 INFO - no previously-included directories found matching 'build' 09:24:46 INFO - no previously-included directories found matching 'dist' 09:24:46 INFO - no previously-included directories found matching '.git*' 09:24:46 INFO - Installing collected packages: jsonschema, functools32 09:24:46 INFO - Running setup.py install for functools32 09:24:46 INFO - warning: no files found matching '*.txt' 09:24:46 INFO - no previously-included directories found matching 'build' 09:24:46 INFO - no previously-included directories found matching 'dist' 09:24:46 INFO - no previously-included directories found matching '.git*' 09:24:46 INFO - Successfully installed jsonschema functools32 09:24:46 INFO - Cleaning up... 09:24:46 INFO - Return code: 0 09:24:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:24:46 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')]} 09:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:46 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')]} 09:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:46 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 0x106994490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10690a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab094b0f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067a8d30>, '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 0x1065cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067a0b20>, '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.wP1CeuJ8jp/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.EyUv6TItdI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 09:24:46 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 09:24:46 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 09:24:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wP1CeuJ8jp/Render', 09:24:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:46 INFO - 'HOME': '/Users/cltbld', 09:24:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:46 INFO - 'LOGNAME': 'cltbld', 09:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:46 INFO - 'MOZ_NO_REMOTE': '1', 09:24:46 INFO - 'NO_EM_RESTART': '1', 09:24:46 INFO - 'PAGER': '/bin/cat', 09:24:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:46 INFO - 'PWD': '/builds/slave/test', 09:24:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:46 INFO - 'SHELL': '/bin/bash', 09:24:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EyUv6TItdI/Listeners', 09:24:46 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 09:24:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:46 INFO - 'USER': 'cltbld', 09:24:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:46 INFO - 'XPC_FLAGS': '0x0', 09:24:46 INFO - 'XPC_SERVICE_NAME': '0', 09:24:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:24:47 INFO - Cleaning up... 09:24:47 INFO - Return code: 0 09:24:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:24: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')]} 09:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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')]} 09:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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', '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 0x106994490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10690a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab094b0f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067a8d30>, '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 0x1065cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067a0b20>, '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.wP1CeuJ8jp/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.EyUv6TItdI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 09:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:24: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 blobuploader==1.2.4 09:24:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wP1CeuJ8jp/Render', 09:24:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:47 INFO - 'HOME': '/Users/cltbld', 09:24:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:47 INFO - 'LOGNAME': 'cltbld', 09:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:47 INFO - 'MOZ_NO_REMOTE': '1', 09:24:47 INFO - 'NO_EM_RESTART': '1', 09:24:47 INFO - 'PAGER': '/bin/cat', 09:24:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:47 INFO - 'PWD': '/builds/slave/test', 09:24:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:47 INFO - 'SHELL': '/bin/bash', 09:24:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EyUv6TItdI/Listeners', 09:24:47 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 09:24:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:47 INFO - 'USER': 'cltbld', 09:24:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:47 INFO - 'XPC_FLAGS': '0x0', 09:24:47 INFO - 'XPC_SERVICE_NAME': '0', 09:24:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:47 INFO - Downloading/unpacking blobuploader==1.2.4 09:24:47 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 09:24:47 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 09:24:47 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 09:24:47 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 09:24:47 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 09:24:47 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 09:24:49 INFO - Downloading blobuploader-1.2.4.tar.gz 09:24:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:24:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:24:49 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 09:24:49 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 09:24:49 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 09:24:49 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 09:24:49 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 09:24:49 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 09:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:24:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:24:50 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 09:24:50 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 09:24:50 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 09:24:50 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 09:24:50 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 09:24:50 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 09:24:51 INFO - Downloading docopt-0.6.1.tar.gz 09:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:51 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:51 INFO - Running setup.py install for blobuploader 09:24:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:24:51 INFO - Running setup.py install for requests 09:24:51 INFO - Running setup.py install for docopt 09:24:51 INFO - Successfully installed blobuploader requests docopt 09:24:51 INFO - Cleaning up... 09:24:52 INFO - Return code: 0 09:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:52 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 0x106994490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10690a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab094b0f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067a8d30>, '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 0x1065cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067a0b20>, '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.wP1CeuJ8jp/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.EyUv6TItdI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 09:24:52 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 09:24:52 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 09:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wP1CeuJ8jp/Render', 09:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:52 INFO - 'HOME': '/Users/cltbld', 09:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:52 INFO - 'LOGNAME': 'cltbld', 09:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:52 INFO - 'MOZ_NO_REMOTE': '1', 09:24:52 INFO - 'NO_EM_RESTART': '1', 09:24:52 INFO - 'PAGER': '/bin/cat', 09:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:52 INFO - 'PWD': '/builds/slave/test', 09:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:52 INFO - 'SHELL': '/bin/bash', 09:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EyUv6TItdI/Listeners', 09:24:52 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 09:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:52 INFO - 'USER': 'cltbld', 09:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:52 INFO - 'XPC_FLAGS': '0x0', 09:24:52 INFO - 'XPC_SERVICE_NAME': '0', 09:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-yNTaxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-FqB4KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-L3HNTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-yhloy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-sgL4OO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-mzXr7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-QYvHW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-qHbHjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:53 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-edGYUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:53 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-8_2OEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:53 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-BGyy_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:53 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-t0VS6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:53 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Yar8wY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:53 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-IyUKL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:53 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Ziv9il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:53 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-gp7dsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:53 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-vpTNMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:24:54 INFO - Running setup.py install for manifestparser 09:24:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:24:54 INFO - Running setup.py install for mozcrash 09:24:54 INFO - Running setup.py install for mozdebug 09:24:54 INFO - Running setup.py install for mozdevice 09:24:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:24:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:24:54 INFO - Running setup.py install for mozfile 09:24:54 INFO - Running setup.py install for mozhttpd 09:24:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:24:54 INFO - Running setup.py install for mozinfo 09:24:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:24:55 INFO - Running setup.py install for mozInstall 09:24:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:24:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:24:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:24:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:24:55 INFO - Running setup.py install for mozleak 09:24:55 INFO - Running setup.py install for mozlog 09:24:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:24:55 INFO - Running setup.py install for moznetwork 09:24:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:24:55 INFO - Running setup.py install for mozprocess 09:24:55 INFO - Running setup.py install for mozprofile 09:24:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:24:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:24:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:24:55 INFO - Running setup.py install for mozrunner 09:24:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:24:56 INFO - Running setup.py install for mozscreenshot 09:24:56 INFO - Running setup.py install for moztest 09:24:56 INFO - Running setup.py install for mozversion 09:24:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:24:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:24:56 INFO - Cleaning up... 09:24:56 INFO - Return code: 0 09:24:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:56 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 0x106994490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10690a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab094b0f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067a8d30>, '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 0x1065cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067a0b20>, '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.wP1CeuJ8jp/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.EyUv6TItdI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 09:24:56 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 09:24:56 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 09:24:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wP1CeuJ8jp/Render', 09:24:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:56 INFO - 'HOME': '/Users/cltbld', 09:24:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:56 INFO - 'LOGNAME': 'cltbld', 09:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:56 INFO - 'MOZ_NO_REMOTE': '1', 09:24:56 INFO - 'NO_EM_RESTART': '1', 09:24:56 INFO - 'PAGER': '/bin/cat', 09:24:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:56 INFO - 'PWD': '/builds/slave/test', 09:24:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:56 INFO - 'SHELL': '/bin/bash', 09:24:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EyUv6TItdI/Listeners', 09:24:56 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 09:24:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:56 INFO - 'USER': 'cltbld', 09:24:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:56 INFO - 'XPC_FLAGS': '0x0', 09:24:56 INFO - 'XPC_SERVICE_NAME': '0', 09:24:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:56 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Cbsc6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:56 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)) 09:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:56 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-aQv1sL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:57 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-1xc8ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:57 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)) 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:57 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-4n5L97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:57 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-pLxUbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:57 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)) 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:57 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-zXcO9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:57 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)) 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:57 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-GLYvdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:57 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)) 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:57 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-BxYer_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:57 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)) 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:57 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-IzDa5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:57 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)) 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:57 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Xqdc2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:57 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)) 09:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:57 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-qcoSVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:58 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)) 09:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:58 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-prKcrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:58 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)) 09:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:58 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-B8KwT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:58 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)) 09:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:58 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-OYMyYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:58 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-EVYMqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:58 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)) 09:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:58 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-CTqnSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:58 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)) 09:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:58 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-XAezih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:58 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)) 09:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:24:58 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)) 09:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:24:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:58 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 09:24:58 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 09:24:58 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 09:24:58 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 09:24:58 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 09:24:58 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 09:25:01 INFO - Downloading blessings-1.6.tar.gz 09:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:25:01 INFO - Installing collected packages: blessings 09:25:01 INFO - Running setup.py install for blessings 09:25:01 INFO - Successfully installed blessings 09:25:01 INFO - Cleaning up... 09:25:01 INFO - Return code: 0 09:25:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:25:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:01 INFO - Reading from file tmpfile_stdout 09:25:01 INFO - Current package versions: 09:25:01 INFO - blessings == 1.6 09:25:01 INFO - blobuploader == 1.2.4 09:25:01 INFO - docopt == 0.6.1 09:25:01 INFO - functools32 == 3.2.3-2 09:25:01 INFO - jsonschema == 2.5.1 09:25:01 INFO - manifestparser == 1.1 09:25:01 INFO - mozInstall == 1.12 09:25:01 INFO - mozcrash == 0.17 09:25:01 INFO - mozdebug == 0.1 09:25:01 INFO - mozdevice == 0.48 09:25:01 INFO - mozfile == 1.2 09:25:01 INFO - mozhttpd == 0.7 09:25:01 INFO - mozinfo == 0.9 09:25:01 INFO - mozleak == 0.1 09:25:01 INFO - mozlog == 3.4 09:25:01 INFO - moznetwork == 0.27 09:25:01 INFO - mozprocess == 0.23 09:25:01 INFO - mozprofile == 0.28 09:25:01 INFO - mozrunner == 6.12 09:25:01 INFO - mozscreenshot == 0.1 09:25:01 INFO - mozsystemmonitor == 0.3 09:25:01 INFO - moztest == 0.7 09:25:01 INFO - mozversion == 1.4 09:25:01 INFO - psutil == 3.1.1 09:25:01 INFO - requests == 1.2.3 09:25:01 INFO - wsgiref == 0.1.2 09:25:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:02 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')]} 09:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:02 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 0x106994490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10690a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab094b0f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067a8d30>, '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 0x1065cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067a0b20>, '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.wP1CeuJ8jp/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.EyUv6TItdI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 09:25:02 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 09:25:02 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 09:25:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wP1CeuJ8jp/Render', 09:25:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:02 INFO - 'HOME': '/Users/cltbld', 09:25:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:02 INFO - 'LOGNAME': 'cltbld', 09:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:02 INFO - 'MOZ_NO_REMOTE': '1', 09:25:02 INFO - 'NO_EM_RESTART': '1', 09:25:02 INFO - 'PAGER': '/bin/cat', 09:25:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:02 INFO - 'PWD': '/builds/slave/test', 09:25:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:02 INFO - 'SHELL': '/bin/bash', 09:25:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EyUv6TItdI/Listeners', 09:25:02 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 09:25:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:02 INFO - 'USER': 'cltbld', 09:25:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:02 INFO - 'XPC_FLAGS': '0x0', 09:25:02 INFO - 'XPC_SERVICE_NAME': '0', 09:25:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:03 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)) 09:25:03 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)) 09:25:03 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)) 09:25:03 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)) 09:25:03 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)) 09:25:03 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)) 09:25:03 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)) 09:25:03 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)) 09:25:03 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)) 09:25:03 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)) 09:25:03 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)) 09:25:03 INFO - Cleaning up... 09:25:03 INFO - Return code: 0 09:25:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:03 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 0x106994490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10690a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab094b0f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067a8d30>, '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 0x1065cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067a0b20>, '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.wP1CeuJ8jp/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.EyUv6TItdI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 09:25:03 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 09:25:03 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 09:25:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wP1CeuJ8jp/Render', 09:25:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:03 INFO - 'HOME': '/Users/cltbld', 09:25:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:03 INFO - 'LOGNAME': 'cltbld', 09:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:03 INFO - 'MOZ_NO_REMOTE': '1', 09:25:03 INFO - 'NO_EM_RESTART': '1', 09:25:03 INFO - 'PAGER': '/bin/cat', 09:25:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:03 INFO - 'PWD': '/builds/slave/test', 09:25:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:03 INFO - 'SHELL': '/bin/bash', 09:25:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EyUv6TItdI/Listeners', 09:25:03 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 09:25:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:03 INFO - 'USER': 'cltbld', 09:25:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:03 INFO - 'XPC_FLAGS': '0x0', 09:25:03 INFO - 'XPC_SERVICE_NAME': '0', 09:25:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:25:03 INFO - Cleaning up... 09:25:03 INFO - Return code: 0 09:25:03 INFO - Running post-action listener: _resource_record_post_action 09:25:03 INFO - Running post-action listener: _start_resource_monitoring 09:25:03 INFO - Starting resource monitoring. 09:25:03 INFO - [mozharness: 2016-10-29 16:25:03.974696Z] Finished create-virtualenv step (success) 09:25:03 INFO - [mozharness: 2016-10-29 16:25:03.975660Z] Running install step. 09:25:03 INFO - Running pre-action listener: _resource_record_pre_action 09:25:03 INFO - Running main action method: install 09:25:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:04 INFO - Reading from file tmpfile_stdout 09:25:04 INFO - Detecting whether we're running mozinstall >=1.0... 09:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:25:04 INFO - Reading from file tmpfile_stdout 09:25:04 INFO - Output received: 09:25:04 INFO - Usage: mozinstall [options] installer 09:25:04 INFO - Options: 09:25:04 INFO - -h, --help show this help message and exit 09:25:04 INFO - -d DEST, --destination=DEST 09:25:04 INFO - Directory to install application into. [default: 09:25:04 INFO - "/builds/slave/test"] 09:25:04 INFO - --app=APP Application being installed. [default: firefox] 09:25:04 INFO - mkdir: /builds/slave/test/build/application 09:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:25:38 INFO - Reading from file tmpfile_stdout 09:25:38 INFO - Output received: 09:25:38 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 09:25:38 INFO - Running post-action listener: _resource_record_post_action 09:25:38 INFO - [mozharness: 2016-10-29 16:25:38.504627Z] Finished install step (success) 09:25:38 INFO - [mozharness: 2016-10-29 16:25:38.504748Z] Running run-tests step. 09:25:38 INFO - Running pre-action listener: _resource_record_pre_action 09:25:38 INFO - Running main action method: run_tests 09:25:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:25:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:25:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:25:38 INFO - 2016-10-29 09:25:38.518 screenresolution[1640:7552] starting screenresolution argv=screenresolution get 09:25:38 INFO - 2016-10-29 09:25:38.521 screenresolution[1640:7552] Display 0: 1600x1200x32@60 09:25:38 INFO - 2016-10-29 09:25:38.527 screenresolution[1641:7554] starting screenresolution argv=screenresolution list 09:25:38 INFO - Available Modes on Display 0 09:25:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:25:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:25:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:25:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:25:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:25:38 INFO - Intel Iris: 09:25:38 INFO - Chipset Model: Intel Iris 09:25:38 INFO - Type: GPU 09:25:38 INFO - Bus: Built-In 09:25:38 INFO - VRAM (Dynamic, Max): 1536 MB 09:25:38 INFO - Vendor: Intel (0x8086) 09:25:38 INFO - Device ID: 0x0a2e 09:25:38 INFO - Revision ID: 0x0009 09:25:38 INFO - Displays: 09:25:38 INFO - Display: 09:25:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:25:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:25:38 INFO - Display Serial Number: 1600x1200 60 09:25:38 INFO - Main Display: Yes 09:25:38 INFO - Mirror: Off 09:25:38 INFO - Online: Yes 09:25:38 INFO - Rotation: Supported 09:25:38 INFO - Return code: 0 09:25:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:25:38 INFO - Python 2.7.3 09:25:38 INFO - Return code: 0 09:25:38 INFO - grabbing minidump binary from tooltool 09:25:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:38 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 0x1067a8d30>, '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 0x1065cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067a0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:25:38 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 09:25:38 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 09:25:38 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 09:25:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:25:38 INFO - Return code: 0 09:25:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:25:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:25:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:25:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:25:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:25:38 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/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--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 09:25:38 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/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0031 --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 09:25:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wP1CeuJ8jp/Render', 09:25:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:38 INFO - 'HOME': '/Users/cltbld', 09:25:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:38 INFO - 'LOGNAME': 'cltbld', 09:25:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:25:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:38 INFO - 'MOZ_NO_REMOTE': '1', 09:25:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:25:38 INFO - 'NO_EM_RESTART': '1', 09:25:38 INFO - 'PAGER': '/bin/cat', 09:25:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:38 INFO - 'PWD': '/builds/slave/test', 09:25:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:25:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:38 INFO - 'SHELL': '/bin/bash', 09:25:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EyUv6TItdI/Listeners', 09:25:38 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 09:25:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:38 INFO - 'USER': 'cltbld', 09:25:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:38 INFO - 'XPC_FLAGS': '0x0', 09:25:38 INFO - 'XPC_SERVICE_NAME': '0', 09:25:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:25:38 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/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--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 09:25:39 INFO - mozversion application_buildid: 20161029062601 09:25:39 INFO - mozversion application_changeset: 1b170b39ed6bdbde366233ab84594bdaaa960a5a 09:25:39 INFO - mozversion application_display_name: Nightly 09:25:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:25:39 INFO - mozversion application_name: Firefox 09:25:39 INFO - mozversion application_remotingname: firefox 09:25:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:25:39 INFO - mozversion application_vendor: Mozilla 09:25:39 INFO - mozversion application_version: 52.0a1 09:25:39 INFO - mozversion platform_buildid: 20161029062601 09:25:39 INFO - mozversion platform_changeset: 1b170b39ed6bdbde366233ab84594bdaaa960a5a 09:25:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:25:39 INFO - mozversion platform_version: 52.0a1 09:25:39 INFO - using testdate: 1477758339 09:25:39 INFO - actual date: 1477758339 09:25:39 INFO - starting webserver on 'localhost:49272' 09:25:39 INFO - SUITE-START | Running 2 tests 09:25:39 INFO - TEST-START | dromaeo_css 09:25:39 INFO - operating with platform_type : mac_ 09:25:39 INFO - Initialising browser for dromaeo_css test... 09:25:39 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpZqlZLU/profile http://localhost:49272/getInfo.html) 09:25:41 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 09:25:41 INFO - PROCESS | 1651 | colorDepth:24 09:25:41 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 09:25:41 INFO - PROCESS | 1651 | __metrics 09:25:41 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:25:41 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:25:42 INFO - TEST-INFO | 1651: exit 0 09:25:42 INFO - Browser initialized. 09:25:42 INFO - Running cycle 1/1 for dromaeo_css test... 09:25:42 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpZqlZLU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:54 INFO - PROCESS | 1654 | RSS: Main: 232935424 09:25:54 INFO - PROCESS | 1654 | 09:26:45 INFO - PROCESS | 1654 | 1477758405714 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] 09:28:58 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 09:29:01 INFO - PROCESS | 1654 | RSS: Main: 406245376 09:29:01 INFO - PROCESS | 1654 | 09:32:03 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 09:32:04 INFO - PROCESS | 1654 | RSS: Main: 373145600 09:32:04 INFO - PROCESS | 1654 | 09:35:06 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 09:35:07 INFO - PROCESS | 1654 | RSS: Main: 338472960 09:35:07 INFO - PROCESS | 1654 | 09:38:09 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 09:38:10 INFO - PROCESS | 1654 | RSS: Main: 356884480 09:38:10 INFO - PROCESS | 1654 | 09:41:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 09:41:14 INFO - PROCESS | 1654 | RSS: Main: 331452416 09:41:14 INFO - PROCESS | 1654 | 09:44:17 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 09:44:17 INFO - PROCESS | 1654 | RSS: Main: 530944000 09:44:17 INFO - PROCESS | 1654 | 09:44:17 INFO - PROCESS | 1654 | __start_tp_report 09:44:17 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 09:44:17 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 09:44:17 INFO - PROCESS | 1654 | |i|pagename|runs| 09:44:17 INFO - PROCESS | 1654 | |0;dojo.html;3248.139243100579;3284.8357582120902;3293.2260918684115;3315.0883507035564;3317.336532693462;4088.2232375848607;5407.999999999995;5408.540274076699;5497.5601951843855;5596.649407248955;5563.666180029201;5568.9443105568935;5592.189132575784;5594.412586678402;5612.102063669814;5053.646244762868;5075.720835354054;5088.389393272812;5103.2855400244;5178.948210517903;5080.136376815932;5091.974540127313;5115.386153661566;5178.844634660966;5221.399539053001;5191.714455704935;5195.168772996321;5254.500822421883;5255.921161182566;5266.8419947401635;4633.49031606523;4913.877153071202;5175.896482070356;5212.504812042869;5214.634975551713;679.3805582193978;5053.974730126362;5077.060743762416;5098.6176036797015;5135.255387968761;4566.223741963874;5572.665640061568;5590.692511911843;5612.522935550483;5640.633358831704;6056.364081771395;6093.6039157454625;6093.634381937098;6108.297545782203;6112.572119951606;6000.159977603139;6066.120412540201;6074.726637301332;6103.23709536308;6196.659183744938;5591.161325801122;5661.179129026351;5672.432756724377;5675.978323901737;5697.3732889382545;6310.242770867525;6321.336259692758;6323.873522529616;6334.144890439824;6354.173957385603;5803.274590676166;5841.591088623841;5866.384029676908;5968.582199246098;5991.281046274475;5995;6117.431594453911;6118.1128736332985;6128.200396043594;6129.970128114947;6030.698465076816;6039.365866584033;6050.0017497112485;6097;6100.72546735398;5851.21008663825;5962.910556341659;6041.063635136561;6072.51419886408;6074.392560743979;4764.475907650156;4797.808087676453;4826.903461930741;4831.9275210871865;4852.757362131879;4349.456317960255;4351.303791393362;4359.975405779639;4385.473743150842;4423.51341352451;5603.803866864721;5605.187247849039;5609.80365687199;5611.298587676541;5631.577631677641;5966.492848107872;5994.850128746816;6059.575829691968;6107.664078475637;6153.784617538365;5146.202338637517;5291.126964050965;5542.806001789918;5569.888602227933;5642.7178641067785;5285.841424757186;5289.259503669489;5291.761870715827;5307.708076055854;5355.3305836770405;6138.572327483795;6211.937880621136;6292.320560822172;6302.243730752339;6323.177986861679;6085.3306136325855;6103.542234332354;6119.388061193845;6120.569035656853;6152.953997820471;5252.684838909525;6268.247810262797;6289.056641503811;6293.527985401205;6297.716602752796;5906.645601263938;5993.280806303272;5998.130271110577;6025.728842202024;6028.065649824284;5917.940820591739;6003.759849606142;6079.848003799763;6113.755449781959;6127.80043271483;5989.341172470938;5998.790042348497;6030.939690603038;6044.395560444096;6048.818535443944;5703.857403564944;5978.163057172086;5979.611325263844;6019.067044608093;6020.458158765732;5646.943530564642;5735.426457354398;5747.511461525817;5767.9134812977;5796.710164491674;5962.314333851663;5967.910481342697;6017.2779266488305;6024.246969128859;6045.425684559959;5609.326880774333;5728.341240757366;5815.185873977562;5825.79609713658;5843.1235314703135 09:44:17 INFO - PROCESS | 1654 | |1;ext.html;482;492.18543310820604;525.8001959255483;544.4637032522967;545.2693390856253;39381.4092788608;39931.201375972465;39995.80012599623;40013.79993100038;42427;41632.37551436731;42109;42198.57801421985;42238.94402639928;42291;8971.865422018675;9338.859917101232;9523.476208808514;9527.952360238189;9532.094451027177;9402.106799854002;9506.524673766318;9507.334486585942;9517;9524;9489.525523723822;9516.71449856502;9532.904670953305;9533.332666713333;9534.237261019101;9426.528673566329;9483.146516813451;9483.146516813486;9484.241260699127;9505.19205867502;9302.581383837743;9404.38871473352;9405.341626086176;9406.965233824274;9408.247340212834;39706.404403933964;39912.60087399118;39962.20075598472;39969.400458993136;40090.398644020366;3352.195473086442;3417.8974630761118;3484.9477257841154;3532.8056956867363;3819.3888977763704;29710.85144574263;29869.40261194764;31000.53499197514;31176.220594485094;31449;3199;3204.6314673812576;3242.221866751986;3312.602487701467;3341.682540158681;459579;463756;463966;465958;466767;57422.425775742544;57834.7108264456;57871.71064144652;57922;58013.70993145092;61375.38624613786;61463;61491.6925415379;61558;61571.07643385353;15240.847591524165;15452.922735386252;15465.381384744709;15469;15476.845231547766;11962.88037119635;12024.278543287432;12024.33866137371;12047.277163370225;12058.397080145958;14263;15735.921320393554;15771.526854194393;15780.269416796458;15833.762493562606;5432.402435732066;5541.501264886179;6467.773627923094;6554.344565543408;6570.113034740344;733.4914986160495;817.5013241922422;839.5969934431507;854.4318028511095;1028.3469996552094;27695;28550.714492855222;28803.27991800222;28894;29315.85342073276;1058.2856571813995;1068.2041878800344;1107.855978722761;1134.500819639356;1170.1633332167542;15012.47456339023;15117.244137793066;15520.5343839685;15573.766393504107;15601.68796624084;607014;610815;610926;611299;612621;56983.43016569864;57059;57153.42846571481;57256;57266;1252.248650809507;1293.7024484368649;1294.2558029133097;1357.7963305503858;1394.1008049807817;29150;30123.836997114988;30887.69112308848;30888.73247170759;31698.366032678758;47041.05917881555;47385.28922066103;47477.76261118672;47488.52511474841;47637.76181119211;492027;495067;495477;495534.0446595488;496829;24640.507189855743;25482.617760733232;25486.98052077896;26175.083872064388;38660.80669596634;45130;45545.772271138434;45649.85875353143;46267.537324626326;46341.768291158325;37703.62296377001;37807.43288850615;38121.20461023671;38504.80747596244;39059.80470097631;37548;38165.61834381732;38528.42207366836;39118.41322380109;39579.406308905964;37237.59387240751;37285.067873303386;37484.81257593694;38047.04882377962;38276;30429.695703043573;32320.83839580787;33611.96832149891;33917.49123763096;34063;22046.448838779157;24315;24993.626880070788;25573.744262557135;25597.3600659985 09:44:17 INFO - PROCESS | 1654 | |2;jquery.html;347.75135777918786;356.65226404255844;365.78784305103045;368.22121213633164;386.8645973909132;14873.033252838572;15042.849571504295;16026.759598606015;20289.898550507263;20766.68849967248;19939.102740376682;20154.798452015475;20416.795832041676;20718.860462674584;20848.89575552124;5310.76101575429;5586.91619625706;5587.3015873015875;5590.636608620447;5596.328440587135;4578.923952871072;5655.293088363955;5660.716964151797;5689.118186681071;5730.9426905730825;4834.758262086899;5668.773249070032;5672.461116193955;5674.432556744334;5676.801311954083;5522.751476183581;5836.182934389189;5869.79455719052;5902.704864756788;5904.1734157218025;5444.91832622511;5579.358373787026;5672.744726487318;5688.573356998241;5711.314642242916;12640.776601966532;12655.810162847565;12840.165389249762;12842.229466232056;12863.292518911456;2166.5842585517194;2170.1319472211085;2198.7691292414224;2208.8232941364654;2216.5788500185076;8420.915790842075;9104.81790364189;9257.305702072372;9548.236141108764;10274.897251027469;1521.8934674572783;1598.5124537016206;1634.4442889417655;1875.4092460874917;1898.3735367328748;99161;115772;116223.41888290588;116628;116680;10762.085222755997;10897.673069807759;11032.28290161137;11097.667069987914;11136.38749868765;13897.652558686113;13906.721865562633;13921.025528212927;13936.303184840717;13936.651583710489;7788.610569471617;8078.515289082557;8089.433739638169;8172.6322315495945;8191.754247372588;6885.208201056842;7895.328897043815;7922;8046.114927357986;8073.919260807317;4092.6112019358116;4301.849435269751;4339.240632889295;4420.823167073281;4465.37484752135;1861.1345724238295;1890.6029733756066;1895.4882181810833;1895.9052047397574;1899.240303878432;858.6651206029653;892.7991201979503;895.7447127568612;938.6902322233647;1006.9244806639531;18840.905795470935;19221;20507.69238461424;20541.48646283825;20796.376108716762;882.250087425683;893.13366034946;898.8292224477328;957.1911734584265;989.450854775592;10223.28437009417;10714.357138571711;10718.89281107179;10761.56953721858;10762.515686794113;557135;564693;566050;577125.6012079198;578232;118606;123084;124434.37782811029;127009;127732;717.3579646216607;797.3860127701753;959.1128206409044;970.2141265574907;971.4608392342177;18451.354202602844;18763.6247275051;18800.52998675044;18823.623527529646;18827.623447531245;53100.67248318823;53908.38274851761;55147.72426137843;55734;55762;61356.77286454335;80671;81222.37555248744;83079.75380369178;83623;7600.771976840703;7730.6907723692675;7869.937558429768;8147.348212142896;8162.7143049992965;11074.504941833071;11690.415479225834;12280.201786883825;12541.811872822098;12551.497940082294;9670.468124253233;10252.897471025493;10702.625408110678;10708.678739637824;11009.669709908716;10324;10576.947115264375;10865.837012444978;10907.618233361794;10927.344359338465;10795.784084318428;10808.783824323627;11000.779984400107;11276.661700149009;11305;7748.535087894745;7861.882071769042;7932.127465978622;7941.523508589503;7957.801054973672;8910.55447227649;10255.07704306616;10508.316959397614;10532.05211530966;10691.732706682395 09:44:17 INFO - PROCESS | 1654 | |3;mootools.html;1335.2522587351084;1368.2679766325018;1555.2612509058195;1724.517135202143;1908.580112375277;7453.105627324722;7803.687852485901;8128.227818357246;8377.204165604273;8383.910091688087;8232.547209903452;8292.212239837221;8295.91704082959;8308.086110527836;8338.249557539835;2286.634138537834;2320.6519022146645;2322.105989194164;2323.1520495019367;2325.581395348845;2288.6567014947723;2333.964990525135;2339.2397470821966;2347.9060837566476;2348.5537747827943;1912.3306842605116;1988.8408927285855;2260.9886950565306;2280.3614987803358;2316.5945959457113;2262.3326118794994;2269.7389800172946;2296.2766728480474;2297.1500544798364;2300.7009088818513;2293.896774645128;2305.4236440889777;2315.97684023161;2322.779335963081;2331.813454923602;7192.244814294476;8293.046299675554;8295.129011453831;8409;8414.705485308046;5050.797968081309;5060.924086138711;5203.765830537635;5217.113090774577;5219.556337711299;3495.5980062292906;3571.982140089309;3596.5863925648623;3599.8380072896784;3605.3510368133725;1023.3450591621369;1042.1870940666292;1049.7375656085978;1069.2996087562658;1070.4005756776153;10725.946370268177;10806.02745752886;10810.243282970196;10814.026737593576;10815.080718138888;4383.49589797171;4394.648428125743;4445.82216711328;4474.731516109044;4497.370368148462;8600.397972142015;8615.827683446421;8626.223639872442;8631.827363452696;8654.956725216334;5111.233315002779;5115.693058416433;5116.027954688598;5121.9743901281;5140.717260550706;3986.1828325193264;4276.978615106905;4402.691811573223;4722.126406614787;4776.498467660915;3582.874599389009;3638.872639457606;3700.870469533553;3701.1857391373856;3706.721995850322;1129.3624244845007;1144.2390810111349;1156.4044517073714;1158.8783177766381;1161.5005547614608;800.2797482266008;878.7872735624796;901.7700486375932;914.1772404835568;949.9645386528717;5108.386993560722;5508.118701007819;5616.5787565932715;5671.546276297886;5903.645781253139;427.51690589634137;431.4994606256727;447.79625270501845;448.32527046794365;450.916580432621;3721.348763966295;3826.206868985656;3935.7244992850797;3973.92052158961;4005.118873847807;8799.680047992852;9396.389234699722;9693.51532423376;9780.755481112887;9970.152537034433;9910.653127140515;9932.751681208028;9943.602255909827;9950.054744799232;9951.552180151766;7616.619169041636;7680.577568233689;7788.883166752503;7878.212178782191;7888.48724832884;5729.484346408676;5755.366909639853;5846.181534585076;5882.882342353215;5953.851153721018;9259.629614815602;9277.953610231905;9360.578773955325;9400.106989835955;9413.199878010446;9352.158305752515;9399.436033837992;9420.340576159602;9475.526223688927;9581.473018983745;7063.964680176567;7113.679884405317;7168.390686791681;7267.600281984542;7276.781696549112;7808.453408261367;7902.525848449111;7905.090914544901;7909.881351779843;7919.604019798871;6879.690413931285;6985.545939513915;7147.82130446743;7219.6751146199595;7233.240509746612;6852.6231057292325;7028.156621205488;7029.3673569379;7100.325469080429;7129.857402852018;6592.637404942774;6635.8009259722285;6720;6722.529422940347;6735.360140786617;4829.348038014964;4869.6591238612955;4900.215965445512;4920.163572192664;4994.600431965507;4820.25286080644;4820.590249828804;4903.289023091703;4961.131801934719;4969.676970996874 09:44:17 INFO - PROCESS | 1654 | |4;prototype.html;293.4732155780375;296.31846752469323;303.5446829755367;306.8849181556916;311.220392915746;5158.375111839768;5205.115130427826;5243.554297884675;5257.211418287259;5258;4141.523724771652;4805.927911081337;4846.588040016594;4983.825566105187;5013.062133798206;3413.982930085346;3818.205443441592;3894.6689531389725;3912.471816304798;3963.8414463421427;3213.534037564552;3901.843926242961;3906.2226686857553;3920.1963597462595;3925.1364699766004;3718.851245950159;3898.922021559567;3911.8239679214503;3915;3975.4036894465917;3906.843726250975;3908.8045597720284;3925.646691797752;3927.70542209334;3971.185906889081;2817.873195706198;3366.646502117267;3374.9831250843836;3391.609964854024;3402.35355282498;4186.727862688916;4722.929156062662;4832.565069143759;5074.517920797518;5079.085764562377;3566.3045706087323;3869.3228684980018;4167.8116241075295;4287.914241715148;4494.943688233263;5316.813911513117;5321.574274058066;5353.57171426285;5367.926414717033;5391;3682.907927301812;3686.963130368689;3689.335919534483;3696.981515092434;3715.442683597455;5130.56344223618;5259.712679575266;5697.230873832021;5745.88508229833;5770.394108618619;3282.9330467598124;3608.6210947850623;3694.466796279514;3754.4180651998986;3761.191343861083;3808.21931504041;3813.523309586302;3819.236152769457;3826.7371767316718;3840.9231815363537;3616.782993020427;3779.338615742234;4383.947852515437;4448.844290449819;4468.709533880287;4574.771261436915;5082.669626474341;5171.3535808024;5453.991011662855;5475.260839786578;1086.875009373932;1111.955521779136;1286.5689993852163;1305.9608211753662;1309.9345032748515;822.9876551851727;836.7447928381902;846.204567706354;865.6494119881459;886.6187539358137;4611.746353950565;4661.533846615312;4967.826126085642;4970.527799859007;5012.523810238022;4858.927116093261;4976.129177393942;5411.404745477994;5478.808241711601;5510.641808282448;4745.691530050535;4969.478204788517;5028.365781121151;5047.28392346604;5081.212412076134;2908.476474234658;2928.7552790064137;2935.823850568973;2939.853906648159;2951.8081324714253;5287.726277700625;5330.493603107699;5819.156222347736;5829.62107463022;5836;5120.7951681933055;5266.025240534799;5491.560675145979;5668;5771.451712087345;4612.446506419251;5451.781928722807;5723.513501352431;5768.538516918637;5861.443162899518;4869.391326084239;5353.652012619167;5567.7494512747835;5614.578906581941;5685.488306052475;5545.916811247754;5556.16657501378;5559.72201389937;5562.360328562268;5570.86072848182;5152.355955505562;5545.195946587642;5740.995325817881;5813.302403711582;5825.76696932118;3540.522029525981;3696.5748938871297;3743.2139250757646;3753.053852725597;3782.394816829294;5293.258943747801;5543.944560554342;5573.7770489179975;5584.441555844383;5664.886702265849;5374.951884382508;5390.892182156414;5408.486193811582;5412;5526.364468086061;5118.3857937046305;5269.736513174403;5286.735663216747;5379.784808607612;5424;4174.686898482687;5164.49521981831;5186.429492755869;5192.584593232456;5206.687598743936;4504.648605418427;5136.666116702402;5220.181102204767;5257.685578605348;5373.35519737634;5284.392294885984;5296.788128474818;5304.893902121858;5306.471196654182;5327.627066105335 09:44:17 INFO - PROCESS | 1654 | |5;yui.html;657.4444594317802;727.4762171236714;761.3908872901679;805.1586092533302;810.9270165685091;14324.570262892117;14430.783538246935;14866.47967321144;14943.925280373584;15160.014599051054;13424.731505369911;13473.730525389487;13783.379747911344;13788.517401890911;13802.792958105636;710.3464812372604;882.2985726347553;891.4250308551013;892.8392889279927;894.7449976756626;729.4747781597268;798.5887268056955;843.7932706486919;894.727108231989;909.1862782809382;961.6105477281712;964.5418426247546;964.628617982075;966.9661561845337;969.5879251318162;954.4178051388682;955.7562821480548;955.7706150523894;956.8086382723449;960.5149399553251;548.8298627425471;567.1917517537534;682.3313153109931;699.2937133495155;702.0592406175749;14184.148951062969;14204.076735012191;14237.715245695132;14241.216733079676;14246.857531424657;13030.283334416603;13122.212667239995;13184.34078296091;13225.470981160743;13476.25880576568;11972;12016.879831201664;12024.158308918379;12106.213096148722;12382.195157314745;4335.809379202212;4390.165868484977;4444.244478438641;4471.35165401015;4587.541245875385;92612;93365;93424.53287733518;94984;95440.52279738626;10396.792064158826;10400;10410.375377477376;10472.633457829092;10863.261878099465;19653.213871445267;19800.70298945517;19811.801881981282;19858.00709964496;19882;7393.81515462107;7491.475596708287;7500.849983000309;7638.8090297743;7768.883466748003;4294.506131794821;4379;4408.669349798778;4525.886852828639;4539.0694907543875;2850.3016760893297;3439.8796042138406;3476.617572067071;3478.826058697055;3480.9825950870086;631.7283568065684;647.718242564486;657.7993711917911;662.4236913884951;664.5281849886635;601.3054921565599;601.7021574320739;611.5718996702326;628.9654069026247;630.9022101574263;8469.709164257083;8683.522406267715;8766.60550275239;8819.338549608805;8908.688195913242;547.9013777520005;561.1134407635925;571.2602180176681;574.3768011707344;633.9711135732446;4216.409702641633;4249.256380133526;4403.625691816167;4799.208130658472;4805.831795887128;84399;85587.14412855916;108880;113278;115963.84036159699;100283;100631;103865;105756.47121764343;106089.40865887018;71570;73759.63120184364;75220.85401886812;82386.94032649112;83245.16754832375;9241.260699144186;9680.661176858775;9794.85307720399;9809.950950245204;9886.209103271865;49474.81457433345;50506.74746626243;50903;52865;53374.93250134898;69017;69950.95073574003;72333.638331808;73283.63358183175;74561.62719186369;11291.943540282246;12040.337781422106;12041;12176.878231217574;12581.87418125807;13141;13200.80198797038;13835.930820345833;13873.79189312141;13951.302434878418;12930.482780688668;13042.4130914111;13369.449935517938;13373.465061397435;13695.657608559468;13374.531891383755;13512.459501619825;13580.388882500114;13636.318184090558;13751.17492950386;12332.81500777471;12902.483900643869;12937.417816198105;13204.122320640581;13344.933275333562;8796.604152813266;10736.51685674131;10983.340999539734;11321.773564528829;11379.260348077349;8193.836123277382;9238.769030774285;10130.392176469435;10539.367637941748;11183.776324473627 09:44:17 INFO - PROCESS | 1654 | __end_tp_report 09:44:17 INFO - PROCESS | 1654 | __start_cc_report 09:44:17 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2180 09:44:17 INFO - PROCESS | 1654 | __end_cc_report 09:44:17 INFO - PROCESS | 1654 | __startTimestamp1477759457570__endTimestamp 09:44:17 INFO - PROCESS | 1654 | 09:44:17 INFO - PROCESS | 1654 | ------- Summary: start ------- 09:44:17 INFO - PROCESS | 1654 | Number of tests: 6 09:44:17 INFO - PROCESS | 1654 | 09:44:17 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5574.84 Median:5796.71 stddev:745.95 (12.9%) stddev-sans-first:725.56 09:44:17 INFO - PROCESS | 1654 | Values: 3248.1 3284.8 3293.2 3315.1 3317.3 4088.2 5408.0 5408.5 5497.6 5596.6 5563.7 5568.9 5592.2 5594.4 5612.1 5053.6 5075.7 5088.4 5103.3 5178.9 5080.1 5092.0 5115.4 5178.8 5221.4 5191.7 5195.2 5254.5 5255.9 5266.8 4633.5 4913.9 5175.9 5212.5 5214.6 679.4 5054.0 5077.1 5098.6 5135.3 4566.2 5572.7 5590.7 5612.5 5640.6 6056.4 6093.6 6093.6 6108.3 6112.6 6000.2 6066.1 6074.7 6103.2 6196.7 5591.2 5661.2 5672.4 5676.0 5697.4 6310.2 6321.3 6323.9 6334.1 6354.2 5803.3 5841.6 5866.4 5968.6 5991.3 5995.0 6117.4 6118.1 6128.2 6130.0 6030.7 6039.4 6050.0 6097.0 6100.7 5851.2 5962.9 6041.1 6072.5 6074.4 4764.5 4797.8 4826.9 4831.9 4852.8 4349.5 4351.3 4360.0 4385.5 4423.5 5603.8 5605.2 5609.8 5611.3 5631.6 5966.5 5994.9 6059.6 6107.7 6153.8 5146.2 5291.1 5542.8 5569.9 5642.7 5285.8 5289.3 5291.8 5307.7 5355.3 6138.6 6211.9 6292.3 6302.2 6323.2 6085.3 6103.5 6119.4 6120.6 6153.0 5252.7 6268.2 6289.1 6293.5 6297.7 5906.6 5993.3 5998.1 6025.7 6028.1 5917.9 6003.8 6079.8 6113.8 6127.8 5989.3 5998.8 6030.9 6044.4 6048.8 5703.9 5978.2 5979.6 6019.1 6020.5 5646.9 5735.4 5747.5 5767.9 5796.7 5962.3 5967.9 6017.3 6024.2 6045.4 5609.3 5728.3 5815.2 5825.8 5843.1 09:44:17 INFO - PROCESS | 1654 | 09:44:17 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:65932.59 Median:39965.80 stddev:140554.34 (351.7%) stddev-sans-first:140862.73 09:44:17 INFO - PROCESS | 1654 | Values: 482.0 492.2 525.8 544.5 545.3 39381.4 39931.2 39995.8 40013.8 42427.0 41632.4 42109.0 42198.6 42238.9 42291.0 8971.9 9338.9 9523.5 9528.0 9532.1 9402.1 9506.5 9507.3 9517.0 9524.0 9489.5 9516.7 9532.9 9533.3 9534.2 9426.5 9483.1 9483.1 9484.2 9505.2 9302.6 9404.4 9405.3 9407.0 9408.2 39706.4 39912.6 39962.2 39969.4 40090.4 3352.2 3417.9 3484.9 3532.8 3819.4 29710.9 29869.4 31000.5 31176.2 31449.0 3199.0 3204.6 3242.2 3312.6 3341.7 459579.0 463756.0 463966.0 465958.0 466767.0 57422.4 57834.7 57871.7 57922.0 58013.7 61375.4 61463.0 61491.7 61558.0 61571.1 15240.8 15452.9 15465.4 15469.0 15476.8 11962.9 12024.3 12024.3 12047.3 12058.4 14263.0 15735.9 15771.5 15780.3 15833.8 5432.4 5541.5 6467.8 6554.3 6570.1 733.5 817.5 839.6 854.4 1028.3 27695.0 28550.7 28803.3 28894.0 29315.9 1058.3 1068.2 1107.9 1134.5 1170.2 15012.5 15117.2 15520.5 15573.8 15601.7 607014.0 610815.0 610926.0 611299.0 612621.0 56983.4 57059.0 57153.4 57256.0 57266.0 1252.2 1293.7 1294.3 1357.8 1394.1 29150.0 30123.8 30887.7 30888.7 31698.4 47041.1 47385.3 47477.8 47488.5 47637.8 492027.0 495067.0 495477.0 495534.0 496829.0 24640.5 25482.6 25487.0 26175.1 38660.8 45130.0 45545.8 45649.9 46267.5 46341.8 37703.6 37807.4 38121.2 38504.8 39059.8 37548.0 38165.6 38528.4 39118.4 39579.4 37237.6 37285.1 37484.8 38047.0 38276.0 30429.7 32320.8 33612.0 33917.5 34063.0 22046.4 24315.0 24993.6 25573.7 25597.4 09:44:17 INFO - PROCESS | 1654 | 09:44:17 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:33327.20 Median:361.22 stddev:95132.85 (26336.5%) stddev-sans-first:95367.49 09:44:17 INFO - PROCESS | 1654 | Values: 347.8 356.7 365.8 368.2 386.9 14873.0 15042.8 16026.8 20289.9 20766.7 19939.1 20154.8 20416.8 20718.9 20848.9 5310.8 5586.9 5587.3 5590.6 5596.3 4578.9 5655.3 5660.7 5689.1 5730.9 4834.8 5668.8 5672.5 5674.4 5676.8 5522.8 5836.2 5869.8 5902.7 5904.2 5444.9 5579.4 5672.7 5688.6 5711.3 12640.8 12655.8 12840.2 12842.2 12863.3 2166.6 2170.1 2198.8 2208.8 2216.6 8420.9 9104.8 9257.3 9548.2 10274.9 1521.9 1598.5 1634.4 1875.4 1898.4 99161.0 115772.0 116223.4 116628.0 116680.0 10762.1 10897.7 11032.3 11097.7 11136.4 13897.7 13906.7 13921.0 13936.3 13936.7 7788.6 8078.5 8089.4 8172.6 8191.8 6885.2 7895.3 7922.0 8046.1 8073.9 4092.6 4301.8 4339.2 4420.8 4465.4 1861.1 1890.6 1895.5 1895.9 1899.2 858.7 892.8 895.7 938.7 1006.9 18840.9 19221.0 20507.7 20541.5 20796.4 882.3 893.1 898.8 957.2 989.5 10223.3 10714.4 10718.9 10761.6 10762.5 557135.0 564693.0 566050.0 577125.6 578232.0 118606.0 123084.0 124434.4 127009.0 127732.0 717.4 797.4 959.1 970.2 971.5 18451.4 18763.6 18800.5 18823.6 18827.6 53100.7 53908.4 55147.7 55734.0 55762.0 61356.8 80671.0 81222.4 83079.8 83623.0 7600.8 7730.7 7869.9 8147.3 8162.7 11074.5 11690.4 12280.2 12541.8 12551.5 9670.5 10252.9 10702.6 10708.7 11009.7 10324.0 10576.9 10865.8 10907.6 10927.3 10795.8 10808.8 11000.8 11276.7 11305.0 7748.5 7861.9 7932.1 7941.5 7957.8 8910.6 10255.1 10508.3 10532.1 10691.7 09:44:17 INFO - PROCESS | 1654 | 09:44:17 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5381.52 Median:5119.00 stddev:2948.61 (57.6%) stddev-sans-first:2941.20 09:44:17 INFO - PROCESS | 1654 | Values: 1335.3 1368.3 1555.3 1724.5 1908.6 7453.1 7803.7 8128.2 8377.2 8383.9 8232.5 8292.2 8295.9 8308.1 8338.2 2286.6 2320.7 2322.1 2323.2 2325.6 2288.7 2334.0 2339.2 2347.9 2348.6 1912.3 1988.8 2261.0 2280.4 2316.6 2262.3 2269.7 2296.3 2297.2 2300.7 2293.9 2305.4 2316.0 2322.8 2331.8 7192.2 8293.0 8295.1 8409.0 8414.7 5050.8 5060.9 5203.8 5217.1 5219.6 3495.6 3572.0 3596.6 3599.8 3605.4 1023.3 1042.2 1049.7 1069.3 1070.4 10725.9 10806.0 10810.2 10814.0 10815.1 4383.5 4394.6 4445.8 4474.7 4497.4 8600.4 8615.8 8626.2 8631.8 8655.0 5111.2 5115.7 5116.0 5122.0 5140.7 3986.2 4277.0 4402.7 4722.1 4776.5 3582.9 3638.9 3700.9 3701.2 3706.7 1129.4 1144.2 1156.4 1158.9 1161.5 800.3 878.8 901.8 914.2 950.0 5108.4 5508.1 5616.6 5671.5 5903.6 427.5 431.5 447.8 448.3 450.9 3721.3 3826.2 3935.7 3973.9 4005.1 8799.7 9396.4 9693.5 9780.8 9970.2 9910.7 9932.8 9943.6 9950.1 9951.6 7616.6 7680.6 7788.9 7878.2 7888.5 5729.5 5755.4 5846.2 5882.9 5953.9 9259.6 9278.0 9360.6 9400.1 9413.2 9352.2 9399.4 9420.3 9475.5 9581.5 7064.0 7113.7 7168.4 7267.6 7276.8 7808.5 7902.5 7905.1 7909.9 7919.6 6879.7 6985.5 7147.8 7219.7 7233.2 6852.6 7028.2 7029.4 7100.3 7129.9 6592.6 6635.8 6720.0 6722.5 6735.4 4829.3 4869.7 4900.2 4920.2 4994.6 4820.3 4820.6 4903.3 4961.1 4969.7 09:44:17 INFO - PROCESS | 1654 | 09:44:17 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4379.70 Median:5012.79 stddev:1351.00 (27.0%) stddev-sans-first:1319.52 09:44:17 INFO - PROCESS | 1654 | Values: 293.5 296.3 303.5 306.9 311.2 5158.4 5205.1 5243.6 5257.2 5258.0 4141.5 4805.9 4846.6 4983.8 5013.1 3414.0 3818.2 3894.7 3912.5 3963.8 3213.5 3901.8 3906.2 3920.2 3925.1 3718.9 3898.9 3911.8 3915.0 3975.4 3906.8 3908.8 3925.6 3927.7 3971.2 2817.9 3366.6 3375.0 3391.6 3402.4 4186.7 4722.9 4832.6 5074.5 5079.1 3566.3 3869.3 4167.8 4287.9 4494.9 5316.8 5321.6 5353.6 5367.9 5391.0 3682.9 3687.0 3689.3 3697.0 3715.4 5130.6 5259.7 5697.2 5745.9 5770.4 3282.9 3608.6 3694.5 3754.4 3761.2 3808.2 3813.5 3819.2 3826.7 3840.9 3616.8 3779.3 4383.9 4448.8 4468.7 4574.8 5082.7 5171.4 5454.0 5475.3 1086.9 1112.0 1286.6 1306.0 1309.9 823.0 836.7 846.2 865.6 886.6 4611.7 4661.5 4967.8 4970.5 5012.5 4858.9 4976.1 5411.4 5478.8 5510.6 4745.7 4969.5 5028.4 5047.3 5081.2 2908.5 2928.8 2935.8 2939.9 2951.8 5287.7 5330.5 5819.2 5829.6 5836.0 5120.8 5266.0 5491.6 5668.0 5771.5 4612.4 5451.8 5723.5 5768.5 5861.4 4869.4 5353.7 5567.7 5614.6 5685.5 5545.9 5556.2 5559.7 5562.4 5570.9 5152.4 5545.2 5741.0 5813.3 5825.8 3540.5 3696.6 3743.2 3753.1 3782.4 5293.3 5543.9 5573.8 5584.4 5664.9 5375.0 5390.9 5408.5 5412.0 5526.4 5118.4 5269.7 5286.7 5379.8 5424.0 4174.7 5164.5 5186.4 5192.6 5206.7 4504.6 5136.7 5220.2 5257.7 5373.4 5284.4 5296.8 5304.9 5306.5 5327.6 09:44:17 INFO - PROCESS | 1654 | 09:44:17 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:20364.00 Median:4532.48 stddev:29758.04 (656.6%) stddev-sans-first:29804.73 09:44:17 INFO - PROCESS | 1654 | Values: 657.4 727.5 761.4 805.2 810.9 14324.6 14430.8 14866.5 14943.9 15160.0 13424.7 13473.7 13783.4 13788.5 13802.8 710.3 882.3 891.4 892.8 894.7 729.5 798.6 843.8 894.7 909.2 961.6 964.5 964.6 967.0 969.6 954.4 955.8 955.8 956.8 960.5 548.8 567.2 682.3 699.3 702.1 14184.1 14204.1 14237.7 14241.2 14246.9 13030.3 13122.2 13184.3 13225.5 13476.3 11972.0 12016.9 12024.2 12106.2 12382.2 4335.8 4390.2 4444.2 4471.4 4587.5 92612.0 93365.0 93424.5 94984.0 95440.5 10396.8 10400.0 10410.4 10472.6 10863.3 19653.2 19800.7 19811.8 19858.0 19882.0 7393.8 7491.5 7500.8 7638.8 7768.9 4294.5 4379.0 4408.7 4525.9 4539.1 2850.3 3439.9 3476.6 3478.8 3481.0 631.7 647.7 657.8 662.4 664.5 601.3 601.7 611.6 629.0 630.9 8469.7 8683.5 8766.6 8819.3 8908.7 547.9 561.1 571.3 574.4 634.0 4216.4 4249.3 4403.6 4799.2 4805.8 84399.0 85587.1 108880.0 113278.0 115963.8 100283.0 100631.0 103865.0 105756.5 106089.4 71570.0 73759.6 75220.9 82386.9 83245.2 9241.3 9680.7 9794.9 9810.0 9886.2 49474.8 50506.7 50903.0 52865.0 53374.9 69017.0 69951.0 72333.6 73283.6 74561.6 11291.9 12040.3 12041.0 12176.9 12581.9 13141.0 13200.8 13835.9 13873.8 13951.3 12930.5 13042.4 13369.4 13373.5 13695.7 13374.5 13512.5 13580.4 13636.3 13751.2 12332.8 12902.5 12937.4 13204.1 13344.9 8796.6 10736.5 10983.3 11321.8 11379.3 8193.8 9238.8 10130.4 10539.4 11183.8 09:44:17 INFO - PROCESS | 1654 | -------- Summary: end -------- 09:44:17 INFO - PROCESS | 1654 | 09:44:18 INFO - TEST-INFO | 1654: exit 0 09:44:18 INFO - TEST-OK | dromaeo_css | took 1119300ms 09:44:18 INFO - TEST-START | kraken 09:44:18 INFO - operating with platform_type : mac_ 09:44:18 INFO - Initialising browser for kraken test... 09:44:18 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpPZCTdT/profile http://localhost:49272/getInfo.html) 09:44:20 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 09:44:20 INFO - PROCESS | 1665 | colorDepth:24 09:44:20 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 09:44:20 INFO - PROCESS | 1665 | __metrics 09:44:21 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:44:21 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:44:21 INFO - TEST-INFO | 1665: exit 0 09:44:21 INFO - Browser initialized. 09:44:21 INFO - Running cycle 1/1 for kraken test... 09:44:21 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpPZCTdT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:33 INFO - PROCESS | 1667 | RSS: Main: 241295360 09:44:33 INFO - PROCESS | 1667 | 09:44:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 09:44:37 INFO - PROCESS | 1667 | RSS: Main: 291590144 09:44:37 INFO - PROCESS | 1667 | 09:44:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 09:44:40 INFO - PROCESS | 1667 | RSS: Main: 293474304 09:44:40 INFO - PROCESS | 1667 | 09:44:44 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 09:44:44 INFO - PROCESS | 1667 | RSS: Main: 383795200 09:44:44 INFO - PROCESS | 1667 | 09:44:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 09:44:47 INFO - PROCESS | 1667 | RSS: Main: 288649216 09:44:47 INFO - PROCESS | 1667 | 09:44:49 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:44:50 INFO - PROCESS | 1667 | RSS: Main: 290336768 09:44:50 INFO - PROCESS | 1667 | 09:44:52 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 09:44:53 INFO - PROCESS | 1667 | RSS: Main: 327254016 09:44:53 INFO - PROCESS | 1667 | 09:44:56 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 09:44:57 INFO - PROCESS | 1667 | RSS: Main: 327958528 09:44:57 INFO - PROCESS | 1667 | 09:44:59 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 09:45:00 INFO - PROCESS | 1667 | RSS: Main: 327446528 09:45:00 INFO - PROCESS | 1667 | 09:45:01 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:45:02 INFO - PROCESS | 1667 | RSS: Main: 302641152 09:45:02 INFO - PROCESS | 1667 | 09:45:04 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:45:05 INFO - PROCESS | 1667 | RSS: Main: 308609024 09:45:05 INFO - PROCESS | 1667 | 09:45:07 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:45:07 INFO - PROCESS | 1667 | RSS: Main: 310644736 09:45:07 INFO - PROCESS | 1667 | 09:45:10 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:45:11 INFO - PROCESS | 1667 | RSS: Main: 319352832 09:45:11 INFO - PROCESS | 1667 | 09:45:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:45:15 INFO - PROCESS | 1667 | RSS: Main: 318988288 09:45:15 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 09:45:17 INFO - PROCESS | 1667 | RSS: Main: 362676224 09:45:17 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | __start_tp_report 09:45:17 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 09:45:17 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 09:45:17 INFO - PROCESS | 1667 | |i|pagename|runs| 09:45:17 INFO - PROCESS | 1667 | |0;ai-astar;114;113;114;112;113;115;113;113;113;112 09:45:17 INFO - PROCESS | 1667 | |1;audio-beat-detection;140;109;107;148;105;125;103;148;176;139 09:45:17 INFO - PROCESS | 1667 | |2;audio-dft;181;184;184;183;186;184;182;196;264;183 09:45:17 INFO - PROCESS | 1667 | |3;audio-fft;79;60;59;86;62;58;59;59;87;61 09:45:17 INFO - PROCESS | 1667 | |4;audio-oscillator;90;71;95;70;69;68;92;67;68;91 09:45:17 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;92;86;94;89;93;90;94;91;90;86 09:45:17 INFO - PROCESS | 1667 | |6;imaging-darkroom;103;144;96;94;93;94;94;94;93;94 09:45:17 INFO - PROCESS | 1667 | |7;imaging-desaturate;85;83;82;83;82;84;85;86;83;83 09:45:17 INFO - PROCESS | 1667 | |8;json-parse-financial;57;52;56;55;56;57;56;55;55;55 09:45:17 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;65;80;74;72;71;69;69;68;69;72 09:45:17 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;90;91;86;89;86;90;83;79;86;97 09:45:17 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;145;150;149;149;146;145;148;152;223;138 09:45:17 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;175;174;173;184;236;175;172;233;222;172 09:45:17 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;69;67;65;66;68;67;59;61;84;86 09:45:17 INFO - PROCESS | 1667 | __end_tp_report 09:45:17 INFO - PROCESS | 1667 | __start_cc_report 09:45:17 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,2025 09:45:17 INFO - PROCESS | 1667 | __end_cc_report 09:45:17 INFO - PROCESS | 1667 | __startTimestamp1477759517510__endTimestamp 09:45:17 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | ------- Summary: start ------- 09:45:17 INFO - PROCESS | 1667 | Number of tests: 14 09:45:17 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 09:45:17 INFO - PROCESS | 1667 | Values: 114.0 113.0 114.0 112.0 113.0 115.0 113.0 113.0 113.0 112.0 09:45:17 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:130.00 Median:139.50 stddev:24.25 (17.4%) stddev-sans-first:25.45 09:45:17 INFO - PROCESS | 1667 | Values: 140.0 109.0 107.0 148.0 105.0 125.0 103.0 148.0 176.0 139.0 09:45:17 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:192.70 Median:184.00 stddev:25.40 (13.8%) stddev-sans-first:26.58 09:45:17 INFO - PROCESS | 1667 | Values: 181.0 184.0 184.0 183.0 186.0 184.0 182.0 196.0 264.0 183.0 09:45:17 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:67.00 Median:61.50 stddev:11.96 (19.5%) stddev-sans-first:11.87 09:45:17 INFO - PROCESS | 1667 | Values: 79.0 60.0 59.0 86.0 62.0 58.0 59.0 59.0 87.0 61.0 09:45:17 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:80.50 stddev:12.08 (15.0%) stddev-sans-first:12.02 09:45:17 INFO - PROCESS | 1667 | Values: 90.0 71.0 95.0 70.0 69.0 68.0 92.0 67.0 68.0 91.0 09:45:17 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:90.50 Median:91.50 stddev:2.92 (3.2%) stddev-sans-first:3.04 09:45:17 INFO - PROCESS | 1667 | Values: 92.0 86.0 94.0 89.0 93.0 90.0 94.0 91.0 90.0 86.0 09:45:17 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:99.90 Median:94.00 stddev:15.77 (16.8%) stddev-sans-first:16.69 09:45:17 INFO - PROCESS | 1667 | Values: 103.0 144.0 96.0 94.0 93.0 94.0 94.0 94.0 93.0 94.0 09:45:17 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:83.60 Median:83.50 stddev:1.35 (1.6%) stddev-sans-first:1.33 09:45:17 INFO - PROCESS | 1667 | Values: 85.0 83.0 82.0 83.0 82.0 84.0 85.0 86.0 83.0 83.0 09:45:17 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.43 (2.6%) stddev-sans-first:1.39 09:45:17 INFO - PROCESS | 1667 | Values: 57.0 52.0 56.0 55.0 56.0 57.0 56.0 55.0 55.0 55.0 09:45:17 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.50 stddev:4.07 (5.7%) stddev-sans-first:3.71 09:45:17 INFO - PROCESS | 1667 | Values: 65.0 80.0 74.0 72.0 71.0 69.0 69.0 68.0 69.0 72.0 09:45:17 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:89.50 stddev:4.90 (5.5%) stddev-sans-first:5.13 09:45:17 INFO - PROCESS | 1667 | Values: 90.0 91.0 86.0 89.0 86.0 90.0 83.0 79.0 86.0 97.0 09:45:17 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:154.50 Median:149.00 stddev:24.37 (16.4%) stddev-sans-first:25.61 09:45:17 INFO - PROCESS | 1667 | Values: 145.0 150.0 149.0 149.0 146.0 145.0 148.0 152.0 223.0 138.0 09:45:17 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.60 Median:179.50 stddev:27.17 (15.1%) stddev-sans-first:28.14 09:45:17 INFO - PROCESS | 1667 | Values: 175.0 174.0 173.0 184.0 236.0 175.0 172.0 233.0 222.0 172.0 09:45:17 INFO - PROCESS | 1667 | 09:45:17 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:67.50 stddev:8.89 (13.2%) stddev-sans-first:9.43 09:45:17 INFO - PROCESS | 1667 | Values: 69.0 67.0 65.0 66.0 68.0 67.0 59.0 61.0 84.0 86.0 09:45:17 INFO - PROCESS | 1667 | -------- Summary: end -------- 09:45:17 INFO - PROCESS | 1667 | 09:45:18 INFO - TEST-INFO | 1667: exit 0 09:45:18 INFO - TEST-OK | kraken | took 59970ms 09:45:18 INFO - SUITE-END | took 1179s 09:45:18 INFO - Completed test suite (00:19:39) 09:45:18 INFO - javascript benchmark 09:45:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3248.139243100579, 3284.8357582120902, 3293.2260918684115, 3315.0883507035564, 3317.336532693462, 4088.2232375848607, 5407.999999999995, 5408.540274076699, 5497.5601951843855, 5596.649407248955, 5563.666180029201, 5568.9443105568935, 5592.189132575784, 5594.412586678402, 5612.102063669814, 5053.646244762868, 5075.720835354054, 5088.389393272812, 5103.2855400244, 5178.948210517903, 5080.136376815932, 5091.974540127313, 5115.386153661566, 5178.844634660966, 5221.399539053001, 5191.714455704935, 5195.168772996321, 5254.500822421883, 5255.921161182566, 5266.8419947401635, 4633.49031606523, 4913.877153071202, 5175.896482070356, 5212.504812042869, 5214.634975551713, 679.3805582193978, 5053.974730126362, 5077.060743762416, 5098.6176036797015, 5135.255387968761, 4566.223741963874, 5572.665640061568, 5590.692511911843, 5612.522935550483, 5640.633358831704, 6056.364081771395, 6093.6039157454625, 6093.634381937098, 6108.297545782203, 6112.572119951606, 6000.159977603139, 6066.120412540201, 6074.726637301332, 6103.23709536308, 6196.659183744938, 5591.161325801122, 5661.179129026351, 5672.432756724377, 5675.978323901737, 5697.3732889382545, 6310.242770867525, 6321.336259692758, 6323.873522529616, 6334.144890439824, 6354.173957385603, 5803.274590676166, 5841.591088623841, 5866.384029676908, 5968.582199246098, 5991.281046274475, 5995.0, 6117.431594453911, 6118.1128736332985, 6128.200396043594, 6129.970128114947, 6030.698465076816, 6039.365866584033, 6050.0017497112485, 6097.0, 6100.72546735398, 5851.21008663825, 5962.910556341659, 6041.063635136561, 6072.51419886408, 6074.392560743979, 4764.475907650156, 4797.808087676453, 4826.903461930741, 4831.9275210871865, 4852.757362131879, 4349.456317960255, 4351.303791393362, 4359.975405779639, 4385.473743150842, 4423.51341352451, 5603.803866864721, 5605.187247849039, 5609.80365687199, 5611.298587676541, 5631.577631677641, 5966.492848107872, 5994.850128746816, 6059.575829691968, 6107.664078475637, 6153.784617538365, 5146.202338637517, 5291.126964050965, 5542.806001789918, 5569.888602227933, 5642.7178641067785, 5285.841424757186, 5289.259503669489, 5291.761870715827, 5307.708076055854, 5355.3305836770405, 6138.572327483795, 6211.937880621136, 6292.320560822172, 6302.243730752339, 6323.177986861679, 6085.3306136325855, 6103.542234332354, 6119.388061193845, 6120.569035656853, 6152.953997820471, 5252.684838909525, 6268.247810262797, 6289.056641503811, 6293.527985401205, 6297.716602752796, 5906.645601263938, 5993.280806303272, 5998.130271110577, 6025.728842202024, 6028.065649824284, 5917.940820591739, 6003.759849606142, 6079.848003799763, 6113.755449781959, 6127.80043271483, 5989.341172470938, 5998.790042348497, 6030.939690603038, 6044.395560444096, 6048.818535443944, 5703.857403564944, 5978.163057172086, 5979.611325263844, 6019.067044608093, 6020.458158765732, 5646.943530564642, 5735.426457354398, 5747.511461525817, 5767.9134812977, 5796.710164491674, 5962.314333851663, 5967.910481342697, 6017.2779266488305, 6024.246969128859, 6045.425684559959, 5609.326880774333, 5728.341240757366, 5815.185873977562, 5825.79609713658, 5843.1235314703135], "value": 5529.128898422951, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.0, 492.18543310820604, 525.8001959255483, 544.4637032522967, 545.2693390856253, 39381.4092788608, 39931.201375972465, 39995.80012599623, 40013.79993100038, 42427.0, 41632.37551436731, 42109.0, 42198.57801421985, 42238.94402639928, 42291.0, 8971.865422018675, 9338.859917101232, 9523.476208808514, 9527.952360238189, 9532.094451027177, 9402.106799854002, 9506.524673766318, 9507.334486585942, 9517.0, 9524.0, 9489.525523723822, 9516.71449856502, 9532.904670953305, 9533.332666713333, 9534.237261019101, 9426.528673566329, 9483.146516813451, 9483.146516813486, 9484.241260699127, 9505.19205867502, 9302.581383837743, 9404.38871473352, 9405.341626086176, 9406.965233824274, 9408.247340212834, 39706.404403933964, 39912.60087399118, 39962.20075598472, 39969.400458993136, 40090.398644020366, 3352.195473086442, 3417.8974630761118, 3484.9477257841154, 3532.8056956867363, 3819.3888977763704, 29710.85144574263, 29869.40261194764, 31000.53499197514, 31176.220594485094, 31449.0, 3199.0, 3204.6314673812576, 3242.221866751986, 3312.602487701467, 3341.682540158681, 459579.0, 463756.0, 463966.0, 465958.0, 466767.0, 57422.425775742544, 57834.7108264456, 57871.71064144652, 57922.0, 58013.70993145092, 61375.38624613786, 61463.0, 61491.6925415379, 61558.0, 61571.07643385353, 15240.847591524165, 15452.922735386252, 15465.381384744709, 15469.0, 15476.845231547766, 11962.88037119635, 12024.278543287432, 12024.33866137371, 12047.277163370225, 12058.397080145958, 14263.0, 15735.921320393554, 15771.526854194393, 15780.269416796458, 15833.762493562606, 5432.402435732066, 5541.501264886179, 6467.773627923094, 6554.344565543408, 6570.113034740344, 733.4914986160495, 817.5013241922422, 839.5969934431507, 854.4318028511095, 1028.3469996552094, 27695.0, 28550.714492855222, 28803.27991800222, 28894.0, 29315.85342073276, 1058.2856571813995, 1068.2041878800344, 1107.855978722761, 1134.500819639356, 1170.1633332167542, 15012.47456339023, 15117.244137793066, 15520.5343839685, 15573.766393504107, 15601.68796624084, 607014.0, 610815.0, 610926.0, 611299.0, 612621.0, 56983.43016569864, 57059.0, 57153.42846571481, 57256.0, 57266.0, 1252.248650809507, 1293.7024484368649, 1294.2558029133097, 1357.7963305503858, 1394.1008049807817, 29150.0, 30123.836997114988, 30887.69112308848, 30888.73247170759, 31698.366032678758, 47041.05917881555, 47385.28922066103, 47477.76261118672, 47488.52511474841, 47637.76181119211, 492027.0, 495067.0, 495477.0, 495534.0446595488, 496829.0, 24640.507189855743, 25482.617760733232, 25486.98052077896, 26175.083872064388, 38660.80669596634, 45130.0, 45545.772271138434, 45649.85875353143, 46267.537324626326, 46341.768291158325, 37703.62296377001, 37807.43288850615, 38121.20461023671, 38504.80747596244, 39059.80470097631, 37548.0, 38165.61834381732, 38528.42207366836, 39118.41322380109, 39579.406308905964, 37237.59387240751, 37285.067873303386, 37484.81257593694, 38047.04882377962, 38276.0, 30429.695703043573, 32320.83839580787, 33611.96832149891, 33917.49123763096, 34063.0, 22046.448838779157, 24315.0, 24993.626880070788, 25573.744262557135, 25597.3600659985], "value": 19363.108743000856, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.75135777918786, 356.65226404255844, 365.78784305103045, 368.22121213633164, 386.8645973909132, 14873.033252838572, 15042.849571504295, 16026.759598606015, 20289.898550507263, 20766.68849967248, 19939.102740376682, 20154.798452015475, 20416.795832041676, 20718.860462674584, 20848.89575552124, 5310.76101575429, 5586.91619625706, 5587.3015873015875, 5590.636608620447, 5596.328440587135, 4578.923952871072, 5655.293088363955, 5660.716964151797, 5689.118186681071, 5730.9426905730825, 4834.758262086899, 5668.773249070032, 5672.461116193955, 5674.432556744334, 5676.801311954083, 5522.751476183581, 5836.182934389189, 5869.79455719052, 5902.704864756788, 5904.1734157218025, 5444.91832622511, 5579.358373787026, 5672.744726487318, 5688.573356998241, 5711.314642242916, 12640.776601966532, 12655.810162847565, 12840.165389249762, 12842.229466232056, 12863.292518911456, 2166.5842585517194, 2170.1319472211085, 2198.7691292414224, 2208.8232941364654, 2216.5788500185076, 8420.915790842075, 9104.81790364189, 9257.305702072372, 9548.236141108764, 10274.897251027469, 1521.8934674572783, 1598.5124537016206, 1634.4442889417655, 1875.4092460874917, 1898.3735367328748, 99161.0, 115772.0, 116223.41888290588, 116628.0, 116680.0, 10762.085222755997, 10897.673069807759, 11032.28290161137, 11097.667069987914, 11136.38749868765, 13897.652558686113, 13906.721865562633, 13921.025528212927, 13936.303184840717, 13936.651583710489, 7788.610569471617, 8078.515289082557, 8089.433739638169, 8172.6322315495945, 8191.754247372588, 6885.208201056842, 7895.328897043815, 7922.0, 8046.114927357986, 8073.919260807317, 4092.6112019358116, 4301.849435269751, 4339.240632889295, 4420.823167073281, 4465.37484752135, 1861.1345724238295, 1890.6029733756066, 1895.4882181810833, 1895.9052047397574, 1899.240303878432, 858.6651206029653, 892.7991201979503, 895.7447127568612, 938.6902322233647, 1006.9244806639531, 18840.905795470935, 19221.0, 20507.69238461424, 20541.48646283825, 20796.376108716762, 882.250087425683, 893.13366034946, 898.8292224477328, 957.1911734584265, 989.450854775592, 10223.28437009417, 10714.357138571711, 10718.89281107179, 10761.56953721858, 10762.515686794113, 557135.0, 564693.0, 566050.0, 577125.6012079198, 578232.0, 118606.0, 123084.0, 124434.37782811029, 127009.0, 127732.0, 717.3579646216607, 797.3860127701753, 959.1128206409044, 970.2141265574907, 971.4608392342177, 18451.354202602844, 18763.6247275051, 18800.52998675044, 18823.623527529646, 18827.623447531245, 53100.67248318823, 53908.38274851761, 55147.72426137843, 55734.0, 55762.0, 61356.77286454335, 80671.0, 81222.37555248744, 83079.75380369178, 83623.0, 7600.771976840703, 7730.6907723692675, 7869.937558429768, 8147.348212142896, 8162.7143049992965, 11074.504941833071, 11690.415479225834, 12280.201786883825, 12541.811872822098, 12551.497940082294, 9670.468124253233, 10252.897471025493, 10702.625408110678, 10708.678739637824, 11009.669709908716, 10324.0, 10576.947115264375, 10865.837012444978, 10907.618233361794, 10927.344359338465, 10795.784084318428, 10808.783824323627, 11000.779984400107, 11276.661700149009, 11305.0, 7748.535087894745, 7861.882071769042, 7932.127465978622, 7941.523508589503, 7957.801054973672, 8910.55447227649, 10255.07704306616, 10508.316959397614, 10532.05211530966, 10691.732706682395], "value": 9012.503732958876, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.2522587351084, 1368.2679766325018, 1555.2612509058195, 1724.517135202143, 1908.580112375277, 7453.105627324722, 7803.687852485901, 8128.227818357246, 8377.204165604273, 8383.910091688087, 8232.547209903452, 8292.212239837221, 8295.91704082959, 8308.086110527836, 8338.249557539835, 2286.634138537834, 2320.6519022146645, 2322.105989194164, 2323.1520495019367, 2325.581395348845, 2288.6567014947723, 2333.964990525135, 2339.2397470821966, 2347.9060837566476, 2348.5537747827943, 1912.3306842605116, 1988.8408927285855, 2260.9886950565306, 2280.3614987803358, 2316.5945959457113, 2262.3326118794994, 2269.7389800172946, 2296.2766728480474, 2297.1500544798364, 2300.7009088818513, 2293.896774645128, 2305.4236440889777, 2315.97684023161, 2322.779335963081, 2331.813454923602, 7192.244814294476, 8293.046299675554, 8295.129011453831, 8409.0, 8414.705485308046, 5050.797968081309, 5060.924086138711, 5203.765830537635, 5217.113090774577, 5219.556337711299, 3495.5980062292906, 3571.982140089309, 3596.5863925648623, 3599.8380072896784, 3605.3510368133725, 1023.3450591621369, 1042.1870940666292, 1049.7375656085978, 1069.2996087562658, 1070.4005756776153, 10725.946370268177, 10806.02745752886, 10810.243282970196, 10814.026737593576, 10815.080718138888, 4383.49589797171, 4394.648428125743, 4445.82216711328, 4474.731516109044, 4497.370368148462, 8600.397972142015, 8615.827683446421, 8626.223639872442, 8631.827363452696, 8654.956725216334, 5111.233315002779, 5115.693058416433, 5116.027954688598, 5121.9743901281, 5140.717260550706, 3986.1828325193264, 4276.978615106905, 4402.691811573223, 4722.126406614787, 4776.498467660915, 3582.874599389009, 3638.872639457606, 3700.870469533553, 3701.1857391373856, 3706.721995850322, 1129.3624244845007, 1144.2390810111349, 1156.4044517073714, 1158.8783177766381, 1161.5005547614608, 800.2797482266008, 878.7872735624796, 901.7700486375932, 914.1772404835568, 949.9645386528717, 5108.386993560722, 5508.118701007819, 5616.5787565932715, 5671.546276297886, 5903.645781253139, 427.51690589634137, 431.4994606256727, 447.79625270501845, 448.32527046794365, 450.916580432621, 3721.348763966295, 3826.206868985656, 3935.7244992850797, 3973.92052158961, 4005.118873847807, 8799.680047992852, 9396.389234699722, 9693.51532423376, 9780.755481112887, 9970.152537034433, 9910.653127140515, 9932.751681208028, 9943.602255909827, 9950.054744799232, 9951.552180151766, 7616.619169041636, 7680.577568233689, 7788.883166752503, 7878.212178782191, 7888.48724832884, 5729.484346408676, 5755.366909639853, 5846.181534585076, 5882.882342353215, 5953.851153721018, 9259.629614815602, 9277.953610231905, 9360.578773955325, 9400.106989835955, 9413.199878010446, 9352.158305752515, 9399.436033837992, 9420.340576159602, 9475.526223688927, 9581.473018983745, 7063.964680176567, 7113.679884405317, 7168.390686791681, 7267.600281984542, 7276.781696549112, 7808.453408261367, 7902.525848449111, 7905.090914544901, 7909.881351779843, 7919.604019798871, 6879.690413931285, 6985.545939513915, 7147.82130446743, 7219.6751146199595, 7233.240509746612, 6852.6231057292325, 7028.156621205488, 7029.3673569379, 7100.325469080429, 7129.857402852018, 6592.637404942774, 6635.8009259722285, 6720.0, 6722.529422940347, 6735.360140786617, 4829.348038014964, 4869.6591238612955, 4900.215965445512, 4920.163572192664, 4994.600431965507, 4820.25286080644, 4820.590249828804, 4903.289023091703, 4961.131801934719, 4969.676970996874], "value": 4289.959465718769, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.4732155780375, 296.31846752469323, 303.5446829755367, 306.8849181556916, 311.220392915746, 5158.375111839768, 5205.115130427826, 5243.554297884675, 5257.211418287259, 5258.0, 4141.523724771652, 4805.927911081337, 4846.588040016594, 4983.825566105187, 5013.062133798206, 3413.982930085346, 3818.205443441592, 3894.6689531389725, 3912.471816304798, 3963.8414463421427, 3213.534037564552, 3901.843926242961, 3906.2226686857553, 3920.1963597462595, 3925.1364699766004, 3718.851245950159, 3898.922021559567, 3911.8239679214503, 3915.0, 3975.4036894465917, 3906.843726250975, 3908.8045597720284, 3925.646691797752, 3927.70542209334, 3971.185906889081, 2817.873195706198, 3366.646502117267, 3374.9831250843836, 3391.609964854024, 3402.35355282498, 4186.727862688916, 4722.929156062662, 4832.565069143759, 5074.517920797518, 5079.085764562377, 3566.3045706087323, 3869.3228684980018, 4167.8116241075295, 4287.914241715148, 4494.943688233263, 5316.813911513117, 5321.574274058066, 5353.57171426285, 5367.926414717033, 5391.0, 3682.907927301812, 3686.963130368689, 3689.335919534483, 3696.981515092434, 3715.442683597455, 5130.56344223618, 5259.712679575266, 5697.230873832021, 5745.88508229833, 5770.394108618619, 3282.9330467598124, 3608.6210947850623, 3694.466796279514, 3754.4180651998986, 3761.191343861083, 3808.21931504041, 3813.523309586302, 3819.236152769457, 3826.7371767316718, 3840.9231815363537, 3616.782993020427, 3779.338615742234, 4383.947852515437, 4448.844290449819, 4468.709533880287, 4574.771261436915, 5082.669626474341, 5171.3535808024, 5453.991011662855, 5475.260839786578, 1086.875009373932, 1111.955521779136, 1286.5689993852163, 1305.9608211753662, 1309.9345032748515, 822.9876551851727, 836.7447928381902, 846.204567706354, 865.6494119881459, 886.6187539358137, 4611.746353950565, 4661.533846615312, 4967.826126085642, 4970.527799859007, 5012.523810238022, 4858.927116093261, 4976.129177393942, 5411.404745477994, 5478.808241711601, 5510.641808282448, 4745.691530050535, 4969.478204788517, 5028.365781121151, 5047.28392346604, 5081.212412076134, 2908.476474234658, 2928.7552790064137, 2935.823850568973, 2939.853906648159, 2951.8081324714253, 5287.726277700625, 5330.493603107699, 5819.156222347736, 5829.62107463022, 5836.0, 5120.7951681933055, 5266.025240534799, 5491.560675145979, 5668.0, 5771.451712087345, 4612.446506419251, 5451.781928722807, 5723.513501352431, 5768.538516918637, 5861.443162899518, 4869.391326084239, 5353.652012619167, 5567.7494512747835, 5614.578906581941, 5685.488306052475, 5545.916811247754, 5556.16657501378, 5559.72201389937, 5562.360328562268, 5570.86072848182, 5152.355955505562, 5545.195946587642, 5740.995325817881, 5813.302403711582, 5825.76696932118, 3540.522029525981, 3696.5748938871297, 3743.2139250757646, 3753.053852725597, 3782.394816829294, 5293.258943747801, 5543.944560554342, 5573.7770489179975, 5584.441555844383, 5664.886702265849, 5374.951884382508, 5390.892182156414, 5408.486193811582, 5412.0, 5526.364468086061, 5118.3857937046305, 5269.736513174403, 5286.735663216747, 5379.784808607612, 5424.0, 4174.686898482687, 5164.49521981831, 5186.429492755869, 5192.584593232456, 5206.687598743936, 4504.648605418427, 5136.666116702402, 5220.181102204767, 5257.685578605348, 5373.35519737634, 5284.392294885984, 5296.788128474818, 5304.893902121858, 5306.471196654182, 5327.627066105335], "value": 3947.9589501260566, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.4444594317802, 727.4762171236714, 761.3908872901679, 805.1586092533302, 810.9270165685091, 14324.570262892117, 14430.783538246935, 14866.47967321144, 14943.925280373584, 15160.014599051054, 13424.731505369911, 13473.730525389487, 13783.379747911344, 13788.517401890911, 13802.792958105636, 710.3464812372604, 882.2985726347553, 891.4250308551013, 892.8392889279927, 894.7449976756626, 729.4747781597268, 798.5887268056955, 843.7932706486919, 894.727108231989, 909.1862782809382, 961.6105477281712, 964.5418426247546, 964.628617982075, 966.9661561845337, 969.5879251318162, 954.4178051388682, 955.7562821480548, 955.7706150523894, 956.8086382723449, 960.5149399553251, 548.8298627425471, 567.1917517537534, 682.3313153109931, 699.2937133495155, 702.0592406175749, 14184.148951062969, 14204.076735012191, 14237.715245695132, 14241.216733079676, 14246.857531424657, 13030.283334416603, 13122.212667239995, 13184.34078296091, 13225.470981160743, 13476.25880576568, 11972.0, 12016.879831201664, 12024.158308918379, 12106.213096148722, 12382.195157314745, 4335.809379202212, 4390.165868484977, 4444.244478438641, 4471.35165401015, 4587.541245875385, 92612.0, 93365.0, 93424.53287733518, 94984.0, 95440.52279738626, 10396.792064158826, 10400.0, 10410.375377477376, 10472.633457829092, 10863.261878099465, 19653.213871445267, 19800.70298945517, 19811.801881981282, 19858.00709964496, 19882.0, 7393.81515462107, 7491.475596708287, 7500.849983000309, 7638.8090297743, 7768.883466748003, 4294.506131794821, 4379.0, 4408.669349798778, 4525.886852828639, 4539.0694907543875, 2850.3016760893297, 3439.8796042138406, 3476.617572067071, 3478.826058697055, 3480.9825950870086, 631.7283568065684, 647.718242564486, 657.7993711917911, 662.4236913884951, 664.5281849886635, 601.3054921565599, 601.7021574320739, 611.5718996702326, 628.9654069026247, 630.9022101574263, 8469.709164257083, 8683.522406267715, 8766.60550275239, 8819.338549608805, 8908.688195913242, 547.9013777520005, 561.1134407635925, 571.2602180176681, 574.3768011707344, 633.9711135732446, 4216.409702641633, 4249.256380133526, 4403.625691816167, 4799.208130658472, 4805.831795887128, 84399.0, 85587.14412855916, 108880.0, 113278.0, 115963.84036159699, 100283.0, 100631.0, 103865.0, 105756.47121764343, 106089.40865887018, 71570.0, 73759.63120184364, 75220.85401886812, 82386.94032649112, 83245.16754832375, 9241.260699144186, 9680.661176858775, 9794.85307720399, 9809.950950245204, 9886.209103271865, 49474.81457433345, 50506.74746626243, 50903.0, 52865.0, 53374.93250134898, 69017.0, 69950.95073574003, 72333.638331808, 73283.63358183175, 74561.62719186369, 11291.943540282246, 12040.337781422106, 12041.0, 12176.878231217574, 12581.87418125807, 13141.0, 13200.80198797038, 13835.930820345833, 13873.79189312141, 13951.302434878418, 12930.482780688668, 13042.4130914111, 13369.449935517938, 13373.465061397435, 13695.657608559468, 13374.531891383755, 13512.459501619825, 13580.388882500114, 13636.318184090558, 13751.17492950386, 12332.81500777471, 12902.483900643869, 12937.417816198105, 13204.122320640581, 13344.933275333562, 8796.604152813266, 10736.51685674131, 10983.340999539734, 11321.773564528829, 11379.260348077349, 8193.836123277382, 9238.769030774285, 10130.392176469435, 10539.367637941748, 11183.776324473627], "value": 7346.417628316441, "unit": "score"}], "name": "dromaeo_css", "value": 7023.784855117522, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 112.0, 113.0, 115.0, 113.0, 113.0, 113.0, 112.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 109.0, 107.0, 148.0, 105.0, 125.0, 103.0, 148.0, 176.0, 139.0], "value": 130.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 184.0, 183.0, 186.0, 184.0, 182.0, 196.0, 264.0, 183.0], "value": 192.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 59.0, 86.0, 62.0, 58.0, 59.0, 59.0, 87.0, 61.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 95.0, 70.0, 69.0, 68.0, 92.0, 67.0, 68.0, 91.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 86.0, 94.0, 89.0, 93.0, 90.0, 94.0, 91.0, 90.0, 86.0], "value": 90.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 144.0, 96.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 99.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 82.0, 83.0, 82.0, 84.0, 85.0, 86.0, 83.0, 83.0], "value": 83.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 56.0, 55.0, 56.0, 57.0, 56.0, 55.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 80.0, 74.0, 72.0, 71.0, 69.0, 69.0, 68.0, 69.0, 72.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 86.0, 89.0, 86.0, 90.0, 83.0, 79.0, 86.0, 97.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 150.0, 149.0, 149.0, 146.0, 145.0, 148.0, 152.0, 223.0, 138.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 173.0, 184.0, 236.0, 175.0, 172.0, 233.0, 222.0, 172.0], "value": 191.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 65.0, 66.0, 68.0, 67.0, 59.0, 61.0, 84.0, 86.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1484.3, "alertThreshold": 2.0}]} 09:45:18 INFO - Return code: 0 09:45:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:45:18 INFO - # TBPL SUCCESS # 09:45:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:45:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:45:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:45:18 INFO - 2016-10-29 09:45:18.778 screenresolution[1671:10107] starting screenresolution argv=screenresolution get 09:45:18 INFO - 2016-10-29 09:45:18.782 screenresolution[1671:10107] Display 0: 1600x1200x32@60 09:45:18 INFO - 2016-10-29 09:45:18.788 screenresolution[1672:10110] starting screenresolution argv=screenresolution list 09:45:18 INFO - Available Modes on Display 0 09:45:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:45:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:45:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:45:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:45:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:45:19 INFO - Intel Iris: 09:45:19 INFO - Chipset Model: Intel Iris 09:45:19 INFO - Type: GPU 09:45:19 INFO - Bus: Built-In 09:45:19 INFO - VRAM (Dynamic, Max): 1536 MB 09:45:19 INFO - Vendor: Intel (0x8086) 09:45:19 INFO - Device ID: 0x0a2e 09:45:19 INFO - Revision ID: 0x0009 09:45:19 INFO - Displays: 09:45:19 INFO - Display: 09:45:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:45:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:45:19 INFO - Display Serial Number: 1600x1200 60 09:45:19 INFO - Main Display: Yes 09:45:19 INFO - Mirror: Off 09:45:19 INFO - Online: Yes 09:45:19 INFO - Rotation: Supported 09:45:19 INFO - Return code: 0 09:45:19 INFO - Running post-action listener: _resource_record_post_action 09:45:19 INFO - [mozharness: 2016-10-29 16:45:19.030489Z] Finished run-tests step (success) 09:45:19 INFO - Running post-run listener: _resource_record_post_run 09:45:19 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 38867968; Write bytes: 709989888; Read time: 383; Write time: 2262 09:45:19 INFO - TinderboxPrint: CPU usage
53.4% 09:45:19 INFO - TinderboxPrint: I/O read bytes / time
38,867,968 / 383 09:45:19 INFO - TinderboxPrint: I/O write bytes / time
709,989,888 / 2,262 09:45:19 INFO - TinderboxPrint: CPU idle
2,261.8 (46.6%) 09:45:19 INFO - TinderboxPrint: CPU system
970.2 (20.0%) 09:45:19 INFO - TinderboxPrint: CPU user
1,625.7 (33.5%) 09:45:19 INFO - TinderboxPrint: Swap in / out
445,521,920 / 0 09:45:19 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 397818368; Write bytes: 391931392; Read time: 29542; Write time: 767 09:45:19 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 36852736; Write bytes: 299671552; Read time: 359; Write time: 1446 09:45:19 INFO - Running post-run listener: _upload_blobber_files 09:45:19 INFO - Blob upload gear active. 09:45:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:45:19 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 09:45:19 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'] 09:45:19 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 09:45:19 INFO - (blobuploader) - INFO - Open directory for files ... 09:45:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:45:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:45:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:20 INFO - (blobuploader) - INFO - Done attempting. 09:45:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:45:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:45:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:21 INFO - (blobuploader) - INFO - Done attempting. 09:45:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:45:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:45:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:23 INFO - (blobuploader) - INFO - Done attempting. 09:45:23 INFO - (blobuploader) - INFO - Iteration through files over. 09:45:23 INFO - Return code: 0 09:45:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:45:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:45:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0780eefc2dbe63427af968c2d4f652fe47c0a003a338c039a68cd02fe9b5e7286c79720e9758e7a9dced22ed8f36c13c524c63b5e3d638deec21bf761351c17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b4a8419bf7f3a9105c38e50e18717513cab9347291bcebef75fbf76a2a2ebc01a3fd8a4151bf7ed0ce3f33be97c1710a14bfcda953c6e70a61c36cf39feb3cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/103f899cd55015180f1763e79e26d8588a25883c5435672f9eda8b1334e15afcc6e40d4068d66b2388e28dcac7dfd5dead073a3bcaa4122e376cebc40aaaddc2"} 09:45:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:45:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:45:23 INFO - Contents: 09:45:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0780eefc2dbe63427af968c2d4f652fe47c0a003a338c039a68cd02fe9b5e7286c79720e9758e7a9dced22ed8f36c13c524c63b5e3d638deec21bf761351c17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b4a8419bf7f3a9105c38e50e18717513cab9347291bcebef75fbf76a2a2ebc01a3fd8a4151bf7ed0ce3f33be97c1710a14bfcda953c6e70a61c36cf39feb3cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/103f899cd55015180f1763e79e26d8588a25883c5435672f9eda8b1334e15afcc6e40d4068d66b2388e28dcac7dfd5dead073a3bcaa4122e376cebc40aaaddc2"} 09:45:23 INFO - Running post-run listener: copy_logs_to_upload_dir 09:45:23 INFO - Copying logs to upload dir... 09:45:23 INFO - mkdir: /builds/slave/test/build/upload/logs 09:45:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.256611 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-29 09:45:24.006353) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 09:45:24.009543) ========= 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.wP1CeuJ8jp/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.EyUv6TItdI/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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/f0780eefc2dbe63427af968c2d4f652fe47c0a003a338c039a68cd02fe9b5e7286c79720e9758e7a9dced22ed8f36c13c524c63b5e3d638deec21bf761351c17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b4a8419bf7f3a9105c38e50e18717513cab9347291bcebef75fbf76a2a2ebc01a3fd8a4151bf7ed0ce3f33be97c1710a14bfcda953c6e70a61c36cf39feb3cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/103f899cd55015180f1763e79e26d8588a25883c5435672f9eda8b1334e15afcc6e40d4068d66b2388e28dcac7dfd5dead073a3bcaa4122e376cebc40aaaddc2"} build_url:https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011102 build_url: 'https://queue.taskcluster.net/v1/task/XI8_LGYPT3-aZRkBA3o6lg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0780eefc2dbe63427af968c2d4f652fe47c0a003a338c039a68cd02fe9b5e7286c79720e9758e7a9dced22ed8f36c13c524c63b5e3d638deec21bf761351c17", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b4a8419bf7f3a9105c38e50e18717513cab9347291bcebef75fbf76a2a2ebc01a3fd8a4151bf7ed0ce3f33be97c1710a14bfcda953c6e70a61c36cf39feb3cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/103f899cd55015180f1763e79e26d8588a25883c5435672f9eda8b1334e15afcc6e40d4068d66b2388e28dcac7dfd5dead073a3bcaa4122e376cebc40aaaddc2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 09:45:24.042239) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:45:24.042641) ========= 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.wP1CeuJ8jp/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.EyUv6TItdI/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.005051 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:45:24.092043) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 09:45:24.092391) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 09:45:24.092733) ========= ========= Total master_lag: 0.17 =========