builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0135 starttime: 1477312865.34 results: success (0) buildid: 20161024030205 builduid: 25896b81c02c43e39fb49284fea31552 revision: 215f9686117673a2c914ed207bc7da9bb8d741ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 05:41:05.335438) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 05:41:05.335918) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 05:41:05.336278) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 05:41:05.455026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 05:41:05.455398) ========= 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.x6AfgJZIkE/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.cPG3N4CBts/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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-24 05:41: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% 69.5M=0s 2016-10-24 05:41:05 (69.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.455226 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 05:41:05.948649) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 05:41:05.948980) ========= 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.x6AfgJZIkE/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.cPG3N4CBts/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.026535 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 05:41:05.998408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 05:41:05.998780) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 215f9686117673a2c914ed207bc7da9bb8d741ad --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 215f9686117673a2c914ed207bc7da9bb8d741ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.x6AfgJZIkE/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.cPG3N4CBts/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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-24 05:41:06,080 truncating revision to first 12 chars 2016-10-24 05:41:06,080 Setting DEBUG logging. 2016-10-24 05:41:06,080 attempt 1/10 2016-10-24 05:41:06,080 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/215f96861176?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 05:41:06,727 unpacking tar archive at: mozilla-central-215f96861176/testing/mozharness/ program finished with exit code 0 elapsedTime=0.901435 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 05:41:06.922191) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 05:41:06.922567) ========= script_repo_revision: 215f9686117673a2c914ed207bc7da9bb8d741ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 05:41:06.923026) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 05:41:06.923342) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 05:41:06.942381) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-10-24 05:41:06.942848) ========= /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.x6AfgJZIkE/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.cPG3N4CBts/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 05:41:07 INFO - MultiFileLogger online at 20161024 05:41:07 in /builds/slave/test 05:41:07 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 05:41:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:41:07 INFO - {'append_to_log': False, 05:41:07 INFO - 'base_work_dir': '/builds/slave/test', 05:41:07 INFO - 'blob_upload_branch': 'Firefox', 05:41:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:41:07 INFO - 'branch': 'Firefox', 05:41:07 INFO - 'buildbot_json_path': 'buildprops.json', 05:41:07 INFO - 'config_files': ('talos/mac_config.py',), 05:41:07 INFO - 'default_actions': ('clobber', 05:41:07 INFO - 'read-buildbot-config', 05:41:07 INFO - 'download-and-extract', 05:41:07 INFO - 'populate-webroot', 05:41:07 INFO - 'create-virtualenv', 05:41:07 INFO - 'install', 05:41:07 INFO - 'run-tests'), 05:41:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:41:07 INFO - 'download_minidump_stackwalk': True, 05:41:07 INFO - 'download_symbols': 'ondemand', 05:41:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:41:07 INFO - 'tooltool.py': '/tools/tooltool.py', 05:41:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:41:07 INFO - '/tools/misc-python/virtualenv.py')}, 05:41:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:41:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:41:07 INFO - 'installer_path': 'installer.exe', 05:41:07 INFO - 'log_level': 'info', 05:41:07 INFO - 'log_name': 'talos', 05:41:07 INFO - 'log_to_console': True, 05:41:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:41:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:41:07 INFO - 'opt_config_files': (), 05:41:07 INFO - 'pip_index': False, 05:41:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:41:07 INFO - 'cmd': ('bash', 05:41:07 INFO - '-c', 05:41:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:41:07 INFO - 'enabled': True, 05:41:07 INFO - 'halt_on_failure': False, 05:41:07 INFO - 'name': 'check_screen_resolution'},), 05:41:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:41:07 INFO - 'cmd': ('bash', 05:41:07 INFO - '-c', 05:41:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:41:07 INFO - 'enabled': True, 05:41:07 INFO - 'halt_on_failure': False, 05:41:07 INFO - 'name': 'check_screen_resolution'},), 05:41:07 INFO - 'run_cmd_checks_enabled': True, 05:41:07 INFO - 'sps_profile': False, 05:41:07 INFO - 'sps_profile_interval': 0, 05:41:07 INFO - 'suite': 'dromaeojs', 05:41:07 INFO - 'system_bits': '32', 05:41:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:41:07 INFO - 'title': 't-yosemite-r7-0135', 05:41:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:41:07 INFO - 'use_talos_json': True, 05:41:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:41:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:41:07 INFO - 'work_dir': 'build'} 05:41:07 INFO - [mozharness: 2016-10-24 12:41:07.156526Z] Running clobber step. 05:41:07 INFO - Running pre-action listener: _resource_record_pre_action 05:41:07 INFO - Running main action method: clobber 05:41:07 INFO - rmtree: /builds/slave/test/build 05:41:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:41:09 INFO - Running post-action listener: _resource_record_post_action 05:41:09 INFO - [mozharness: 2016-10-24 12:41:09.322380Z] Finished clobber step (success) 05:41:09 INFO - [mozharness: 2016-10-24 12:41:09.322564Z] Running read-buildbot-config step. 05:41:09 INFO - Running pre-action listener: _resource_record_pre_action 05:41:09 INFO - Running main action method: read_buildbot_config 05:41:09 INFO - Using buildbot properties: 05:41:09 INFO - { 05:41:09 INFO - "project": "", 05:41:09 INFO - "product": "firefox", 05:41:09 INFO - "script_repo_revision": "production", 05:41:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:41:09 INFO - "repository": "", 05:41:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:41:09 INFO - "buildid": "20161024030205", 05:41:09 INFO - "stage_platform": "macosx64", 05:41:09 INFO - "basedir": "/builds/slave/test", 05:41:09 INFO - "nightly_build": "True", 05:41:09 INFO - "buildnumber": 58, 05:41:09 INFO - "slavename": "t-yosemite-r7-0135", 05:41:09 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:41:09 INFO - "platform": "yosemite_r7", 05:41:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:41:09 INFO - "branch": "mozilla-central", 05:41:09 INFO - "repo_path": "mozilla-central", 05:41:09 INFO - "revision": "215f9686117673a2c914ed207bc7da9bb8d741ad", 05:41:09 INFO - "pgo_build": "False", 05:41:09 INFO - "builduid": "25896b81c02c43e39fb49284fea31552", 05:41:09 INFO - "slavebuilddir": "test" 05:41:09 INFO - } 05:41:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:41:09 INFO - Running post-action listener: _resource_record_post_action 05:41:09 INFO - [mozharness: 2016-10-24 12:41:09.328240Z] Finished read-buildbot-config step (success) 05:41:09 INFO - [mozharness: 2016-10-24 12:41:09.328379Z] Running download-and-extract step. 05:41:09 INFO - Running pre-action listener: _resource_record_pre_action 05:41:09 INFO - Running main action method: download_and_extract 05:41:09 INFO - mkdir: /builds/slave/test/build/tests 05:41: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')]} 05:41:09 INFO - trying https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:41:09 INFO - Downloading https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/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 05:41:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/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 05:41:10 INFO - Downloaded 1199 bytes. 05:41:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:41:10 INFO - Using the following test package requirements: 05:41:10 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:41:10 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:41:10 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:41:10 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:41:10 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:41:10 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:41:10 INFO - u'jsshell-mac.zip'], 05:41:10 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:41:10 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:41:10 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:41:10 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:41:10 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:41:10 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:41:10 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:41:10 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:41:10 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:41:10 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:41:10 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:41:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:41:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:41:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:41:10 INFO - Fetch https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:41:10 INFO - Http code: 200 05:41:10 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 05:41:10 INFO - x-amz-cf-id: MIupzTmi2DCK83cwAwokPujTthilcMnW6-r3_XfVlDfr71tGjHIkGA== 05:41:10 INFO - x-amz-version-id: Nbv9pYBtR5f_6RgLvJBm2pVI168eLVXz 05:41:11 INFO - Expected file size: 16409521 05:41:11 INFO - Obtained file size: 16409521 05:41:17 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 05:41:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:41:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:41:17 INFO - Fetch https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:41:18 INFO - Http code: 200 05:41:18 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 05:41:18 INFO - x-amz-cf-id: REFgXQ9sB4Z1HNmLIwn6zujKtZewg9AR9wU0nMkfqtGJEhp9JejGmw== 05:41:18 INFO - x-amz-version-id: Nbv9pYBtR5f_6RgLvJBm2pVI168eLVXz 05:41:18 INFO - Expected file size: 16409521 05:41:18 INFO - Obtained file size: 16409521 05:41:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:41:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:41:24 INFO - Fetch https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:41:25 INFO - Http code: 200 05:41:25 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 05:41:25 INFO - x-amz-cf-id: Kp5HC4exNEEPuRpjstggJsHr4yAffAh8SDXuBFvMtqJCjStZo5cv8Q== 05:41:25 INFO - x-amz-version-id: Fm6lU2Qx2B8PWcCJLDkyyaR1tVx6svBL 05:41:26 INFO - Expected file size: 14409028 05:41:26 INFO - Obtained file size: 14409028 05:41: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')]} 05:41:27 INFO - trying https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:41:27 INFO - Downloading https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:41:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/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 05:41:31 INFO - Downloaded 111345375 bytes. 05:41:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:41:31 INFO - mkdir: /builds/slave/test/properties 05:41:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:41:31 INFO - Writing to file /builds/slave/test/properties/build_url 05:41:31 INFO - Contents: 05:41:31 INFO - build_url:https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:41:32 INFO - Running post-action listener: _resource_record_post_action 05:41:32 INFO - Running post-action listener: set_extra_try_arguments 05:41:32 INFO - [mozharness: 2016-10-24 12:41:32.426681Z] Finished download-and-extract step (success) 05:41:32 INFO - [mozharness: 2016-10-24 12:41:32.426826Z] Running populate-webroot step. 05:41:32 INFO - Running pre-action listener: _resource_record_pre_action 05:41:32 INFO - Running main action method: populate_webroot 05:41:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:41:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:41:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:41:32 INFO - '--tppagecycles', 05:41:32 INFO - '7'], 05:41:32 INFO - 'tests': ['tsvgm']}}, 05:41:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:41:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:41:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:41:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:41:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:41:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:41:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:32 INFO - 'talos_options': ['--disable-e10s'], 05:41:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:32 INFO - 'talos_options': ['--disable-e10s'], 05:41:32 INFO - 'tests': ['damp', 'tps']}, 05:41:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:32 INFO - 'tests': ['damp', 'tps']}, 05:41:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:41:32 INFO - 'tests': ['dromaeo_dom']}, 05:41:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:41:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:41:32 INFO - 'tests': ['basic_compositor_video']}, 05:41:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:41:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:41:32 INFO - 'tests': ['a11yr', 05:41:32 INFO - 'ts_paint', 05:41:32 INFO - 'tpaint', 05:41:32 INFO - 'sessionrestore', 05:41:32 INFO - 'sessionrestore_no_auto_restore', 05:41:32 INFO - 'tabpaint']}, 05:41:32 INFO - 'other-e10s': {'tests': ['a11yr', 05:41:32 INFO - 'ts_paint', 05:41:32 INFO - 'tpaint', 05:41:32 INFO - 'sessionrestore', 05:41:32 INFO - 'sessionrestore_no_auto_restore', 05:41:32 INFO - 'tabpaint']}, 05:41:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:41:32 INFO - 'ts_paint', 05:41:32 INFO - 'tpaint', 05:41:32 INFO - 'sessionrestore', 05:41:32 INFO - 'sessionrestore_no_auto_restore', 05:41:32 INFO - 'tabpaint']}, 05:41:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:41:32 INFO - 'ts_paint', 05:41:32 INFO - 'tpaint', 05:41:32 INFO - 'sessionrestore', 05:41:32 INFO - 'sessionrestore_no_auto_restore', 05:41:32 INFO - 'tabpaint']}, 05:41:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:41:32 INFO - 'tests': ['a11yr', 05:41:32 INFO - 'ts_paint', 05:41:32 INFO - 'tpaint', 05:41:32 INFO - 'sessionrestore', 05:41:32 INFO - 'sessionrestore_no_auto_restore', 05:41:32 INFO - 'tabpaint']}, 05:41:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:41:32 INFO - 'tests': ['a11yr', 05:41:32 INFO - 'ts_paint', 05:41:32 INFO - 'tpaint', 05:41:32 INFO - 'sessionrestore', 05:41:32 INFO - 'sessionrestore_no_auto_restore', 05:41:32 INFO - 'tabpaint']}, 05:41:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:41:32 INFO - 'tests': ['tsvgx', 05:41:32 INFO - 'tsvgr_opacity', 05:41:32 INFO - 'tart', 05:41:32 INFO - 'tscrollx', 05:41:32 INFO - 'cart']}, 05:41:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:41:32 INFO - 'tsvgr_opacity', 05:41:32 INFO - 'tart', 05:41:32 INFO - 'tscrollx', 05:41:32 INFO - 'cart']}, 05:41:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:32 INFO - 'talos_options': ['--disable-e10s'], 05:41:32 INFO - 'tests': ['tp5o']}, 05:41:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:32 INFO - 'tests': ['tp5o']}, 05:41:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:32 INFO - 'talos_options': ['--disable-e10s', 05:41:32 INFO - '--xperf_path', 05:41:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:32 INFO - 'tests': ['tp5n']}, 05:41:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:32 INFO - 'talos_options': ['--xperf_path', 05:41:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:32 INFO - 'tests': ['tp5n']}}, 05:41:32 INFO - 'talos.zip': {'path': '', 05:41:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:41:32 INFO - Running post-action listener: _resource_record_post_action 05:41:32 INFO - [mozharness: 2016-10-24 12:41:32.443678Z] Finished populate-webroot step (success) 05:41:32 INFO - [mozharness: 2016-10-24 12:41:32.443783Z] Running create-virtualenv step. 05:41:32 INFO - Running pre-action listener: _resource_record_pre_action 05:41:32 INFO - Running main action method: create_virtualenv 05:41:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:41:32 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 05:41:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:41:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:41:32 INFO - Using real prefix '/tools/python27' 05:41:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:41:33 INFO - Installing distribute.............................................................................................................................................................................................done. 05:41:36 INFO - Installing pip.................done. 05:41:36 INFO - Return code: 0 05:41:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:41:36 INFO - Reading from file tmpfile_stdout 05:41:36 INFO - Output received: 05:41:36 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) 05:41:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:41:36 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')]} 05:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:36 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')]} 05:41:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:36 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 0x104b2c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aa2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bad584c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x104766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.x6AfgJZIkE/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.cPG3N4CBts/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 05:41:36 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 05:41:36 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 05:41:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x6AfgJZIkE/Render', 05:41:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:36 INFO - 'HOME': '/Users/cltbld', 05:41:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:36 INFO - 'LOGNAME': 'cltbld', 05:41:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:36 INFO - 'MOZ_NO_REMOTE': '1', 05:41:36 INFO - 'NO_EM_RESTART': '1', 05:41:36 INFO - 'PAGER': '/bin/cat', 05:41:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:36 INFO - 'PWD': '/builds/slave/test', 05:41:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:36 INFO - 'SHELL': '/bin/bash', 05:41:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cPG3N4CBts/Listeners', 05:41:36 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 05:41:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:36 INFO - 'USER': 'cltbld', 05:41:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:36 INFO - 'XPC_FLAGS': '0x0', 05:41:36 INFO - 'XPC_SERVICE_NAME': '0', 05:41:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:36 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 05:41:36 INFO - Cleaning up... 05:41:36 INFO - Return code: 0 05:41:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:41:36 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')]} 05:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:36 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')]} 05:41:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:36 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 0x104b2c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aa2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bad584c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x104766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.x6AfgJZIkE/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.cPG3N4CBts/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 05:41:36 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 05:41:36 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 05:41:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x6AfgJZIkE/Render', 05:41:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:36 INFO - 'HOME': '/Users/cltbld', 05:41:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:36 INFO - 'LOGNAME': 'cltbld', 05:41:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:36 INFO - 'MOZ_NO_REMOTE': '1', 05:41:36 INFO - 'NO_EM_RESTART': '1', 05:41:36 INFO - 'PAGER': '/bin/cat', 05:41:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:36 INFO - 'PWD': '/builds/slave/test', 05:41:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:36 INFO - 'SHELL': '/bin/bash', 05:41:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cPG3N4CBts/Listeners', 05:41:36 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 05:41:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:36 INFO - 'USER': 'cltbld', 05:41:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:36 INFO - 'XPC_FLAGS': '0x0', 05:41:36 INFO - 'XPC_SERVICE_NAME': '0', 05:41:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:36 INFO - Downloading/unpacking psutil>=3.1.1 05:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:41:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:40 INFO - Installing collected packages: psutil 05:41:40 INFO - Running setup.py install for psutil 05:41:41 INFO - building 'psutil._psutil_osx' extension 05:41:41 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 05:41:41 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 05:41:41 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 05:41:41 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 05:41:41 INFO - building 'psutil._psutil_posix' extension 05:41:41 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 05:41:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:41:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:41:41 INFO - ^ 05:41:41 INFO - 1 warning generated. 05:41:41 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 05:41:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:42 INFO - Successfully installed psutil 05:41:42 INFO - Cleaning up... 05:41:42 INFO - Return code: 0 05:41:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:41:42 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')]} 05:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:42 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')]} 05:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:42 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 0x104b2c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aa2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bad584c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x104766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.x6AfgJZIkE/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.cPG3N4CBts/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 05:41:42 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 05:41:42 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 05:41:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x6AfgJZIkE/Render', 05:41:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:42 INFO - 'HOME': '/Users/cltbld', 05:41:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:42 INFO - 'LOGNAME': 'cltbld', 05:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:42 INFO - 'MOZ_NO_REMOTE': '1', 05:41:42 INFO - 'NO_EM_RESTART': '1', 05:41:42 INFO - 'PAGER': '/bin/cat', 05:41:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:42 INFO - 'PWD': '/builds/slave/test', 05:41:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:42 INFO - 'SHELL': '/bin/bash', 05:41:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cPG3N4CBts/Listeners', 05:41:42 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 05:41:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:42 INFO - 'USER': 'cltbld', 05:41:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:42 INFO - 'XPC_FLAGS': '0x0', 05:41:42 INFO - 'XPC_SERVICE_NAME': '0', 05:41:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:41:42 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 05:41:42 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 05:41:42 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 05:41:42 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 05:41:42 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 05:41:42 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 05:41:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:41:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:41:45 INFO - Installing collected packages: mozsystemmonitor 05:41:45 INFO - Running setup.py install for mozsystemmonitor 05:41:45 INFO - Successfully installed mozsystemmonitor 05:41:45 INFO - Cleaning up... 05:41:45 INFO - Return code: 0 05:41:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:45 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 0x104b2c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aa2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bad584c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x104766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.x6AfgJZIkE/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.cPG3N4CBts/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 05:41:45 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 05:41:45 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 05:41:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x6AfgJZIkE/Render', 05:41:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:45 INFO - 'HOME': '/Users/cltbld', 05:41:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:45 INFO - 'LOGNAME': 'cltbld', 05:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:45 INFO - 'MOZ_NO_REMOTE': '1', 05:41:45 INFO - 'NO_EM_RESTART': '1', 05:41:45 INFO - 'PAGER': '/bin/cat', 05:41:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:45 INFO - 'PWD': '/builds/slave/test', 05:41:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:45 INFO - 'SHELL': '/bin/bash', 05:41:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cPG3N4CBts/Listeners', 05:41:45 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 05:41:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:45 INFO - 'USER': 'cltbld', 05:41:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:45 INFO - 'XPC_FLAGS': '0x0', 05:41:45 INFO - 'XPC_SERVICE_NAME': '0', 05:41:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:45 INFO - Downloading/unpacking jsonschema==2.5.1 05:41: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 05:41: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 05:41: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 05:41: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 05:41: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 05:41: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 05:41:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:41:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:41:48 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 05:41:48 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 05:41:48 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 05:41:48 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 05:41:48 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 05:41:48 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 05:41:48 INFO - Downloading functools32-3.2.3-2.tar.gz 05:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:41:48 INFO - warning: no files found matching '*.txt' 05:41:48 INFO - no previously-included directories found matching 'build' 05:41:48 INFO - no previously-included directories found matching 'dist' 05:41:48 INFO - no previously-included directories found matching '.git*' 05:41:48 INFO - Installing collected packages: jsonschema, functools32 05:41:48 INFO - Running setup.py install for functools32 05:41:48 INFO - warning: no files found matching '*.txt' 05:41:48 INFO - no previously-included directories found matching 'build' 05:41:48 INFO - no previously-included directories found matching 'dist' 05:41:48 INFO - no previously-included directories found matching '.git*' 05:41:48 INFO - Successfully installed jsonschema functools32 05:41:48 INFO - Cleaning up... 05:41:48 INFO - Return code: 0 05:41:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:48 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 0x104b2c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aa2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bad584c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x104766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.x6AfgJZIkE/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.cPG3N4CBts/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 05:41:48 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 05:41:48 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 05:41:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x6AfgJZIkE/Render', 05:41:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:48 INFO - 'HOME': '/Users/cltbld', 05:41:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:48 INFO - 'LOGNAME': 'cltbld', 05:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:48 INFO - 'MOZ_NO_REMOTE': '1', 05:41:48 INFO - 'NO_EM_RESTART': '1', 05:41:48 INFO - 'PAGER': '/bin/cat', 05:41:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:48 INFO - 'PWD': '/builds/slave/test', 05:41:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:48 INFO - 'SHELL': '/bin/bash', 05:41:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cPG3N4CBts/Listeners', 05:41:48 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 05:41:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:48 INFO - 'USER': 'cltbld', 05:41:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:48 INFO - 'XPC_FLAGS': '0x0', 05:41:48 INFO - 'XPC_SERVICE_NAME': '0', 05:41:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:41:49 INFO - Cleaning up... 05:41:49 INFO - Return code: 0 05:41:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104b2c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aa2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bad584c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x104766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.x6AfgJZIkE/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.cPG3N4CBts/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 05:41:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:41:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x6AfgJZIkE/Render', 05:41:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:49 INFO - 'HOME': '/Users/cltbld', 05:41:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:49 INFO - 'LOGNAME': 'cltbld', 05:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:49 INFO - 'MOZ_NO_REMOTE': '1', 05:41:49 INFO - 'NO_EM_RESTART': '1', 05:41:49 INFO - 'PAGER': '/bin/cat', 05:41:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:49 INFO - 'PWD': '/builds/slave/test', 05:41:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:49 INFO - 'SHELL': '/bin/bash', 05:41:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cPG3N4CBts/Listeners', 05:41:49 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 05:41:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:49 INFO - 'USER': 'cltbld', 05:41:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:49 INFO - 'XPC_FLAGS': '0x0', 05:41:49 INFO - 'XPC_SERVICE_NAME': '0', 05:41:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:41: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 05:41: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 05:41: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 05:41: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 05:41: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 05:41: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 05:41:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:41:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:41:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:41:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:53 INFO - Downloading docopt-0.6.1.tar.gz 05:41:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:41:53 INFO - Installing collected packages: blobuploader, requests, docopt 05:41:53 INFO - Running setup.py install for blobuploader 05:41:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:41:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:41:53 INFO - Running setup.py install for requests 05:41:53 INFO - Running setup.py install for docopt 05:41:54 INFO - Successfully installed blobuploader requests docopt 05:41:54 INFO - Cleaning up... 05:41:54 INFO - Return code: 0 05:41:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:54 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')]} 05:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:54 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')]} 05:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:54 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 0x104b2c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aa2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bad584c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x104766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.x6AfgJZIkE/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.cPG3N4CBts/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 05:41:54 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 05:41:54 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 05:41:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x6AfgJZIkE/Render', 05:41:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:54 INFO - 'HOME': '/Users/cltbld', 05:41:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:54 INFO - 'LOGNAME': 'cltbld', 05:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:54 INFO - 'MOZ_NO_REMOTE': '1', 05:41:54 INFO - 'NO_EM_RESTART': '1', 05:41:54 INFO - 'PAGER': '/bin/cat', 05:41:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:54 INFO - 'PWD': '/builds/slave/test', 05:41:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:54 INFO - 'SHELL': '/bin/bash', 05:41:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cPG3N4CBts/Listeners', 05:41:54 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 05:41:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:54 INFO - 'USER': 'cltbld', 05:41:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:54 INFO - 'XPC_FLAGS': '0x0', 05:41:54 INFO - 'XPC_SERVICE_NAME': '0', 05:41:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:41:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-aoQAa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:41:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-8lUDN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:41:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-iRtUIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:41:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-2EWvVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:41:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-xvzw0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:41:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-BrLEQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:41:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-4E9fQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:41:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Xi_i2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:41:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-JyLpFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:41:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-nFh8PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:41:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-iNtN09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:41:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Y9aelB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:41:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-qGj6Tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:41:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-D2fnWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-0IhTLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:41:55 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-sFBPTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:41:56 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-RARd_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:41:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:41:56 INFO - Running setup.py install for manifestparser 05:41:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:41:56 INFO - Running setup.py install for mozcrash 05:41:56 INFO - Running setup.py install for mozdebug 05:41:56 INFO - Running setup.py install for mozdevice 05:41:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:41:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:41:56 INFO - Running setup.py install for mozfile 05:41:56 INFO - Running setup.py install for mozhttpd 05:41:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Running setup.py install for mozinfo 05:41:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Running setup.py install for mozInstall 05:41:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Running setup.py install for mozleak 05:41:57 INFO - Running setup.py install for mozlog 05:41:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Running setup.py install for moznetwork 05:41:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Running setup.py install for mozprocess 05:41:57 INFO - Running setup.py install for mozprofile 05:41:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:41:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:41:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:41:58 INFO - Running setup.py install for mozrunner 05:41:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:41:58 INFO - Running setup.py install for mozscreenshot 05:41:58 INFO - Running setup.py install for moztest 05:41:58 INFO - Running setup.py install for mozversion 05:41:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:41:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:41:58 INFO - Cleaning up... 05:41:58 INFO - Return code: 0 05:41:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:58 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 0x104b2c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aa2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bad584c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x104766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.x6AfgJZIkE/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.cPG3N4CBts/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 05:41:58 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 05:41:58 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 05:41:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x6AfgJZIkE/Render', 05:41:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:58 INFO - 'HOME': '/Users/cltbld', 05:41:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:58 INFO - 'LOGNAME': 'cltbld', 05:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:58 INFO - 'MOZ_NO_REMOTE': '1', 05:41:58 INFO - 'NO_EM_RESTART': '1', 05:41:58 INFO - 'PAGER': '/bin/cat', 05:41:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:58 INFO - 'PWD': '/builds/slave/test', 05:41:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:58 INFO - 'SHELL': '/bin/bash', 05:41:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cPG3N4CBts/Listeners', 05:41:58 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 05:41:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:58 INFO - 'USER': 'cltbld', 05:41:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:58 INFO - 'XPC_FLAGS': '0x0', 05:41:58 INFO - 'XPC_SERVICE_NAME': '0', 05:41:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:41:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-F04C9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:41:59 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)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:41:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-XK_zVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:41:59 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)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:41:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-qrlflk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:41:59 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)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:41:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-kuR4gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:41:59 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)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:41:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-7R2g6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:41:59 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)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:41:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-WxZmE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:41:59 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)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:41:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-g7piqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:41:59 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)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:41:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-vpoE_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:41:59 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)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:41:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-jTmiPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:41:59 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)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:41:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-b3PG8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:42:00 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)) 05:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:42:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-PTdIvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:42:00 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)) 05:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:42:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-jMVPwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:42:00 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)) 05:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:42:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-kcNv4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:42:00 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)) 05:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:42:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-CBOCgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:42:00 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)) 05:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-5tcsD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:00 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)) 05:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:42:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-XCJWw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:42:00 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)) 05:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:42:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-LGwUtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:42:00 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)) 05:42:00 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)) 05:42:00 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)) 05:42:00 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)) 05:42:00 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)) 05:42:00 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)) 05:42:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:42:00 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 05:42:00 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 05:42:00 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 05:42:00 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 05:42:00 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 05:42:00 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 05:42:03 INFO - Downloading blessings-1.6.tar.gz 05:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:42:03 INFO - Installing collected packages: blessings 05:42:03 INFO - Running setup.py install for blessings 05:42:03 INFO - Successfully installed blessings 05:42:03 INFO - Cleaning up... 05:42:03 INFO - Return code: 0 05:42:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:42:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:42:03 INFO - Reading from file tmpfile_stdout 05:42:03 INFO - Current package versions: 05:42:03 INFO - blessings == 1.6 05:42:03 INFO - blobuploader == 1.2.4 05:42:03 INFO - docopt == 0.6.1 05:42:03 INFO - functools32 == 3.2.3-2 05:42:03 INFO - jsonschema == 2.5.1 05:42:03 INFO - manifestparser == 1.1 05:42:03 INFO - mozInstall == 1.12 05:42:03 INFO - mozcrash == 0.17 05:42:03 INFO - mozdebug == 0.1 05:42:03 INFO - mozdevice == 0.48 05:42:03 INFO - mozfile == 1.2 05:42:03 INFO - mozhttpd == 0.7 05:42:03 INFO - mozinfo == 0.9 05:42:03 INFO - mozleak == 0.1 05:42:03 INFO - mozlog == 3.4 05:42:03 INFO - moznetwork == 0.27 05:42:03 INFO - mozprocess == 0.23 05:42:03 INFO - mozprofile == 0.28 05:42:03 INFO - mozrunner == 6.12 05:42:03 INFO - mozscreenshot == 0.1 05:42:03 INFO - mozsystemmonitor == 0.3 05:42:03 INFO - moztest == 0.7 05:42:03 INFO - mozversion == 1.4 05:42:03 INFO - psutil == 3.1.1 05:42:03 INFO - requests == 1.2.3 05:42:03 INFO - wsgiref == 0.1.2 05:42:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42: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')]} 05:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42: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')]} 05:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:03 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 0x104b2c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aa2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bad584c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x104766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.x6AfgJZIkE/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.cPG3N4CBts/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 05:42:03 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 05:42:03 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 05:42:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x6AfgJZIkE/Render', 05:42:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:42:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:42:03 INFO - 'HOME': '/Users/cltbld', 05:42:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:42:03 INFO - 'LOGNAME': 'cltbld', 05:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:03 INFO - 'MOZ_NO_REMOTE': '1', 05:42:03 INFO - 'NO_EM_RESTART': '1', 05:42:03 INFO - 'PAGER': '/bin/cat', 05:42:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:03 INFO - 'PWD': '/builds/slave/test', 05:42:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:42:03 INFO - 'SHELL': '/bin/bash', 05:42:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cPG3N4CBts/Listeners', 05:42:03 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 05:42:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:42:03 INFO - 'USER': 'cltbld', 05:42:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:42:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:03 INFO - 'XPC_FLAGS': '0x0', 05:42:03 INFO - 'XPC_SERVICE_NAME': '0', 05:42:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:04 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)) 05:42:04 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)) 05:42:04 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)) 05:42:04 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)) 05:42:04 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)) 05:42:04 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)) 05:42:04 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)) 05:42:04 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)) 05:42:04 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)) 05:42:04 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)) 05:42:04 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)) 05:42:04 INFO - Cleaning up... 05:42:04 INFO - Return code: 0 05:42:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:42:04 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')]} 05:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:04 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')]} 05:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:04 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 0x104b2c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aa2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98bad584c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104940d30>, '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 0x104766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, '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.x6AfgJZIkE/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.cPG3N4CBts/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 05:42:04 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 05:42:04 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 05:42:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x6AfgJZIkE/Render', 05:42:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:42:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:42:04 INFO - 'HOME': '/Users/cltbld', 05:42:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:42:04 INFO - 'LOGNAME': 'cltbld', 05:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:04 INFO - 'MOZ_NO_REMOTE': '1', 05:42:04 INFO - 'NO_EM_RESTART': '1', 05:42:04 INFO - 'PAGER': '/bin/cat', 05:42:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:04 INFO - 'PWD': '/builds/slave/test', 05:42:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:42:04 INFO - 'SHELL': '/bin/bash', 05:42:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cPG3N4CBts/Listeners', 05:42:04 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 05:42:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:42:04 INFO - 'USER': 'cltbld', 05:42:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:42:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:04 INFO - 'XPC_FLAGS': '0x0', 05:42:04 INFO - 'XPC_SERVICE_NAME': '0', 05:42:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:42:04 INFO - Cleaning up... 05:42:04 INFO - Return code: 0 05:42:04 INFO - Running post-action listener: _resource_record_post_action 05:42:04 INFO - Running post-action listener: _start_resource_monitoring 05:42:04 INFO - Starting resource monitoring. 05:42:04 INFO - [mozharness: 2016-10-24 12:42:04.566129Z] Finished create-virtualenv step (success) 05:42:04 INFO - [mozharness: 2016-10-24 12:42:04.567135Z] Running install step. 05:42:04 INFO - Running pre-action listener: _resource_record_pre_action 05:42:04 INFO - Running main action method: install 05:42:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:42:04 INFO - Reading from file tmpfile_stdout 05:42:04 INFO - Detecting whether we're running mozinstall >=1.0... 05:42:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:42:04 INFO - Reading from file tmpfile_stdout 05:42:04 INFO - Output received: 05:42:04 INFO - Usage: mozinstall [options] installer 05:42:04 INFO - Options: 05:42:04 INFO - -h, --help show this help message and exit 05:42:04 INFO - -d DEST, --destination=DEST 05:42:04 INFO - Directory to install application into. [default: 05:42:04 INFO - "/builds/slave/test"] 05:42:04 INFO - --app=APP Application being installed. [default: firefox] 05:42:04 INFO - mkdir: /builds/slave/test/build/application 05:42: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'] 05:42: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 05:42:39 INFO - Reading from file tmpfile_stdout 05:42:39 INFO - Output received: 05:42:39 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:42:39 INFO - Running post-action listener: _resource_record_post_action 05:42:39 INFO - [mozharness: 2016-10-24 12:42:39.062840Z] Finished install step (success) 05:42:39 INFO - [mozharness: 2016-10-24 12:42:39.062980Z] Running run-tests step. 05:42:39 INFO - Running pre-action listener: _resource_record_pre_action 05:42:39 INFO - Running main action method: run_tests 05:42:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:42:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:42:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:42:39 INFO - 2016-10-24 05:42:39.077 screenresolution[1644:8620] starting screenresolution argv=screenresolution get 05:42:39 INFO - 2016-10-24 05:42:39.079 screenresolution[1644:8620] Display 0: 1600x1200x32@60 05:42:39 INFO - 2016-10-24 05:42:39.085 screenresolution[1645:8623] starting screenresolution argv=screenresolution list 05:42:39 INFO - Available Modes on Display 0 05:42:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:42:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:42:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:42:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:42:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:42:39 INFO - Intel Iris: 05:42:39 INFO - Chipset Model: Intel Iris 05:42:39 INFO - Type: GPU 05:42:39 INFO - Bus: Built-In 05:42:39 INFO - VRAM (Dynamic, Max): 1536 MB 05:42:39 INFO - Vendor: Intel (0x8086) 05:42:39 INFO - Device ID: 0x0a2e 05:42:39 INFO - Revision ID: 0x0009 05:42:39 INFO - Displays: 05:42:39 INFO - Display: 05:42:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:42:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:42:39 INFO - Display Serial Number: 1600x1200 60 05:42:39 INFO - Main Display: Yes 05:42:39 INFO - Mirror: Off 05:42:39 INFO - Online: Yes 05:42:39 INFO - Rotation: Supported 05:42:39 INFO - Return code: 0 05:42:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:42:39 INFO - Python 2.7.3 05:42:39 INFO - Return code: 0 05:42:39 INFO - grabbing minidump binary from tooltool 05:42:39 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')]} 05:42:39 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 0x104940d30>, '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 0x104766db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104938b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:42:39 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 05:42:39 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 05:42:39 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 05:42:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:42:39 INFO - Return code: 0 05:42:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:42:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:42:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:42:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:42:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:42:39 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/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--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 05:42:39 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/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0135 --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 05:42:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x6AfgJZIkE/Render', 05:42:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:42:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:42:39 INFO - 'HOME': '/Users/cltbld', 05:42:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:42:39 INFO - 'LOGNAME': 'cltbld', 05:42:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:42:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:39 INFO - 'MOZ_NO_REMOTE': '1', 05:42:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:42:39 INFO - 'NO_EM_RESTART': '1', 05:42:39 INFO - 'PAGER': '/bin/cat', 05:42:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:39 INFO - 'PWD': '/builds/slave/test', 05:42:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:42:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:42:39 INFO - 'SHELL': '/bin/bash', 05:42:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cPG3N4CBts/Listeners', 05:42:39 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 05:42:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:42:39 INFO - 'USER': 'cltbld', 05:42:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:42:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:39 INFO - 'XPC_FLAGS': '0x0', 05:42:39 INFO - 'XPC_SERVICE_NAME': '0', 05:42:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:42:39 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/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--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 05:42:39 INFO - mozversion application_buildid: 20161024030205 05:42:39 INFO - mozversion application_changeset: 215f9686117673a2c914ed207bc7da9bb8d741ad 05:42:39 INFO - mozversion application_display_name: Nightly 05:42:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:42:39 INFO - mozversion application_name: Firefox 05:42:39 INFO - mozversion application_remotingname: firefox 05:42:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:42:39 INFO - mozversion application_vendor: Mozilla 05:42:39 INFO - mozversion application_version: 52.0a1 05:42:39 INFO - mozversion platform_buildid: 20161024030205 05:42:39 INFO - mozversion platform_changeset: 215f9686117673a2c914ed207bc7da9bb8d741ad 05:42:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:42:39 INFO - mozversion platform_version: 52.0a1 05:42:39 INFO - using testdate: 1477312959 05:42:39 INFO - actual date: 1477312959 05:42:39 INFO - starting webserver on 'localhost:49272' 05:42:39 INFO - SUITE-START | Running 2 tests 05:42:39 INFO - TEST-START | dromaeo_css 05:42:39 INFO - operating with platform_type : mac_ 05:42:39 INFO - Initialising browser for dromaeo_css test... 05:42:39 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpSvq8ST/profile http://localhost:49272/getInfo.html) 05:42:42 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 05:42:42 INFO - PROCESS | 1655 | colorDepth:24 05:42:42 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 05:42:42 INFO - PROCESS | 1655 | __metrics 05:42:42 INFO - PROCESS | 1655 | 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" 05:42:42 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:42:43 INFO - TEST-INFO | 1655: exit 0 05:42:43 INFO - Browser initialized. 05:42:43 INFO - Running cycle 1/1 for dromaeo_css test... 05:42:43 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpSvq8ST/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:42:55 INFO - PROCESS | 1660 | RSS: Main: 238829568 05:42:55 INFO - PROCESS | 1660 | 05:43:46 INFO - PROCESS | 1660 | 1477313026442 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] 05:45:58 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 05:46:01 INFO - PROCESS | 1660 | RSS: Main: 466219008 05:46:01 INFO - PROCESS | 1660 | 05:49:04 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 05:49:05 INFO - PROCESS | 1660 | RSS: Main: 371896320 05:49:05 INFO - PROCESS | 1660 | 05:52:07 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 05:52:08 INFO - PROCESS | 1660 | RSS: Main: 339742720 05:52:08 INFO - PROCESS | 1660 | 05:55:10 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 05:55:11 INFO - PROCESS | 1660 | RSS: Main: 346157056 05:55:11 INFO - PROCESS | 1660 | 05:58:14 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 05:58:15 INFO - PROCESS | 1660 | RSS: Main: 339259392 05:58:15 INFO - PROCESS | 1660 | 06:01:18 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 06:01:18 INFO - PROCESS | 1660 | RSS: Main: 512610304 06:01:18 INFO - PROCESS | 1660 | 06:01:18 INFO - PROCESS | 1660 | __start_tp_report 06:01:18 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 06:01:18 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 06:01:18 INFO - PROCESS | 1660 | |i|pagename|runs| 06:01:18 INFO - PROCESS | 1660 | |0;dojo.html;2805.22856214541;3301.0591981285324;3301.669833016698;3344.4314466540686;3368.7810292330996;4658.161530924433;5520.475554822286;5596.860078498034;5601.887962240753;5668.376478587352;5581.804636837712;5594.328680558328;5600.747966341514;5611.3266408031095;5613.382527921935;5099.031184075023;5142.974285128569;5143.485651434864;5176.922346164792;5222.843314700565;5166.121759300909;5180.844574662748;5201.167813149897;5238.52853243208;5263.815766448175;5235.11003129467;5243.79024839006;5269;5300.09898317287;5309.840704778863;5180.6373553851245;5218.13900706383;5220.190870415092;5261.763220655042;5264.815731449419;4930.211166213425;4973.378327709036;5158.432572417031;5163.993021360836;5172.586193104543;5608.383077861432;5611.859703507404;5627.577931655102;5734.025215713339;5735.1970724098655;6166.321704612489;6211.751529938842;6215.968920155416;6223.1287619733275;6237.34507876671;6199.411055949678;6247.187865577446;6261.655608941552;6276.968615156895;6306.0225665022;5549.472800084026;5614.2701448811395;5628;5630.746616402272;5631.070873305941;5253.737313134405;6235.563510554309;6275.748970041239;6296.433321001132;6342.080398342307;6003.3996600339615;6035.969820150871;6045.093236014633;6050.757969681252;6053.061775424816;6057.515398768088;6101.731934812992;6104.480726615073;6134.6625935573975;6177.938220617736;6086.056661217518;6124.601900876429;6126.295476020226;6131.448169664663;6138.202033735586;5033.924491132636;6143.078538219303;6152.938470615237;6162.352952939967;6172.475339596095;4773.427188737373;4857.247126695368;4863.221884498464;4868.2210846264425;4876.463589005207;4400.933985990213;4427.446569178853;4452.0873220989615;4458.77706114693;4460.420145381145;5651.463111004448;5673.375928647845;5715.371309155989;5732.283464566929;5749.338826034976;6186.133941248228;6219.720112594944;6254.562180647311;6259.342769009279;6270.372962703693;4654.790534425959;5676.4323567642905;5681.318241811009;5681.403452637496;5723.399043100498;4025.75845449274;5277.234800953917;5299.523042926078;5334.359876814729;5360.812371566976;6344.460720838688;6357.586756860789;6369.45859601939;6379.52153588492;6389.073584330153;6170.784022559189;6174.536909731878;6207.441330280297;6235.657038862906;6245.0632405139595;6235.407636274546;6276.435120839146;6278.6546739929745;6321.936780632135;6324.525660575383;6133.120447061136;6134.7121296814075;6136.94800169746;6143.54258296667;6152.415520525543;6220.626762394271;6228.968855155877;6237.1891654084675;6250.4374606285655;6266.717997690206;5668.858278542904;5805.535557155333;5870.207521984477;5989.700514974321;6034.969825150846;5868.530517558671;5908.438698323653;5920.319163296103;5923.822285331447;5927.288725352985;4794.856154315376;5756.194132821324;5766.711664416846;5773.422657734193;5786.247787787561;5841.357450680337;5893.734781934738;5908.084246941731;5915.911261330997;5919.85200369977;5757.453041961007;5772.134179873053;5779.624324418899;5781.277340332458;5788.7395067222915 06:01:18 INFO - PROCESS | 1660 | |1;ext.html;512.4132867866293;524.5069634543529;548.4186762032244;553.3304701311413;563.5942121672399;30248.546271805913;31613;31617.36765264696;31647;31682.524762128527;41913.79043104788;42848.57151428485;42959.14081718372;45045;45106;9453.57458914347;9631.373960692532;9634.9518252409;9648.614055437774;9654.71035868925;8581.442206256574;9524;9635.518224088803;9635.951820240889;9637.18083962864;8596.527191004492;11381.317120972768;11699.824502632468;11807;12168.965637920788;11577.768444631103;11659.533618655243;11672.1829471937;11674.29954202742;11679.357635330054;8460.238578527962;8690.348223883235;11454.484548195267;11518.308901465854;11518.424078796026;39331;39998;40126;42037.36943945843;42063.73808785741;3390.4914262860766;3638.963610363889;3684.3552378333684;4010.418489319062;4084.36692312692;29269.85365073161;30601.38797224043;30813.845930770425;30892.691073089205;31435.52846707301;3159.3681263747344;3291.4569096099117;3301.9174520637175;3336.4494858348585;3349.765516413852;454273;459701;461001;463249;464237;59731.22150227971;59934.70032649896;60136.69931650401;60233;60325.39674603286;64398;64510;64535;64539.03191452132;64634.67682661556;15971.361145554049;16215.594610134842;16241.756373654405;16248.512544623443;16318.75521867173;12460.87539124597;12513.311767852674;12515.186512876633;12520;12543.24740515572;15239.238038098272;15558.611034724223;15583.376664933503;15873.539601361806;17344.47966561005;7187.353138217481;7364.815879602946;7402.518836275733;7407.000219881312;7432.591207483641;845.6279237135641;862.3230763850473;876.2551830943775;895.9776005599782;928.972130836076;29627.963021294152;29810.25474363115;30046;30455.69544304573;30496.237594059883;844.3709436469869;995.5868314649484;1041.7916416716535;1085.6091806949491;1137.9431028448544;15514.612134696723;15853.52439426819;15857.286422111032;15896.218161821635;16094.436694715629;587916;590911;592658;592819;592976;49837;50748;50894;57602.7119864398;57628;1353.289523000413;1369.5685858954596;1411.1251024364753;1414.476643641859;1419.7515434798868;29872.19418956414;30470.390592188476;30556.236094097825;30622.84688576543;31316.686833132288;49899;50565;50620.24069638885;50639;50644.746776265885;388780.2804929899;392055;398247;440191;441779;24832.50334993326;25016.62475062839;25061.24816255515;25324.36689082714;25368.746312536638;44873.775631121636;45365;45544.31683524816;45631;45880.77059614681;37522.437163443115;37703.70518485929;37986.24027519379;38641.22717545577;38736;36927.81536092302;37277;37615;38300;38767.41848872213;37035;37597.62402375941;37782;37799.43300850435;37919.43120853134;31748.888788892276;33104;34016.319673605896;34131.82934085314;34205.48691769576;22165.77834221637;22666.320010399715;24468.877655611606;24662.136825211033;25375.238742837744 06:01:18 INFO - PROCESS | 1660 | |2;jquery.html;344.4798354484727;367.9264147170565;369.1270146104463;375.47996025504676;395.59253968412526;14883.925580372097;15013;16059.437919672828;20460;20600.484987875312;19104.617907641874;19257.903710481463;19844;19928.402147935583;20123.29568465104;4974.278729584208;5514.641548299358;5716.1711551824965;5804.767809287623;5809.2738407699035;4382.890427739316;5710.885782284352;5752.626079304852;5755.107958266475;5776.364599894029;5438.3473983121885;5717.914231286534;5718.971405142989;5723.170140329649;5730;5595.63628364155;5692.31692196939;5698.857528561798;5700.743466543995;5704.201411802351;4716.481187069419;4880.243562247857;4942.950570494285;4951.3810773653295;4968.254761785725;20733.548651594396;21513.892430537748;24657;24683.876580616983;25076.373090672696;2053.9486512837298;2496.6754321938033;2650.893964241428;2785.8049936504453;2790.7209279072135;14680.192589407578;14818.851811481854;14862.628434289121;15245.39018439261;15403.15041717286;1541.2524925411167;1584.4612831637298;1785.3483478530243;1801.1084513166068;1832.3861506395374;106262;109301;110528.89471105266;111325.77348452985;117059.41470292679;11085.667429977113;11233.966828956136;11374.772504549863;11440.256383335056;11535.942320288344;14420.278986050866;14447.49433769813;14450.783238251435;14453.205073720836;14463.204523751085;8159.428839981144;8331.458455200393;8370.288525475282;8389.53857537829;8467.110953349933;8163.591820408956;8248.340132789363;8302.83394332122;8374.371922105867;8385.245327920395;3559.8220088995445;4486.68593198473;4501.527339629291;4539.205639013159;4599.862004139881;1698.8193205722152;1841.5580260737327;1845.796962334142;1899.1074195128267;1905.5236190952262;875.7564258752586;942.1850099663742;942.7131964868042;964.7009427077628;1060.6977011551826;19186.61626767457;20386.59226815485;20568.382948511568;20667.379978600668;20682.276120336017;761.7981234972737;913.3241401363076;959.6113574002541;969.3069455339466;1012.4128005756644;10079.69760907174;10091.646792362231;10311.690649280534;10727.409992450333;10809.945950270356;490082;490253;559866.4074572538;567226.3277367256;583509;83792.74310885342;107975.37449216183;119963;122488.77511224773;137307;937.8499440089689;956.6173530587821;973.9415635061919;974.5760594141572;975.658519518163;14976.700465990401;18162.273509060018;18262.452126436227;18629.068546572347;18871.433856984313;53239.733801332295;53416.322959630044;53551;54799.72600136974;54872.68964069183;73308.63345683238;77815.61092194729;78724.21275787169;79207;80878.59560702159;6568.408843203943;7843.941067955753;7945.682172713026;7946.721864734706;8226.547539885363;11221.831672524755;11405.543778248777;11545.88454115448;12321.199122057038;12330.19853709506;7816.960915195387;8947.19475247231;10421.322614030063;10901;11014.39420831862;10433.582656693647;10458.215633827342;11151.776964460503;11220.326780393203;11574;10361.84457233127;10396.688099357032;10614.938506149323;11065.889341106486;11813;6506.967465162644;8141;8181.550014749246;8275;8339.374546908884;9368.625254989724;9410;10348.223883208639;11295.209335346446;11450.969412752893 06:01:18 INFO - PROCESS | 1660 | |3;mootools.html;1520.7946927164833;1556.5641620346303;1651.975220371694;1793.5964408008192;1982.236838817055;7800.141984381714;8111.837763244746;8299.958500207498;8839.204471597555;8844.469331840086;7965.920340796591;8060.355171586259;8062;8089.635966381512;8368.874466882986;2267.648514480258;2299.3906614747107;2306.2735238399932;2308.2382813671447;2311.191083120911;2285.759995200505;2299.8160147188187;2308.503671710582;2310.4685922237895;2340.871252081135;2300.5053913408615;2312.1213938703268;2313.201945328859;2318.234982455794;2322.651602259666;2292.5300313435705;2298.5058212484228;2300.5973954557967;2301.367124040902;2303.5623231585946;1931.9227230910747;2242.248846636379;2283.417728479227;2286.0969916882736;2304.2396009316885;8720.912790872073;8797.164269394398;8801.427907186076;8803.515806630632;8806.735797926009;5032.471590482984;5211.661242019257;5212.218167274901;5219.295395121648;5221.817236396746;3404.778689385182;3500.03748969033;3547.5210846535647;3548.0952357148763;3553.9644603553893;1005.3214080495636;1050.112654806687;1063.643679367413;1068.5458680061022;1072.6835583502886;11548.307101573933;11548.826767598493;11550.94224528872;11567.652970410902;11569.595064172798;4516.774161291923;4571.405717256735;4722.386089808303;4797;4802.111609352281;9020.368574199874;9065.048169942062;9066.727998160066;9078.319126065571;9082.18260356558;5132.948670513321;5141.280220769096;5142.408623008402;5143.099957507421;5147.845564633067;4707.599854012379;4741.407324084489;4770.76146192689;4797.56821886032;4808.663393562487;3440.638732933056;3487.5640544931885;3488.70346020586;3534.7172226222356;3549.254656522108;1064.0689396777818;1067.8771941226703;1068.1454836131063;1077.0952399983894;1077.175960390302;875.7066382761719;905.6467977488785;906.3112034853559;949.2643201518878;963.080258353285;5152.896942061137;5575.386707462176;5689.601727879091;5897.970510147507;6129.478994285447;423.947006624172;436.23658597454454;441.20803158330233;443.40362212823703;445.8350410348127;2966.9554956675665;3809.209671454412;3918.5101862267215;4018.8392464301687;4050.9392359114636;10240.692779216635;10564.207684423698;10672.94663526693;10687.358758474516;10716.892831071746;10610.840837387444;10612.20408469368;10616.946915265375;10626.14990800734;10635.255532112833;7905.367570594339;7919.3268572170855;8005;8029.076656184497;8130.918690813134;5816.47651711348;5827.1841942127285;5833.241678581757;5882.411758824083;5917.283987643707;8805.867911981453;9604.807903842024;9793.412395256308;9859.605615775576;10028.348157369748;9830.655927042519;9952.10431061208;10059.849102263326;10097.798044039226;10197.490125493843;6368.904466432915;6387.648679322496;6600.504962127956;6614.603123812587;6673.232578253563;8144.5520496373265;8349.03986041613;8350.791230219293;8365.749027529184;8366.24703776663;7154.463415243774;7197.784066478014;7315.963420182865;7445.478816482794;7531.661075251736;7163.426925845815;7241;7348.3386495213545;7380.852382952418;7413.666385012795;6830.829229269308;6952.756653517103;6961.37347638715;6976.5465244758925;6989.161300643752;4850.296706977539;4882.584980276574;4907.2393778964315;5061.31672224245;5097.057044446789;4813.566778989908;4917.852464426073;4991.126552853164;5050.141475949024;5134.10153223177 06:01:18 INFO - PROCESS | 1660 | |4;prototype.html;287.227358405888;289.58300047930976;296.842673383107;302.4269010225624;303.2434076977939;4988.68252612013;5219.86950326242;5470.753816078276;5531.253280807085;5607.7476513556885;5209.984053109645;5217.2695822584865;5371.785128594861;5383.596230282735;5529.806456774014;3259.8044117353033;4080.2859499587603;4103.281925663012;4123.7938103094875;4133.379993001044;3753.7935413552245;4095.4471146395304;4159.168166366739;4159.667226621878;4311.288637374845;3794.2221844521946;4053.43251944728;4084.530279017921;4086.346184610463;4132.483439570054;4029;4040.313146765028;4063.7155399122075;4072.857449989251;4096.8975775605695;2905.5641653752105;3472.75690701651;3476.774009689362;3489.616142224353;3490.6212046241844;4985.027919555652;5347.946520534783;5392;5418.566514678816;5423.349198096214;3804.1630841214887;4606.355110284563;4668.906621867578;4676.415448068991;4716;5751.25233719618;5822.563307751935;5842.649441033552;5847.883042339172;5860.208871802295;3403.7787543809823;3731.9626803731885;3833.8658146965;3841.8847434577006;3865.43951127085;4957.380327459067;5412.350517937873;5798.275215598051;5998.670073145975;6073.665948372838;3085.9074227773203;3885.00854342155;3885.3977633466857;3913.202060526737;3924.547917270571;3331.68349006844;3967.6230758077936;3973.344398174269;3980.8805735827973;3991.960080399217;4184.782065505287;4603.549881787227;4644.907101858012;4649.465311489222;4687.367205427224;4801.567858892717;5643.802466913638;5748.166515855261;5776.740046697909;5789.218455508452;1261.2054405724334;1332.054241488554;1340.2092765268537;1347.8517363090052;1369.3020654388486;833.9791505212419;834.5827086456771;846.2679781988659;867.8915135608049;890.7327801659476;4488.4165058542185;5370.892582148335;5372.301600791872;5377.3816011159215;5397.082495975694;5149.665271757323;5911.261092363455;5937.376575459601;5954.404559544011;6066.090086487062;5074.340335756328;5295.576353891679;5376;5403.729813509309;5416.945830541723;2951.6605590356953;3077.092257783959;3106.2820032471586;3112.1057416602325;3120.3603261331828;5091.719955402488;5401.405845357008;5989;6142.201513803177;6205.47253483459;6081.209442772411;6120.449159575571;6177.289611694623;6191.349908259568;6228.688565571703;5474.073333999353;6184;6259.436650701458;6284.402981716729;6335.303116657256;5517.917231241454;5876.590597854859;5887.7056147191615;5933.228680271537;5954.315253745702;5422.620416570802;5843.415658434293;5876.354620706209;5879.706014699163;6008.699565021819;5875.004996602181;5931.733072011683;6217.96891015542;6260.090672344979;6302.621842689453;3214.2928555717704;3331.4170020245874;3371.983140084284;3866.304065268279;3885.7862817544174;6028.186194863637;6064.423879731418;6098.603590766586;6102.938970610237;6138.754449821957;4419.535948725466;5064.645474816874;5687.374388817144;5727.565784541636;5930.382466695399;5116.411612664442;5120.13115212952;5125.718085505184;5830.912536311874;5881.9705901470215;4390;4956.405231372259;5103.698556867975;5110.61670374716;5656.406077361818;5221.556167725786;5268.604854635841;5665.6317339374455;5697.230873832145;5710.942890571041;5261.605379596469;5609.579281553818;5629.634073785191;5630.60585758993;5703.20155178267 06:01:18 INFO - PROCESS | 1660 | |5;yui.html;609.3936533149517;739.8594267089253;772.0503780350169;819.8975128108987;837.99581002095;15451.84548154518;15723.13522756248;15760.054396736205;15802.60493487662;16075.356985720571;14223.146611203336;14278;14330;14333.924955628318;14348.139111653309;691.3570379547019;707.5966698981582;710.4777988178711;843.9071702112763;853.3940901959617;877.368294827723;882.4043770454917;892.384254864145;894.6108442827358;900.7432881628737;952.3857112162651;954.551360860398;954.8376775948105;955.2549011770795;956.4500412262942;947.313197931501;949.2358651285713;950.1401231885155;950.7765675066354;950.8954015058338;537.301508039551;553.5626854784715;558.6731761919282;687.2165731066588;689.1316940654812;15052.172130532816;15071.321790519452;15071.47249846261;15082.472113475975;15102.924485377613;13506.459741610324;13786.310684465736;13884.930575347058;13940.093893896865;14211.360488777926;11045.447727613588;12093.274403535816;12586.81119783204;12723.23660580359;13145.21128732279;3891.571927088018;4472.753998530079;4474.6420286377015;4496;4538.092381523708;112288;112793;113238.43380783126;113355;114210;10573.471326433648;10654.041136297616;10911.83632245517;10918.50866711;11446;20804.791952080588;20919.849408282385;21135;21218.575628487342;21249.893750531148;7594.088709354913;7695.576743279174;7714.151443341228;7794.064712234568;7836.960815195887;3521.9119522011642;4095.344744840811;4141.668666506672;4272.124214536013;4315.568443155722;2796.902108426236;3508.5438892943753;3515.402381595135;3515.54297941266;3517.3141237458963;580.7154494297848;615.5691016288616;636.3477435628517;636.4558302651259;657.746767494518;557.5678848892142;610.1732152932801;624.7625902157242;627.1940556385023;636.9808905732835;8667.219950204386;8748.825023499494;9034.32242581809;9054.411463254999;9108.49903255314;517.583345406951;592.1768741449389;606.4360145065132;622.99386490817;644.5101722690789;4159.875203743893;4308.569143085666;4322.0491491871735;4377.606015458624;4427.313766366218;129760.35119824529;140050.2997485006;148869;156696;168998;125970.37014814868;138467;142767.28616356853;143157;145859;117536;118945;119548;120579;120694.18958715626;8383.203595658402;8408.201220884006;8432.831343372976;8462.449940753831;8646.697365592174;48972;59406.70296648489;63381;64175.037374440355;67630;61208.77582448237;67319;72664;94798;99284;10177.440240786827;10675.359478431319;10705.250632455653;10786.676399708022;10847.566097356017;11976.46105925218;12013.099017573542;12022.27866328023;12551.686207844878;12635;11335.716607084889;11351;11451.942740286246;11477.512228098725;11690.415479226174;13155;13256.270905100311;13711;13903.721925561635;14174.32747721695;12913.031522635652;13102.934485327512;13480.662983425493;13696.65758356049;13867.076221853722;11105.611303604335;11327.830082548604;11582.36297003673;11594.594189203337;11643.359615220905;9869;10300.484975751333;11049.0366294717;11507.367094809531;11572.18994670365 06:01:18 INFO - PROCESS | 1660 | __end_tp_report 06:01:18 INFO - PROCESS | 1660 | __start_cc_report 06:01:18 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,2965 06:01:18 INFO - PROCESS | 1660 | __end_cc_report 06:01:18 INFO - PROCESS | 1660 | __startTimestamp1477314078759__endTimestamp 06:01:18 INFO - PROCESS | 1660 | 06:01:18 INFO - PROCESS | 1660 | ------- Summary: start ------- 06:01:18 INFO - PROCESS | 1660 | Number of tests: 6 06:01:18 INFO - PROCESS | 1660 | 06:01:18 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5644.22 Median:5772.13 stddev:667.73 (11.6%) stddev-sans-first:631.55 06:01:18 INFO - PROCESS | 1660 | Values: 2805.2 3301.1 3301.7 3344.4 3368.8 4658.2 5520.5 5596.9 5601.9 5668.4 5581.8 5594.3 5600.7 5611.3 5613.4 5099.0 5143.0 5143.5 5176.9 5222.8 5166.1 5180.8 5201.2 5238.5 5263.8 5235.1 5243.8 5269.0 5300.1 5309.8 5180.6 5218.1 5220.2 5261.8 5264.8 4930.2 4973.4 5158.4 5164.0 5172.6 5608.4 5611.9 5627.6 5734.0 5735.2 6166.3 6211.8 6216.0 6223.1 6237.3 6199.4 6247.2 6261.7 6277.0 6306.0 5549.5 5614.3 5628.0 5630.7 5631.1 5253.7 6235.6 6275.7 6296.4 6342.1 6003.4 6036.0 6045.1 6050.8 6053.1 6057.5 6101.7 6104.5 6134.7 6177.9 6086.1 6124.6 6126.3 6131.4 6138.2 5033.9 6143.1 6152.9 6162.4 6172.5 4773.4 4857.2 4863.2 4868.2 4876.5 4400.9 4427.4 4452.1 4458.8 4460.4 5651.5 5673.4 5715.4 5732.3 5749.3 6186.1 6219.7 6254.6 6259.3 6270.4 4654.8 5676.4 5681.3 5681.4 5723.4 4025.8 5277.2 5299.5 5334.4 5360.8 6344.5 6357.6 6369.5 6379.5 6389.1 6170.8 6174.5 6207.4 6235.7 6245.1 6235.4 6276.4 6278.7 6321.9 6324.5 6133.1 6134.7 6136.9 6143.5 6152.4 6220.6 6229.0 6237.2 6250.4 6266.7 5668.9 5805.5 5870.2 5989.7 6035.0 5868.5 5908.4 5920.3 5923.8 5927.3 4794.9 5756.2 5766.7 5773.4 5786.2 5841.4 5893.7 5908.1 5915.9 5919.9 5757.5 5772.1 5779.6 5781.3 5788.7 06:01:18 INFO - PROCESS | 1660 | 06:01:18 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:63103.41 Median:37790.72 stddev:131573.51 (348.2%) stddev-sans-first:131858.68 06:01:18 INFO - PROCESS | 1660 | Values: 512.4 524.5 548.4 553.3 563.6 30248.5 31613.0 31617.4 31647.0 31682.5 41913.8 42848.6 42959.1 45045.0 45106.0 9453.6 9631.4 9635.0 9648.6 9654.7 8581.4 9524.0 9635.5 9636.0 9637.2 8596.5 11381.3 11699.8 11807.0 12169.0 11577.8 11659.5 11672.2 11674.3 11679.4 8460.2 8690.3 11454.5 11518.3 11518.4 39331.0 39998.0 40126.0 42037.4 42063.7 3390.5 3639.0 3684.4 4010.4 4084.4 29269.9 30601.4 30813.8 30892.7 31435.5 3159.4 3291.5 3301.9 3336.4 3349.8 454273.0 459701.0 461001.0 463249.0 464237.0 59731.2 59934.7 60136.7 60233.0 60325.4 64398.0 64510.0 64535.0 64539.0 64634.7 15971.4 16215.6 16241.8 16248.5 16318.8 12460.9 12513.3 12515.2 12520.0 12543.2 15239.2 15558.6 15583.4 15873.5 17344.5 7187.4 7364.8 7402.5 7407.0 7432.6 845.6 862.3 876.3 896.0 929.0 29628.0 29810.3 30046.0 30455.7 30496.2 844.4 995.6 1041.8 1085.6 1137.9 15514.6 15853.5 15857.3 15896.2 16094.4 587916.0 590911.0 592658.0 592819.0 592976.0 49837.0 50748.0 50894.0 57602.7 57628.0 1353.3 1369.6 1411.1 1414.5 1419.8 29872.2 30470.4 30556.2 30622.8 31316.7 49899.0 50565.0 50620.2 50639.0 50644.7 388780.3 392055.0 398247.0 440191.0 441779.0 24832.5 25016.6 25061.2 25324.4 25368.7 44873.8 45365.0 45544.3 45631.0 45880.8 37522.4 37703.7 37986.2 38641.2 38736.0 36927.8 37277.0 37615.0 38300.0 38767.4 37035.0 37597.6 37782.0 37799.4 37919.4 31748.9 33104.0 34016.3 34131.8 34205.5 22165.8 22666.3 24468.9 24662.1 25375.2 06:01:18 INFO - PROCESS | 1660 | 06:01:18 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:32554.06 Median:2788.26 stddev:90229.63 (3236.1%) stddev-sans-first:90450.34 06:01:18 INFO - PROCESS | 1660 | Values: 344.5 367.9 369.1 375.5 395.6 14883.9 15013.0 16059.4 20460.0 20600.5 19104.6 19257.9 19844.0 19928.4 20123.3 4974.3 5514.6 5716.2 5804.8 5809.3 4382.9 5710.9 5752.6 5755.1 5776.4 5438.3 5717.9 5719.0 5723.2 5730.0 5595.6 5692.3 5698.9 5700.7 5704.2 4716.5 4880.2 4943.0 4951.4 4968.3 20733.5 21513.9 24657.0 24683.9 25076.4 2053.9 2496.7 2650.9 2785.8 2790.7 14680.2 14818.9 14862.6 15245.4 15403.2 1541.3 1584.5 1785.3 1801.1 1832.4 106262.0 109301.0 110528.9 111325.8 117059.4 11085.7 11234.0 11374.8 11440.3 11535.9 14420.3 14447.5 14450.8 14453.2 14463.2 8159.4 8331.5 8370.3 8389.5 8467.1 8163.6 8248.3 8302.8 8374.4 8385.2 3559.8 4486.7 4501.5 4539.2 4599.9 1698.8 1841.6 1845.8 1899.1 1905.5 875.8 942.2 942.7 964.7 1060.7 19186.6 20386.6 20568.4 20667.4 20682.3 761.8 913.3 959.6 969.3 1012.4 10079.7 10091.6 10311.7 10727.4 10809.9 490082.0 490253.0 559866.4 567226.3 583509.0 83792.7 107975.4 119963.0 122488.8 137307.0 937.8 956.6 973.9 974.6 975.7 14976.7 18162.3 18262.5 18629.1 18871.4 53239.7 53416.3 53551.0 54799.7 54872.7 73308.6 77815.6 78724.2 79207.0 80878.6 6568.4 7843.9 7945.7 7946.7 8226.5 11221.8 11405.5 11545.9 12321.2 12330.2 7817.0 8947.2 10421.3 10901.0 11014.4 10433.6 10458.2 11151.8 11220.3 11574.0 10361.8 10396.7 10614.9 11065.9 11813.0 6507.0 8141.0 8181.6 8275.0 8339.4 9368.6 9410.0 10348.2 11295.2 11451.0 06:01:18 INFO - PROCESS | 1660 | 06:01:18 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5549.70 Median:4866.44 stddev:3147.53 (64.7%) stddev-sans-first:3141.80 06:01:18 INFO - PROCESS | 1660 | Values: 1520.8 1556.6 1652.0 1793.6 1982.2 7800.1 8111.8 8300.0 8839.2 8844.5 7965.9 8060.4 8062.0 8089.6 8368.9 2267.6 2299.4 2306.3 2308.2 2311.2 2285.8 2299.8 2308.5 2310.5 2340.9 2300.5 2312.1 2313.2 2318.2 2322.7 2292.5 2298.5 2300.6 2301.4 2303.6 1931.9 2242.2 2283.4 2286.1 2304.2 8720.9 8797.2 8801.4 8803.5 8806.7 5032.5 5211.7 5212.2 5219.3 5221.8 3404.8 3500.0 3547.5 3548.1 3554.0 1005.3 1050.1 1063.6 1068.5 1072.7 11548.3 11548.8 11550.9 11567.7 11569.6 4516.8 4571.4 4722.4 4797.0 4802.1 9020.4 9065.0 9066.7 9078.3 9082.2 5132.9 5141.3 5142.4 5143.1 5147.8 4707.6 4741.4 4770.8 4797.6 4808.7 3440.6 3487.6 3488.7 3534.7 3549.3 1064.1 1067.9 1068.1 1077.1 1077.2 875.7 905.6 906.3 949.3 963.1 5152.9 5575.4 5689.6 5898.0 6129.5 423.9 436.2 441.2 443.4 445.8 2967.0 3809.2 3918.5 4018.8 4050.9 10240.7 10564.2 10672.9 10687.4 10716.9 10610.8 10612.2 10616.9 10626.1 10635.3 7905.4 7919.3 8005.0 8029.1 8130.9 5816.5 5827.2 5833.2 5882.4 5917.3 8805.9 9604.8 9793.4 9859.6 10028.3 9830.7 9952.1 10059.8 10097.8 10197.5 6368.9 6387.6 6600.5 6614.6 6673.2 8144.6 8349.0 8350.8 8365.7 8366.2 7154.5 7197.8 7316.0 7445.5 7531.7 7163.4 7241.0 7348.3 7380.9 7413.7 6830.8 6952.8 6961.4 6976.5 6989.2 4850.3 4882.6 4907.2 5061.3 5097.1 4813.6 4917.9 4991.1 5050.1 5134.1 06:01:18 INFO - PROCESS | 1660 | 06:01:18 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4641.60 Median:5241.58 stddev:1477.76 (28.2%) stddev-sans-first:1445.32 06:01:18 INFO - PROCESS | 1660 | Values: 287.2 289.6 296.8 302.4 303.2 4988.7 5219.9 5470.8 5531.3 5607.7 5210.0 5217.3 5371.8 5383.6 5529.8 3259.8 4080.3 4103.3 4123.8 4133.4 3753.8 4095.4 4159.2 4159.7 4311.3 3794.2 4053.4 4084.5 4086.3 4132.5 4029.0 4040.3 4063.7 4072.9 4096.9 2905.6 3472.8 3476.8 3489.6 3490.6 4985.0 5347.9 5392.0 5418.6 5423.3 3804.2 4606.4 4668.9 4676.4 4716.0 5751.3 5822.6 5842.6 5847.9 5860.2 3403.8 3732.0 3833.9 3841.9 3865.4 4957.4 5412.4 5798.3 5998.7 6073.7 3085.9 3885.0 3885.4 3913.2 3924.5 3331.7 3967.6 3973.3 3980.9 3992.0 4184.8 4603.5 4644.9 4649.5 4687.4 4801.6 5643.8 5748.2 5776.7 5789.2 1261.2 1332.1 1340.2 1347.9 1369.3 834.0 834.6 846.3 867.9 890.7 4488.4 5370.9 5372.3 5377.4 5397.1 5149.7 5911.3 5937.4 5954.4 6066.1 5074.3 5295.6 5376.0 5403.7 5416.9 2951.7 3077.1 3106.3 3112.1 3120.4 5091.7 5401.4 5989.0 6142.2 6205.5 6081.2 6120.4 6177.3 6191.3 6228.7 5474.1 6184.0 6259.4 6284.4 6335.3 5517.9 5876.6 5887.7 5933.2 5954.3 5422.6 5843.4 5876.4 5879.7 6008.7 5875.0 5931.7 6218.0 6260.1 6302.6 3214.3 3331.4 3372.0 3866.3 3885.8 6028.2 6064.4 6098.6 6102.9 6138.8 4419.5 5064.6 5687.4 5727.6 5930.4 5116.4 5120.1 5125.7 5830.9 5882.0 4390.0 4956.4 5103.7 5110.6 5656.4 5221.6 5268.6 5665.6 5697.2 5710.9 5261.6 5609.6 5629.6 5630.6 5703.2 06:01:18 INFO - PROCESS | 1660 | 06:01:18 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:24875.50 Median:3511.97 stddev:40828.45 (1162.6%) stddev-sans-first:40902.33 06:01:18 INFO - PROCESS | 1660 | Values: 609.4 739.9 772.1 819.9 838.0 15451.8 15723.1 15760.1 15802.6 16075.4 14223.1 14278.0 14330.0 14333.9 14348.1 691.4 707.6 710.5 843.9 853.4 877.4 882.4 892.4 894.6 900.7 952.4 954.6 954.8 955.3 956.5 947.3 949.2 950.1 950.8 950.9 537.3 553.6 558.7 687.2 689.1 15052.2 15071.3 15071.5 15082.5 15102.9 13506.5 13786.3 13884.9 13940.1 14211.4 11045.4 12093.3 12586.8 12723.2 13145.2 3891.6 4472.8 4474.6 4496.0 4538.1 112288.0 112793.0 113238.4 113355.0 114210.0 10573.5 10654.0 10911.8 10918.5 11446.0 20804.8 20919.8 21135.0 21218.6 21249.9 7594.1 7695.6 7714.2 7794.1 7837.0 3521.9 4095.3 4141.7 4272.1 4315.6 2796.9 3508.5 3515.4 3515.5 3517.3 580.7 615.6 636.3 636.5 657.7 557.6 610.2 624.8 627.2 637.0 8667.2 8748.8 9034.3 9054.4 9108.5 517.6 592.2 606.4 623.0 644.5 4159.9 4308.6 4322.0 4377.6 4427.3 129760.4 140050.3 148869.0 156696.0 168998.0 125970.4 138467.0 142767.3 143157.0 145859.0 117536.0 118945.0 119548.0 120579.0 120694.2 8383.2 8408.2 8432.8 8462.4 8646.7 48972.0 59406.7 63381.0 64175.0 67630.0 61208.8 67319.0 72664.0 94798.0 99284.0 10177.4 10675.4 10705.3 10786.7 10847.6 11976.5 12013.1 12022.3 12551.7 12635.0 11335.7 11351.0 11451.9 11477.5 11690.4 13155.0 13256.3 13711.0 13903.7 14174.3 12913.0 13102.9 13480.7 13696.7 13867.1 11105.6 11327.8 11582.4 11594.6 11643.4 9869.0 10300.5 11049.0 11507.4 11572.2 06:01:18 INFO - PROCESS | 1660 | -------- Summary: end -------- 06:01:18 INFO - PROCESS | 1660 | 06:01:19 INFO - TEST-INFO | 1660: exit 0 06:01:19 INFO - TEST-OK | dromaeo_css | took 1119790ms 06:01:19 INFO - TEST-START | kraken 06:01:19 INFO - operating with platform_type : mac_ 06:01:19 INFO - Initialising browser for kraken test... 06:01:19 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmp0H2Mge/profile http://localhost:49272/getInfo.html) 06:01:21 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 06:01:21 INFO - PROCESS | 1667 | colorDepth:24 06:01:21 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 06:01:21 INFO - PROCESS | 1667 | __metrics 06:01:21 INFO - PROCESS | 1667 | 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" 06:01:21 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:01:22 INFO - TEST-INFO | 1667: exit 0 06:01:22 INFO - Browser initialized. 06:01:22 INFO - Running cycle 1/1 for kraken test... 06:01:22 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmp0H2Mge/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:34 INFO - PROCESS | 1669 | RSS: Main: 230850560 06:01:34 INFO - PROCESS | 1669 | 06:01:37 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 06:01:38 INFO - PROCESS | 1669 | RSS: Main: 290275328 06:01:38 INFO - PROCESS | 1669 | 06:01:41 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 06:01:41 INFO - PROCESS | 1669 | RSS: Main: 291725312 06:01:41 INFO - PROCESS | 1669 | 06:01:45 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 06:01:45 INFO - PROCESS | 1669 | RSS: Main: 386269184 06:01:45 INFO - PROCESS | 1669 | 06:01:48 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 06:01:48 INFO - PROCESS | 1669 | RSS: Main: 290189312 06:01:48 INFO - PROCESS | 1669 | 06:01:50 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:01:51 INFO - PROCESS | 1669 | RSS: Main: 291893248 06:01:51 INFO - PROCESS | 1669 | 06:01:54 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 06:01:54 INFO - PROCESS | 1669 | RSS: Main: 329781248 06:01:54 INFO - PROCESS | 1669 | 06:01:57 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 06:01:58 INFO - PROCESS | 1669 | RSS: Main: 330637312 06:01:58 INFO - PROCESS | 1669 | 06:02:01 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 06:02:01 INFO - PROCESS | 1669 | RSS: Main: 332263424 06:02:01 INFO - PROCESS | 1669 | 06:02:03 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:02:03 INFO - PROCESS | 1669 | RSS: Main: 302891008 06:02:03 INFO - PROCESS | 1669 | 06:02:05 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:02:06 INFO - PROCESS | 1669 | RSS: Main: 307060736 06:02:06 INFO - PROCESS | 1669 | 06:02:08 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:02:09 INFO - PROCESS | 1669 | RSS: Main: 308858880 06:02:09 INFO - PROCESS | 1669 | 06:02:12 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:02:13 INFO - PROCESS | 1669 | RSS: Main: 316952576 06:02:13 INFO - PROCESS | 1669 | 06:02:15 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:02:16 INFO - PROCESS | 1669 | RSS: Main: 317091840 06:02:16 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 06:02:18 INFO - PROCESS | 1669 | RSS: Main: 361578496 06:02:18 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | __start_tp_report 06:02:18 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 06:02:18 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 06:02:18 INFO - PROCESS | 1669 | |i|pagename|runs| 06:02:18 INFO - PROCESS | 1669 | |0;ai-astar;112;114;113;120;165;155;114;114;113;114 06:02:18 INFO - PROCESS | 1669 | |1;audio-beat-detection;149;109;110;149;112;112;112;114;145;130 06:02:18 INFO - PROCESS | 1669 | |2;audio-dft;185;184;185;182;184;184;183;186;253;221 06:02:18 INFO - PROCESS | 1669 | |3;audio-fft;78;58;58;91;80;83;82;82;83;59 06:02:18 INFO - PROCESS | 1669 | |4;audio-oscillator;84;71;118;100;98;69;91;65;67;88 06:02:18 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;95;88;90;86;91;87;91;89;90;87 06:02:18 INFO - PROCESS | 1669 | |6;imaging-darkroom;95;95;106;151;113;95;95;95;95;95 06:02:18 INFO - PROCESS | 1669 | |7;imaging-desaturate;90;83;79;82;86;83;83;85;81;82 06:02:18 INFO - PROCESS | 1669 | |8;json-parse-financial;57;53;53;53;54;54;54;56;55;54 06:02:18 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;64;69;79;75;72;69;70;71;70;70 06:02:18 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;90;87;84;86;86;84;86;86;85;89 06:02:18 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;147;166;155;154;156;145;163;139;217;156 06:02:18 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;172;172;176;171;172;174;171;172;173;173 06:02:18 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;69;70;69;68;70;68;68;69;68;68 06:02:18 INFO - PROCESS | 1669 | __end_tp_report 06:02:18 INFO - PROCESS | 1669 | __start_cc_report 06:02:18 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1975 06:02:18 INFO - PROCESS | 1669 | __end_cc_report 06:02:18 INFO - PROCESS | 1669 | __startTimestamp1477314138475__endTimestamp 06:02:18 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | ------- Summary: start ------- 06:02:18 INFO - PROCESS | 1669 | Number of tests: 14 06:02:18 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:123.40 Median:114.00 stddev:19.55 (17.2%) stddev-sans-first:20.30 06:02:18 INFO - PROCESS | 1669 | Values: 112.0 114.0 113.0 120.0 165.0 155.0 114.0 114.0 113.0 114.0 06:02:18 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:124.20 Median:122.00 stddev:17.25 (14.1%) stddev-sans-first:15.80 06:02:18 INFO - PROCESS | 1669 | Values: 149.0 109.0 110.0 149.0 112.0 112.0 112.0 114.0 145.0 130.0 06:02:18 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:194.70 Median:185.00 stddev:23.56 (12.7%) stddev-sans-first:24.73 06:02:18 INFO - PROCESS | 1669 | Values: 185.0 184.0 185.0 182.0 184.0 184.0 183.0 186.0 253.0 221.0 06:02:18 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:75.40 Median:82.00 stddev:12.24 (14.9%) stddev-sans-first:12.95 06:02:18 INFO - PROCESS | 1669 | Values: 78.0 58.0 58.0 91.0 80.0 83.0 82.0 82.0 83.0 59.0 06:02:18 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:85.10 Median:77.50 stddev:17.34 (22.4%) stddev-sans-first:18.38 06:02:18 INFO - PROCESS | 1669 | Values: 84.0 71.0 118.0 100.0 98.0 69.0 91.0 65.0 67.0 88.0 06:02:18 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:90.00 stddev:2.63 (2.9%) stddev-sans-first:1.86 06:02:18 INFO - PROCESS | 1669 | Values: 95.0 88.0 90.0 86.0 91.0 87.0 91.0 89.0 90.0 87.0 06:02:18 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:103.50 Median:95.00 stddev:17.82 (18.8%) stddev-sans-first:18.64 06:02:18 INFO - PROCESS | 1669 | Values: 95.0 95.0 106.0 151.0 113.0 95.0 95.0 95.0 95.0 95.0 06:02:18 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:83.40 Median:83.00 stddev:3.03 (3.6%) stddev-sans-first:2.06 06:02:18 INFO - PROCESS | 1669 | Values: 90.0 83.0 79.0 82.0 86.0 83.0 83.0 85.0 81.0 82.0 06:02:18 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:1.34 (2.5%) stddev-sans-first:1.00 06:02:18 INFO - PROCESS | 1669 | Values: 57.0 53.0 53.0 53.0 54.0 54.0 54.0 56.0 55.0 54.0 06:02:18 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:70.50 stddev:3.96 (5.6%) stddev-sans-first:3.32 06:02:18 INFO - PROCESS | 1669 | Values: 64.0 69.0 79.0 75.0 72.0 69.0 70.0 71.0 70.0 70.0 06:02:18 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.00 stddev:1.95 (2.3%) stddev-sans-first:1.54 06:02:18 INFO - PROCESS | 1669 | Values: 90.0 87.0 84.0 86.0 86.0 84.0 86.0 86.0 85.0 89.0 06:02:18 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:159.80 Median:156.00 stddev:21.66 (13.9%) stddev-sans-first:22.47 06:02:18 INFO - PROCESS | 1669 | Values: 147.0 166.0 155.0 154.0 156.0 145.0 163.0 139.0 217.0 156.0 06:02:18 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:172.50 stddev:1.51 (0.9%) stddev-sans-first:1.58 06:02:18 INFO - PROCESS | 1669 | Values: 172.0 172.0 176.0 171.0 172.0 174.0 171.0 172.0 173.0 173.0 06:02:18 INFO - PROCESS | 1669 | 06:02:18 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 06:02:18 INFO - PROCESS | 1669 | Values: 69.0 70.0 69.0 68.0 70.0 68.0 68.0 69.0 68.0 68.0 06:02:18 INFO - PROCESS | 1669 | -------- Summary: end -------- 06:02:18 INFO - PROCESS | 1669 | 06:02:19 INFO - TEST-INFO | 1669: exit 0 06:02:19 INFO - TEST-OK | kraken | took 59931ms 06:02:19 INFO - SUITE-END | took 1179s 06:02:19 INFO - Completed test suite (00:19:39) 06:02:19 INFO - javascript benchmark 06:02:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2805.22856214541, 3301.0591981285324, 3301.669833016698, 3344.4314466540686, 3368.7810292330996, 4658.161530924433, 5520.475554822286, 5596.860078498034, 5601.887962240753, 5668.376478587352, 5581.804636837712, 5594.328680558328, 5600.747966341514, 5611.3266408031095, 5613.382527921935, 5099.031184075023, 5142.974285128569, 5143.485651434864, 5176.922346164792, 5222.843314700565, 5166.121759300909, 5180.844574662748, 5201.167813149897, 5238.52853243208, 5263.815766448175, 5235.11003129467, 5243.79024839006, 5269.0, 5300.09898317287, 5309.840704778863, 5180.6373553851245, 5218.13900706383, 5220.190870415092, 5261.763220655042, 5264.815731449419, 4930.211166213425, 4973.378327709036, 5158.432572417031, 5163.993021360836, 5172.586193104543, 5608.383077861432, 5611.859703507404, 5627.577931655102, 5734.025215713339, 5735.1970724098655, 6166.321704612489, 6211.751529938842, 6215.968920155416, 6223.1287619733275, 6237.34507876671, 6199.411055949678, 6247.187865577446, 6261.655608941552, 6276.968615156895, 6306.0225665022, 5549.472800084026, 5614.2701448811395, 5628.0, 5630.746616402272, 5631.070873305941, 5253.737313134405, 6235.563510554309, 6275.748970041239, 6296.433321001132, 6342.080398342307, 6003.3996600339615, 6035.969820150871, 6045.093236014633, 6050.757969681252, 6053.061775424816, 6057.515398768088, 6101.731934812992, 6104.480726615073, 6134.6625935573975, 6177.938220617736, 6086.056661217518, 6124.601900876429, 6126.295476020226, 6131.448169664663, 6138.202033735586, 5033.924491132636, 6143.078538219303, 6152.938470615237, 6162.352952939967, 6172.475339596095, 4773.427188737373, 4857.247126695368, 4863.221884498464, 4868.2210846264425, 4876.463589005207, 4400.933985990213, 4427.446569178853, 4452.0873220989615, 4458.77706114693, 4460.420145381145, 5651.463111004448, 5673.375928647845, 5715.371309155989, 5732.283464566929, 5749.338826034976, 6186.133941248228, 6219.720112594944, 6254.562180647311, 6259.342769009279, 6270.372962703693, 4654.790534425959, 5676.4323567642905, 5681.318241811009, 5681.403452637496, 5723.399043100498, 4025.75845449274, 5277.234800953917, 5299.523042926078, 5334.359876814729, 5360.812371566976, 6344.460720838688, 6357.586756860789, 6369.45859601939, 6379.52153588492, 6389.073584330153, 6170.784022559189, 6174.536909731878, 6207.441330280297, 6235.657038862906, 6245.0632405139595, 6235.407636274546, 6276.435120839146, 6278.6546739929745, 6321.936780632135, 6324.525660575383, 6133.120447061136, 6134.7121296814075, 6136.94800169746, 6143.54258296667, 6152.415520525543, 6220.626762394271, 6228.968855155877, 6237.1891654084675, 6250.4374606285655, 6266.717997690206, 5668.858278542904, 5805.535557155333, 5870.207521984477, 5989.700514974321, 6034.969825150846, 5868.530517558671, 5908.438698323653, 5920.319163296103, 5923.822285331447, 5927.288725352985, 4794.856154315376, 5756.194132821324, 5766.711664416846, 5773.422657734193, 5786.247787787561, 5841.357450680337, 5893.734781934738, 5908.084246941731, 5915.911261330997, 5919.85200369977, 5757.453041961007, 5772.134179873053, 5779.624324418899, 5781.277340332458, 5788.7395067222915], "value": 5601.217526629694, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [512.4132867866293, 524.5069634543529, 548.4186762032244, 553.3304701311413, 563.5942121672399, 30248.546271805913, 31613.0, 31617.36765264696, 31647.0, 31682.524762128527, 41913.79043104788, 42848.57151428485, 42959.14081718372, 45045.0, 45106.0, 9453.57458914347, 9631.373960692532, 9634.9518252409, 9648.614055437774, 9654.71035868925, 8581.442206256574, 9524.0, 9635.518224088803, 9635.951820240889, 9637.18083962864, 8596.527191004492, 11381.317120972768, 11699.824502632468, 11807.0, 12168.965637920788, 11577.768444631103, 11659.533618655243, 11672.1829471937, 11674.29954202742, 11679.357635330054, 8460.238578527962, 8690.348223883235, 11454.484548195267, 11518.308901465854, 11518.424078796026, 39331.0, 39998.0, 40126.0, 42037.36943945843, 42063.73808785741, 3390.4914262860766, 3638.963610363889, 3684.3552378333684, 4010.418489319062, 4084.36692312692, 29269.85365073161, 30601.38797224043, 30813.845930770425, 30892.691073089205, 31435.52846707301, 3159.3681263747344, 3291.4569096099117, 3301.9174520637175, 3336.4494858348585, 3349.765516413852, 454273.0, 459701.0, 461001.0, 463249.0, 464237.0, 59731.22150227971, 59934.70032649896, 60136.69931650401, 60233.0, 60325.39674603286, 64398.0, 64510.0, 64535.0, 64539.03191452132, 64634.67682661556, 15971.361145554049, 16215.594610134842, 16241.756373654405, 16248.512544623443, 16318.75521867173, 12460.87539124597, 12513.311767852674, 12515.186512876633, 12520.0, 12543.24740515572, 15239.238038098272, 15558.611034724223, 15583.376664933503, 15873.539601361806, 17344.47966561005, 7187.353138217481, 7364.815879602946, 7402.518836275733, 7407.000219881312, 7432.591207483641, 845.6279237135641, 862.3230763850473, 876.2551830943775, 895.9776005599782, 928.972130836076, 29627.963021294152, 29810.25474363115, 30046.0, 30455.69544304573, 30496.237594059883, 844.3709436469869, 995.5868314649484, 1041.7916416716535, 1085.6091806949491, 1137.9431028448544, 15514.612134696723, 15853.52439426819, 15857.286422111032, 15896.218161821635, 16094.436694715629, 587916.0, 590911.0, 592658.0, 592819.0, 592976.0, 49837.0, 50748.0, 50894.0, 57602.7119864398, 57628.0, 1353.289523000413, 1369.5685858954596, 1411.1251024364753, 1414.476643641859, 1419.7515434798868, 29872.19418956414, 30470.390592188476, 30556.236094097825, 30622.84688576543, 31316.686833132288, 49899.0, 50565.0, 50620.24069638885, 50639.0, 50644.746776265885, 388780.2804929899, 392055.0, 398247.0, 440191.0, 441779.0, 24832.50334993326, 25016.62475062839, 25061.24816255515, 25324.36689082714, 25368.746312536638, 44873.775631121636, 45365.0, 45544.31683524816, 45631.0, 45880.77059614681, 37522.437163443115, 37703.70518485929, 37986.24027519379, 38641.22717545577, 38736.0, 36927.81536092302, 37277.0, 37615.0, 38300.0, 38767.41848872213, 37035.0, 37597.62402375941, 37782.0, 37799.43300850435, 37919.43120853134, 31748.888788892276, 33104.0, 34016.319673605896, 34131.82934085314, 34205.48691769576, 22165.77834221637, 22666.320010399715, 24468.877655611606, 24662.136825211033, 25375.238742837744], "value": 19624.721901861114, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.4798354484727, 367.9264147170565, 369.1270146104463, 375.47996025504676, 395.59253968412526, 14883.925580372097, 15013.0, 16059.437919672828, 20460.0, 20600.484987875312, 19104.617907641874, 19257.903710481463, 19844.0, 19928.402147935583, 20123.29568465104, 4974.278729584208, 5514.641548299358, 5716.1711551824965, 5804.767809287623, 5809.2738407699035, 4382.890427739316, 5710.885782284352, 5752.626079304852, 5755.107958266475, 5776.364599894029, 5438.3473983121885, 5717.914231286534, 5718.971405142989, 5723.170140329649, 5730.0, 5595.63628364155, 5692.31692196939, 5698.857528561798, 5700.743466543995, 5704.201411802351, 4716.481187069419, 4880.243562247857, 4942.950570494285, 4951.3810773653295, 4968.254761785725, 20733.548651594396, 21513.892430537748, 24657.0, 24683.876580616983, 25076.373090672696, 2053.9486512837298, 2496.6754321938033, 2650.893964241428, 2785.8049936504453, 2790.7209279072135, 14680.192589407578, 14818.851811481854, 14862.628434289121, 15245.39018439261, 15403.15041717286, 1541.2524925411167, 1584.4612831637298, 1785.3483478530243, 1801.1084513166068, 1832.3861506395374, 106262.0, 109301.0, 110528.89471105266, 111325.77348452985, 117059.41470292679, 11085.667429977113, 11233.966828956136, 11374.772504549863, 11440.256383335056, 11535.942320288344, 14420.278986050866, 14447.49433769813, 14450.783238251435, 14453.205073720836, 14463.204523751085, 8159.428839981144, 8331.458455200393, 8370.288525475282, 8389.53857537829, 8467.110953349933, 8163.591820408956, 8248.340132789363, 8302.83394332122, 8374.371922105867, 8385.245327920395, 3559.8220088995445, 4486.68593198473, 4501.527339629291, 4539.205639013159, 4599.862004139881, 1698.8193205722152, 1841.5580260737327, 1845.796962334142, 1899.1074195128267, 1905.5236190952262, 875.7564258752586, 942.1850099663742, 942.7131964868042, 964.7009427077628, 1060.6977011551826, 19186.61626767457, 20386.59226815485, 20568.382948511568, 20667.379978600668, 20682.276120336017, 761.7981234972737, 913.3241401363076, 959.6113574002541, 969.3069455339466, 1012.4128005756644, 10079.69760907174, 10091.646792362231, 10311.690649280534, 10727.409992450333, 10809.945950270356, 490082.0, 490253.0, 559866.4074572538, 567226.3277367256, 583509.0, 83792.74310885342, 107975.37449216183, 119963.0, 122488.77511224773, 137307.0, 937.8499440089689, 956.6173530587821, 973.9415635061919, 974.5760594141572, 975.658519518163, 14976.700465990401, 18162.273509060018, 18262.452126436227, 18629.068546572347, 18871.433856984313, 53239.733801332295, 53416.322959630044, 53551.0, 54799.72600136974, 54872.68964069183, 73308.63345683238, 77815.61092194729, 78724.21275787169, 79207.0, 80878.59560702159, 6568.408843203943, 7843.941067955753, 7945.682172713026, 7946.721864734706, 8226.547539885363, 11221.831672524755, 11405.543778248777, 11545.88454115448, 12321.199122057038, 12330.19853709506, 7816.960915195387, 8947.19475247231, 10421.322614030063, 10901.0, 11014.39420831862, 10433.582656693647, 10458.215633827342, 11151.776964460503, 11220.326780393203, 11574.0, 10361.84457233127, 10396.688099357032, 10614.938506149323, 11065.889341106486, 11813.0, 6506.967465162644, 8141.0, 8181.550014749246, 8275.0, 8339.374546908884, 9368.625254989724, 9410.0, 10348.223883208639, 11295.209335346446, 11450.969412752893], "value": 9277.618817861683, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1520.7946927164833, 1556.5641620346303, 1651.975220371694, 1793.5964408008192, 1982.236838817055, 7800.141984381714, 8111.837763244746, 8299.958500207498, 8839.204471597555, 8844.469331840086, 7965.920340796591, 8060.355171586259, 8062.0, 8089.635966381512, 8368.874466882986, 2267.648514480258, 2299.3906614747107, 2306.2735238399932, 2308.2382813671447, 2311.191083120911, 2285.759995200505, 2299.8160147188187, 2308.503671710582, 2310.4685922237895, 2340.871252081135, 2300.5053913408615, 2312.1213938703268, 2313.201945328859, 2318.234982455794, 2322.651602259666, 2292.5300313435705, 2298.5058212484228, 2300.5973954557967, 2301.367124040902, 2303.5623231585946, 1931.9227230910747, 2242.248846636379, 2283.417728479227, 2286.0969916882736, 2304.2396009316885, 8720.912790872073, 8797.164269394398, 8801.427907186076, 8803.515806630632, 8806.735797926009, 5032.471590482984, 5211.661242019257, 5212.218167274901, 5219.295395121648, 5221.817236396746, 3404.778689385182, 3500.03748969033, 3547.5210846535647, 3548.0952357148763, 3553.9644603553893, 1005.3214080495636, 1050.112654806687, 1063.643679367413, 1068.5458680061022, 1072.6835583502886, 11548.307101573933, 11548.826767598493, 11550.94224528872, 11567.652970410902, 11569.595064172798, 4516.774161291923, 4571.405717256735, 4722.386089808303, 4797.0, 4802.111609352281, 9020.368574199874, 9065.048169942062, 9066.727998160066, 9078.319126065571, 9082.18260356558, 5132.948670513321, 5141.280220769096, 5142.408623008402, 5143.099957507421, 5147.845564633067, 4707.599854012379, 4741.407324084489, 4770.76146192689, 4797.56821886032, 4808.663393562487, 3440.638732933056, 3487.5640544931885, 3488.70346020586, 3534.7172226222356, 3549.254656522108, 1064.0689396777818, 1067.8771941226703, 1068.1454836131063, 1077.0952399983894, 1077.175960390302, 875.7066382761719, 905.6467977488785, 906.3112034853559, 949.2643201518878, 963.080258353285, 5152.896942061137, 5575.386707462176, 5689.601727879091, 5897.970510147507, 6129.478994285447, 423.947006624172, 436.23658597454454, 441.20803158330233, 443.40362212823703, 445.8350410348127, 2966.9554956675665, 3809.209671454412, 3918.5101862267215, 4018.8392464301687, 4050.9392359114636, 10240.692779216635, 10564.207684423698, 10672.94663526693, 10687.358758474516, 10716.892831071746, 10610.840837387444, 10612.20408469368, 10616.946915265375, 10626.14990800734, 10635.255532112833, 7905.367570594339, 7919.3268572170855, 8005.0, 8029.076656184497, 8130.918690813134, 5816.47651711348, 5827.1841942127285, 5833.241678581757, 5882.411758824083, 5917.283987643707, 8805.867911981453, 9604.807903842024, 9793.412395256308, 9859.605615775576, 10028.348157369748, 9830.655927042519, 9952.10431061208, 10059.849102263326, 10097.798044039226, 10197.490125493843, 6368.904466432915, 6387.648679322496, 6600.504962127956, 6614.603123812587, 6673.232578253563, 8144.5520496373265, 8349.03986041613, 8350.791230219293, 8365.749027529184, 8366.24703776663, 7154.463415243774, 7197.784066478014, 7315.963420182865, 7445.478816482794, 7531.661075251736, 7163.426925845815, 7241.0, 7348.3386495213545, 7380.852382952418, 7413.666385012795, 6830.829229269308, 6952.756653517103, 6961.37347638715, 6976.5465244758925, 6989.161300643752, 4850.296706977539, 4882.584980276574, 4907.2393778964315, 5061.31672224245, 5097.057044446789, 4813.566778989908, 4917.852464426073, 4991.126552853164, 5050.141475949024, 5134.10153223177], "value": 4375.434509502423, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.227358405888, 289.58300047930976, 296.842673383107, 302.4269010225624, 303.2434076977939, 4988.68252612013, 5219.86950326242, 5470.753816078276, 5531.253280807085, 5607.7476513556885, 5209.984053109645, 5217.2695822584865, 5371.785128594861, 5383.596230282735, 5529.806456774014, 3259.8044117353033, 4080.2859499587603, 4103.281925663012, 4123.7938103094875, 4133.379993001044, 3753.7935413552245, 4095.4471146395304, 4159.168166366739, 4159.667226621878, 4311.288637374845, 3794.2221844521946, 4053.43251944728, 4084.530279017921, 4086.346184610463, 4132.483439570054, 4029.0, 4040.313146765028, 4063.7155399122075, 4072.857449989251, 4096.8975775605695, 2905.5641653752105, 3472.75690701651, 3476.774009689362, 3489.616142224353, 3490.6212046241844, 4985.027919555652, 5347.946520534783, 5392.0, 5418.566514678816, 5423.349198096214, 3804.1630841214887, 4606.355110284563, 4668.906621867578, 4676.415448068991, 4716.0, 5751.25233719618, 5822.563307751935, 5842.649441033552, 5847.883042339172, 5860.208871802295, 3403.7787543809823, 3731.9626803731885, 3833.8658146965, 3841.8847434577006, 3865.43951127085, 4957.380327459067, 5412.350517937873, 5798.275215598051, 5998.670073145975, 6073.665948372838, 3085.9074227773203, 3885.00854342155, 3885.3977633466857, 3913.202060526737, 3924.547917270571, 3331.68349006844, 3967.6230758077936, 3973.344398174269, 3980.8805735827973, 3991.960080399217, 4184.782065505287, 4603.549881787227, 4644.907101858012, 4649.465311489222, 4687.367205427224, 4801.567858892717, 5643.802466913638, 5748.166515855261, 5776.740046697909, 5789.218455508452, 1261.2054405724334, 1332.054241488554, 1340.2092765268537, 1347.8517363090052, 1369.3020654388486, 833.9791505212419, 834.5827086456771, 846.2679781988659, 867.8915135608049, 890.7327801659476, 4488.4165058542185, 5370.892582148335, 5372.301600791872, 5377.3816011159215, 5397.082495975694, 5149.665271757323, 5911.261092363455, 5937.376575459601, 5954.404559544011, 6066.090086487062, 5074.340335756328, 5295.576353891679, 5376.0, 5403.729813509309, 5416.945830541723, 2951.6605590356953, 3077.092257783959, 3106.2820032471586, 3112.1057416602325, 3120.3603261331828, 5091.719955402488, 5401.405845357008, 5989.0, 6142.201513803177, 6205.47253483459, 6081.209442772411, 6120.449159575571, 6177.289611694623, 6191.349908259568, 6228.688565571703, 5474.073333999353, 6184.0, 6259.436650701458, 6284.402981716729, 6335.303116657256, 5517.917231241454, 5876.590597854859, 5887.7056147191615, 5933.228680271537, 5954.315253745702, 5422.620416570802, 5843.415658434293, 5876.354620706209, 5879.706014699163, 6008.699565021819, 5875.004996602181, 5931.733072011683, 6217.96891015542, 6260.090672344979, 6302.621842689453, 3214.2928555717704, 3331.4170020245874, 3371.983140084284, 3866.304065268279, 3885.7862817544174, 6028.186194863637, 6064.423879731418, 6098.603590766586, 6102.938970610237, 6138.754449821957, 4419.535948725466, 5064.645474816874, 5687.374388817144, 5727.565784541636, 5930.382466695399, 5116.411612664442, 5120.13115212952, 5125.718085505184, 5830.912536311874, 5881.9705901470215, 4390.0, 4956.405231372259, 5103.698556867975, 5110.61670374716, 5656.406077361818, 5221.556167725786, 5268.604854635841, 5665.6317339374455, 5697.230873832145, 5710.942890571041, 5261.605379596469, 5609.579281553818, 5629.634073785191, 5630.60585758993, 5703.20155178267], "value": 4161.811877555234, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.3936533149517, 739.8594267089253, 772.0503780350169, 819.8975128108987, 837.99581002095, 15451.84548154518, 15723.13522756248, 15760.054396736205, 15802.60493487662, 16075.356985720571, 14223.146611203336, 14278.0, 14330.0, 14333.924955628318, 14348.139111653309, 691.3570379547019, 707.5966698981582, 710.4777988178711, 843.9071702112763, 853.3940901959617, 877.368294827723, 882.4043770454917, 892.384254864145, 894.6108442827358, 900.7432881628737, 952.3857112162651, 954.551360860398, 954.8376775948105, 955.2549011770795, 956.4500412262942, 947.313197931501, 949.2358651285713, 950.1401231885155, 950.7765675066354, 950.8954015058338, 537.301508039551, 553.5626854784715, 558.6731761919282, 687.2165731066588, 689.1316940654812, 15052.172130532816, 15071.321790519452, 15071.47249846261, 15082.472113475975, 15102.924485377613, 13506.459741610324, 13786.310684465736, 13884.930575347058, 13940.093893896865, 14211.360488777926, 11045.447727613588, 12093.274403535816, 12586.81119783204, 12723.23660580359, 13145.21128732279, 3891.571927088018, 4472.753998530079, 4474.6420286377015, 4496.0, 4538.092381523708, 112288.0, 112793.0, 113238.43380783126, 113355.0, 114210.0, 10573.471326433648, 10654.041136297616, 10911.83632245517, 10918.50866711, 11446.0, 20804.791952080588, 20919.849408282385, 21135.0, 21218.575628487342, 21249.893750531148, 7594.088709354913, 7695.576743279174, 7714.151443341228, 7794.064712234568, 7836.960815195887, 3521.9119522011642, 4095.344744840811, 4141.668666506672, 4272.124214536013, 4315.568443155722, 2796.902108426236, 3508.5438892943753, 3515.402381595135, 3515.54297941266, 3517.3141237458963, 580.7154494297848, 615.5691016288616, 636.3477435628517, 636.4558302651259, 657.746767494518, 557.5678848892142, 610.1732152932801, 624.7625902157242, 627.1940556385023, 636.9808905732835, 8667.219950204386, 8748.825023499494, 9034.32242581809, 9054.411463254999, 9108.49903255314, 517.583345406951, 592.1768741449389, 606.4360145065132, 622.99386490817, 644.5101722690789, 4159.875203743893, 4308.569143085666, 4322.0491491871735, 4377.606015458624, 4427.313766366218, 129760.35119824529, 140050.2997485006, 148869.0, 156696.0, 168998.0, 125970.37014814868, 138467.0, 142767.28616356853, 143157.0, 145859.0, 117536.0, 118945.0, 119548.0, 120579.0, 120694.18958715626, 8383.203595658402, 8408.201220884006, 8432.831343372976, 8462.449940753831, 8646.697365592174, 48972.0, 59406.70296648489, 63381.0, 64175.037374440355, 67630.0, 61208.77582448237, 67319.0, 72664.0, 94798.0, 99284.0, 10177.440240786827, 10675.359478431319, 10705.250632455653, 10786.676399708022, 10847.566097356017, 11976.46105925218, 12013.099017573542, 12022.27866328023, 12551.686207844878, 12635.0, 11335.716607084889, 11351.0, 11451.942740286246, 11477.512228098725, 11690.415479226174, 13155.0, 13256.270905100311, 13711.0, 13903.721925561635, 14174.32747721695, 12913.031522635652, 13102.934485327512, 13480.662983425493, 13696.65758356049, 13867.076221853722, 11105.611303604335, 11327.830082548604, 11582.36297003673, 11594.594189203337, 11643.359615220905, 9869.0, 10300.484975751333, 11049.0366294717, 11507.367094809531, 11572.18994670365], "value": 7632.213506901999, "unit": "score"}], "name": "dromaeo_css", "value": 7220.830013379652, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 113.0, 120.0, 165.0, 155.0, 114.0, 114.0, 113.0, 114.0], "value": 123.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 109.0, 110.0, 149.0, 112.0, 112.0, 112.0, 114.0, 145.0, 130.0], "value": 124.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 185.0, 182.0, 184.0, 184.0, 183.0, 186.0, 253.0, 221.0], "value": 194.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 58.0, 91.0, 80.0, 83.0, 82.0, 82.0, 83.0, 59.0], "value": 75.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 118.0, 100.0, 98.0, 69.0, 91.0, 65.0, 67.0, 88.0], "value": 85.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 88.0, 90.0, 86.0, 91.0, 87.0, 91.0, 89.0, 90.0, 87.0], "value": 89.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 106.0, 151.0, 113.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 103.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 83.0, 79.0, 82.0, 86.0, 83.0, 83.0, 85.0, 81.0, 82.0], "value": 83.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 53.0, 54.0, 54.0, 54.0, 56.0, 55.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 79.0, 75.0, 72.0, 69.0, 70.0, 71.0, 70.0, 70.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 84.0, 86.0, 86.0, 84.0, 86.0, 86.0, 85.0, 89.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 166.0, 155.0, 154.0, 156.0, 145.0, 163.0, 139.0, 217.0, 156.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 176.0, 171.0, 172.0, 174.0, 171.0, 172.0, 173.0, 173.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 68.0, 70.0, 68.0, 68.0, 69.0, 68.0, 68.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1491.6999999999998, "alertThreshold": 2.0}]} 06:02:19 INFO - Return code: 0 06:02:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:02:19 INFO - # TBPL SUCCESS # 06:02:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:02:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:02:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:02:19 INFO - 2016-10-24 06:02:19.797 screenresolution[1673:10968] starting screenresolution argv=screenresolution get 06:02:19 INFO - 2016-10-24 06:02:19.800 screenresolution[1673:10968] Display 0: 1600x1200x32@60 06:02:19 INFO - 2016-10-24 06:02:19.806 screenresolution[1674:10971] starting screenresolution argv=screenresolution list 06:02:19 INFO - Available Modes on Display 0 06:02:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:02:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:02:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:02:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:02:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:02:20 INFO - Intel Iris: 06:02:20 INFO - Chipset Model: Intel Iris 06:02:20 INFO - Type: GPU 06:02:20 INFO - Bus: Built-In 06:02:20 INFO - VRAM (Dynamic, Max): 1536 MB 06:02:20 INFO - Vendor: Intel (0x8086) 06:02:20 INFO - Device ID: 0x0a2e 06:02:20 INFO - Revision ID: 0x0009 06:02:20 INFO - Displays: 06:02:20 INFO - Display: 06:02:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:02:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:02:20 INFO - Display Serial Number: 1600x1200 60 06:02:20 INFO - Main Display: Yes 06:02:20 INFO - Mirror: Off 06:02:20 INFO - Online: Yes 06:02:20 INFO - Rotation: Supported 06:02:20 INFO - Return code: 0 06:02:20 INFO - Running post-action listener: _resource_record_post_action 06:02:20 INFO - [mozharness: 2016-10-24 13:02:20.041826Z] Finished run-tests step (success) 06:02:20 INFO - Running post-run listener: _resource_record_post_run 06:02:20 INFO - Total resource usage - Wall time: 1215s; CPU: 53.0%; Read bytes: 33328128; Write bytes: 708497920; Read time: 342; Write time: 2306 06:02:20 INFO - TinderboxPrint: CPU usage
53.5% 06:02:20 INFO - TinderboxPrint: I/O read bytes / time
33,328,128 / 342 06:02:20 INFO - TinderboxPrint: I/O write bytes / time
708,497,920 / 2,306 06:02:20 INFO - TinderboxPrint: CPU idle
2,260.8 (46.5%) 06:02:20 INFO - TinderboxPrint: CPU system
970.5 (20.0%) 06:02:20 INFO - TinderboxPrint: CPU user
1,630.4 (33.5%) 06:02:20 INFO - TinderboxPrint: Swap in / out
448,880,640 / 0 06:02:20 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 395655680; Write bytes: 390288896; Read time: 29341; Write time: 713 06:02:20 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 31341568; Write bytes: 299830272; Read time: 321; Write time: 1549 06:02:20 INFO - Running post-run listener: _upload_blobber_files 06:02:20 INFO - Blob upload gear active. 06:02:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:02:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:02:20 INFO - (blobuploader) - INFO - Open directory for files ... 06:02:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:02:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:02:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:22 INFO - (blobuploader) - INFO - Done attempting. 06:02:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:02:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:02:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:23 INFO - (blobuploader) - INFO - Done attempting. 06:02:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:02:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:02:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:26 INFO - (blobuploader) - INFO - Done attempting. 06:02:26 INFO - (blobuploader) - INFO - Iteration through files over. 06:02:26 INFO - Return code: 0 06:02:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:02:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:02:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5c9d28c146d9228d45591394e7cd5536b41b66777b2d02eafe219368d0da8e7cde7882e73c398a3bdb77685af06088470e259f45f42a5c9d394b3c6c36d8690", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eff9f7c81cdcda6b71ee61f289f4550d481df30025981397206e5f155e8a409ce9c788af236b074c7d0561ae5c7422669acbbd16f72c873ae1e98dd88fa06431", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0758fb70e9fd5a4b9f97911d5e02aac8cc444fb894dcc366b405a9fa2d178709bf3a45d04cc11ac6e9c1c31f11719aca5e4f8a2dcba00ea64504e046e4524abc"} 06:02:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:02:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:02:26 INFO - Contents: 06:02:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5c9d28c146d9228d45591394e7cd5536b41b66777b2d02eafe219368d0da8e7cde7882e73c398a3bdb77685af06088470e259f45f42a5c9d394b3c6c36d8690", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eff9f7c81cdcda6b71ee61f289f4550d481df30025981397206e5f155e8a409ce9c788af236b074c7d0561ae5c7422669acbbd16f72c873ae1e98dd88fa06431", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0758fb70e9fd5a4b9f97911d5e02aac8cc444fb894dcc366b405a9fa2d178709bf3a45d04cc11ac6e9c1c31f11719aca5e4f8a2dcba00ea64504e046e4524abc"} 06:02:26 INFO - Running post-run listener: copy_logs_to_upload_dir 06:02:26 INFO - Copying logs to upload dir... 06:02:26 INFO - mkdir: /builds/slave/test/build/upload/logs 06:02:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.101152 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-10-24 06:02:26.089047) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 06:02:26.093150) ========= 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.x6AfgJZIkE/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.cPG3N4CBts/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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/a5c9d28c146d9228d45591394e7cd5536b41b66777b2d02eafe219368d0da8e7cde7882e73c398a3bdb77685af06088470e259f45f42a5c9d394b3c6c36d8690", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eff9f7c81cdcda6b71ee61f289f4550d481df30025981397206e5f155e8a409ce9c788af236b074c7d0561ae5c7422669acbbd16f72c873ae1e98dd88fa06431", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0758fb70e9fd5a4b9f97911d5e02aac8cc444fb894dcc366b405a9fa2d178709bf3a45d04cc11ac6e9c1c31f11719aca5e4f8a2dcba00ea64504e046e4524abc"} build_url:https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/UYJ4jfbyT6yN1nemPqA9rg/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/a5c9d28c146d9228d45591394e7cd5536b41b66777b2d02eafe219368d0da8e7cde7882e73c398a3bdb77685af06088470e259f45f42a5c9d394b3c6c36d8690", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eff9f7c81cdcda6b71ee61f289f4550d481df30025981397206e5f155e8a409ce9c788af236b074c7d0561ae5c7422669acbbd16f72c873ae1e98dd88fa06431", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0758fb70e9fd5a4b9f97911d5e02aac8cc444fb894dcc366b405a9fa2d178709bf3a45d04cc11ac6e9c1c31f11719aca5e4f8a2dcba00ea64504e046e4524abc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 06:02:26.126582) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 06:02:26.126948) ========= 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.x6AfgJZIkE/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.cPG3N4CBts/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.005168 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 06:02:26.175823) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 06:02:26.176164) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 06:02:26.176523) ========= ========= Total master_lag: 0.19 =========