builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0340 starttime: 1477274223.9 results: success (0) buildid: 20161023170523 builduid: 4f882d1610144fd7a82e16bcd66fa4f7 revision: 215f9686117673a2c914ed207bc7da9bb8d741ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 18:57:03.898179) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 18:57:03.898702) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 18:57:03.899005) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 18:57:04.374234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 18:57:04.374753) ========= 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.3hKCuEJ59B/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.j7P4TenLOf/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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-23 18:57:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 179M=0s 2016-10-23 18:57:04 (179 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.502030 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 18:57:04.916809) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 18:57:04.917384) ========= 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.3hKCuEJ59B/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.j7P4TenLOf/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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.025094 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 18:57:04.970951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-23 18:57:04.971316) ========= 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.3hKCuEJ59B/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.j7P4TenLOf/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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-23 18:57:05,053 truncating revision to first 12 chars 2016-10-23 18:57:05,054 Setting DEBUG logging. 2016-10-23 18:57:05,054 attempt 1/10 2016-10-23 18:57:05,054 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-23 18:57:05,767 unpacking tar archive at: mozilla-central-215f96861176/testing/mozharness/ program finished with exit code 0 elapsedTime=0.985132 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-23 18:57:05.983754) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 18:57:05.984205) ========= script_repo_revision: 215f9686117673a2c914ed207bc7da9bb8d741ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 18:57:05.984668) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 18:57:05.984991) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 18:57:06.001462) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-23 18:57:06.002184) ========= /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.3hKCuEJ59B/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.j7P4TenLOf/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:57:06 INFO - MultiFileLogger online at 20161023 18:57:06 in /builds/slave/test 18:57:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:57:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:57:06 INFO - {'append_to_log': False, 18:57:06 INFO - 'base_work_dir': '/builds/slave/test', 18:57:06 INFO - 'blob_upload_branch': 'Firefox', 18:57:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:57:06 INFO - 'branch': 'Firefox', 18:57:06 INFO - 'buildbot_json_path': 'buildprops.json', 18:57:06 INFO - 'config_files': ('talos/mac_config.py',), 18:57:06 INFO - 'default_actions': ('clobber', 18:57:06 INFO - 'read-buildbot-config', 18:57:06 INFO - 'download-and-extract', 18:57:06 INFO - 'populate-webroot', 18:57:06 INFO - 'create-virtualenv', 18:57:06 INFO - 'install', 18:57:06 INFO - 'run-tests'), 18:57:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:57:06 INFO - 'download_minidump_stackwalk': True, 18:57:06 INFO - 'download_symbols': 'ondemand', 18:57:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:57:06 INFO - 'tooltool.py': '/tools/tooltool.py', 18:57:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:57:06 INFO - '/tools/misc-python/virtualenv.py')}, 18:57:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:57:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:57:06 INFO - 'installer_path': 'installer.exe', 18:57:06 INFO - 'log_level': 'info', 18:57:06 INFO - 'log_name': 'talos', 18:57:06 INFO - 'log_to_console': True, 18:57:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:57:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:57:06 INFO - 'opt_config_files': (), 18:57:06 INFO - 'pip_index': False, 18:57:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:57:06 INFO - 'cmd': ('bash', 18:57:06 INFO - '-c', 18:57:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:57:06 INFO - 'enabled': True, 18:57:06 INFO - 'halt_on_failure': False, 18:57:06 INFO - 'name': 'check_screen_resolution'},), 18:57:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:57:06 INFO - 'cmd': ('bash', 18:57:06 INFO - '-c', 18:57:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:57:06 INFO - 'enabled': True, 18:57:06 INFO - 'halt_on_failure': False, 18:57:06 INFO - 'name': 'check_screen_resolution'},), 18:57:06 INFO - 'run_cmd_checks_enabled': True, 18:57:06 INFO - 'sps_profile': False, 18:57:06 INFO - 'sps_profile_interval': 0, 18:57:06 INFO - 'suite': 'dromaeojs', 18:57:06 INFO - 'system_bits': '32', 18:57:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:57:06 INFO - 'title': 't-yosemite-r7-0340', 18:57:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:57:06 INFO - 'use_talos_json': True, 18:57:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:57:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:57:06 INFO - 'work_dir': 'build'} 18:57:06 INFO - [mozharness: 2016-10-24 01:57:06.205750Z] Running clobber step. 18:57:06 INFO - Running pre-action listener: _resource_record_pre_action 18:57:06 INFO - Running main action method: clobber 18:57:06 INFO - rmtree: /builds/slave/test/build 18:57:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:57:08 INFO - Running post-action listener: _resource_record_post_action 18:57:08 INFO - [mozharness: 2016-10-24 01:57:08.340120Z] Finished clobber step (success) 18:57:08 INFO - [mozharness: 2016-10-24 01:57:08.340276Z] Running read-buildbot-config step. 18:57:08 INFO - Running pre-action listener: _resource_record_pre_action 18:57:08 INFO - Running main action method: read_buildbot_config 18:57:08 INFO - Using buildbot properties: 18:57:08 INFO - { 18:57:08 INFO - "project": "", 18:57:08 INFO - "product": "firefox", 18:57:08 INFO - "script_repo_revision": "production", 18:57:08 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:57:08 INFO - "repository": "", 18:57:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:57:08 INFO - "buildid": "20161023170523", 18:57:08 INFO - "pgo_build": "False", 18:57:08 INFO - "basedir": "/builds/slave/test", 18:57:08 INFO - "buildnumber": 57, 18:57:08 INFO - "slavename": "t-yosemite-r7-0340", 18:57:08 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 18:57:08 INFO - "platform": "yosemite_r7", 18:57:08 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:57:08 INFO - "branch": "mozilla-central", 18:57:08 INFO - "repo_path": "mozilla-central", 18:57:08 INFO - "revision": "215f9686117673a2c914ed207bc7da9bb8d741ad", 18:57:08 INFO - "stage_platform": "macosx64", 18:57:08 INFO - "builduid": "4f882d1610144fd7a82e16bcd66fa4f7", 18:57:08 INFO - "slavebuilddir": "test" 18:57:08 INFO - } 18:57:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 18:57:08 INFO - Running post-action listener: _resource_record_post_action 18:57:08 INFO - [mozharness: 2016-10-24 01:57:08.343659Z] Finished read-buildbot-config step (success) 18:57:08 INFO - [mozharness: 2016-10-24 01:57:08.343789Z] Running download-and-extract step. 18:57:08 INFO - Running pre-action listener: _resource_record_pre_action 18:57:08 INFO - Running main action method: download_and_extract 18:57:08 INFO - mkdir: /builds/slave/test/build/tests 18:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:08 INFO - trying https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 18:57:08 INFO - Downloading https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/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 18:57:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/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 18:57:09 INFO - Downloaded 1199 bytes. 18:57:09 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 18:57:09 INFO - Using the following test package requirements: 18:57:09 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 18:57:09 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:57:09 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 18:57:09 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:57:09 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 18:57:09 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:57:09 INFO - u'jsshell-mac.zip'], 18:57:09 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:57:09 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 18:57:09 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 18:57:09 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:57:09 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 18:57:09 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:57:09 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 18:57:09 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:57:09 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 18:57:09 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:57:09 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 18:57:09 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:57:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 18:57:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:57:09 INFO - Fetch https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 18:57:09 INFO - Http code: 200 18:57:09 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 18:57:09 INFO - x-amz-cf-id: xZT5OCUxxD46WJI1GjIPVxg3wg_ueoZer6Bu2AX2cUcYnB009pa8ow== 18:57:09 INFO - x-amz-version-id: _vDOfsmhPXjycDqZ_t4H1MFgOQjjaNvr 18:57:10 INFO - Expected file size: 16409296 18:57:10 INFO - Obtained file size: 16409296 18:57:16 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 18:57:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 18:57:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:57:16 INFO - Fetch https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 18:57:17 INFO - Http code: 200 18:57:17 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 18:57:17 INFO - x-amz-cf-id: vwwEUwdryMJyLy3w8IXxoI432He-fiE4tmwh27qlp4fpfCguPcA7_A== 18:57:17 INFO - x-amz-version-id: _vDOfsmhPXjycDqZ_t4H1MFgOQjjaNvr 18:57:17 INFO - Expected file size: 16409296 18:57:17 INFO - Obtained file size: 16409296 18:57:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 18:57:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:57:23 INFO - Fetch https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 18:57:24 INFO - Http code: 200 18:57:24 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 18:57:24 INFO - x-amz-cf-id: uFfLuz4PjhlhPz1p7rib3r9WZASVjUh3o8VtE2HaP29BvKS5iZ3Qgw== 18:57:24 INFO - x-amz-version-id: er_KJu2nPu7BcEuMSdC9nZ6Wl1pDEplT 18:57:24 INFO - Expected file size: 14409028 18:57:24 INFO - Obtained file size: 14409028 18:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:25 INFO - trying https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 18:57:25 INFO - Downloading https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 18:57:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/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 18:57:28 INFO - Downloaded 111199856 bytes. 18:57:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 18:57:28 INFO - mkdir: /builds/slave/test/properties 18:57:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:57:28 INFO - Writing to file /builds/slave/test/properties/build_url 18:57:28 INFO - Contents: 18:57:28 INFO - build_url:https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 18:57:29 INFO - Running post-action listener: _resource_record_post_action 18:57:29 INFO - Running post-action listener: set_extra_try_arguments 18:57:29 INFO - [mozharness: 2016-10-24 01:57:29.024761Z] Finished download-and-extract step (success) 18:57:29 INFO - [mozharness: 2016-10-24 01:57:29.024920Z] Running populate-webroot step. 18:57:29 INFO - Running pre-action listener: _resource_record_pre_action 18:57:29 INFO - Running main action method: populate_webroot 18:57:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:57:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:57:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:57:29 INFO - '--tppagecycles', 18:57:29 INFO - '7'], 18:57:29 INFO - 'tests': ['tsvgm']}}, 18:57:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:57:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:57:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:57:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:57:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:57:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:57:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:29 INFO - 'talos_options': ['--disable-e10s'], 18:57:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:57:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:57:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:29 INFO - 'talos_options': ['--disable-e10s'], 18:57:29 INFO - 'tests': ['damp', 'tps']}, 18:57:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:29 INFO - 'tests': ['damp', 'tps']}, 18:57:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:57:29 INFO - 'tests': ['dromaeo_dom']}, 18:57:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:57:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:57:29 INFO - 'tests': ['basic_compositor_video']}, 18:57:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:57:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:57:29 INFO - 'tests': ['a11yr', 18:57:29 INFO - 'ts_paint', 18:57:29 INFO - 'tpaint', 18:57:29 INFO - 'sessionrestore', 18:57:29 INFO - 'sessionrestore_no_auto_restore', 18:57:29 INFO - 'tabpaint']}, 18:57:29 INFO - 'other-e10s': {'tests': ['a11yr', 18:57:29 INFO - 'ts_paint', 18:57:29 INFO - 'tpaint', 18:57:29 INFO - 'sessionrestore', 18:57:29 INFO - 'sessionrestore_no_auto_restore', 18:57:29 INFO - 'tabpaint']}, 18:57:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:57:29 INFO - 'ts_paint', 18:57:29 INFO - 'tpaint', 18:57:29 INFO - 'sessionrestore', 18:57:29 INFO - 'sessionrestore_no_auto_restore', 18:57:29 INFO - 'tabpaint']}, 18:57:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:57:29 INFO - 'ts_paint', 18:57:29 INFO - 'tpaint', 18:57:29 INFO - 'sessionrestore', 18:57:29 INFO - 'sessionrestore_no_auto_restore', 18:57:29 INFO - 'tabpaint']}, 18:57:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:57:29 INFO - 'tests': ['a11yr', 18:57:29 INFO - 'ts_paint', 18:57:29 INFO - 'tpaint', 18:57:29 INFO - 'sessionrestore', 18:57:29 INFO - 'sessionrestore_no_auto_restore', 18:57:29 INFO - 'tabpaint']}, 18:57:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:57:29 INFO - 'tests': ['a11yr', 18:57:29 INFO - 'ts_paint', 18:57:29 INFO - 'tpaint', 18:57:29 INFO - 'sessionrestore', 18:57:29 INFO - 'sessionrestore_no_auto_restore', 18:57:29 INFO - 'tabpaint']}, 18:57:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:57:29 INFO - 'tests': ['tsvgx', 18:57:29 INFO - 'tsvgr_opacity', 18:57:29 INFO - 'tart', 18:57:29 INFO - 'tscrollx', 18:57:29 INFO - 'cart']}, 18:57:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:57:29 INFO - 'tsvgr_opacity', 18:57:29 INFO - 'tart', 18:57:29 INFO - 'tscrollx', 18:57:29 INFO - 'cart']}, 18:57:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:29 INFO - 'talos_options': ['--disable-e10s'], 18:57:29 INFO - 'tests': ['tp5o']}, 18:57:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:29 INFO - 'tests': ['tp5o']}, 18:57:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:29 INFO - 'talos_options': ['--disable-e10s', 18:57:29 INFO - '--xperf_path', 18:57:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:57:29 INFO - 'tests': ['tp5n']}, 18:57:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:29 INFO - 'talos_options': ['--xperf_path', 18:57:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:57:29 INFO - 'tests': ['tp5n']}}, 18:57:29 INFO - 'talos.zip': {'path': '', 18:57:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:57:29 INFO - Running post-action listener: _resource_record_post_action 18:57:29 INFO - [mozharness: 2016-10-24 01:57:29.044172Z] Finished populate-webroot step (success) 18:57:29 INFO - [mozharness: 2016-10-24 01:57:29.044283Z] Running create-virtualenv step. 18:57:29 INFO - Running pre-action listener: _resource_record_pre_action 18:57:29 INFO - Running main action method: create_virtualenv 18:57:29 INFO - Creating virtualenv /builds/slave/test/build/venv 18:57:29 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 18:57:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:57:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:57:29 INFO - Using real prefix '/tools/python27' 18:57:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:57:29 INFO - Installing distribute.............................................................................................................................................................................................done. 18:57:32 INFO - Installing pip.................done. 18:57:32 INFO - Return code: 0 18:57:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:57:33 INFO - Reading from file tmpfile_stdout 18:57:33 INFO - Output received: 18:57:33 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) 18:57:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108c30490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c3db4f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a44d30>, '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 0x10886adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a3cb20>, '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.3hKCuEJ59B/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.j7P4TenLOf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:57:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:57:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hKCuEJ59B/Render', 18:57:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:33 INFO - 'HOME': '/Users/cltbld', 18:57:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:33 INFO - 'LOGNAME': 'cltbld', 18:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:33 INFO - 'MOZ_NO_REMOTE': '1', 18:57:33 INFO - 'NO_EM_RESTART': '1', 18:57:33 INFO - 'PAGER': '/bin/cat', 18:57:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:33 INFO - 'PWD': '/builds/slave/test', 18:57:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:33 INFO - 'SHELL': '/bin/bash', 18:57:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j7P4TenLOf/Listeners', 18:57:33 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:57:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:33 INFO - 'USER': 'cltbld', 18:57:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:33 INFO - 'XPC_FLAGS': '0x0', 18:57:33 INFO - 'XPC_SERVICE_NAME': '0', 18:57:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:33 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 18:57:33 INFO - Cleaning up... 18:57:33 INFO - Return code: 0 18:57:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108c30490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c3db4f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a44d30>, '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 0x10886adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a3cb20>, '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.3hKCuEJ59B/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.j7P4TenLOf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:57:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:57:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hKCuEJ59B/Render', 18:57:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:33 INFO - 'HOME': '/Users/cltbld', 18:57:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:33 INFO - 'LOGNAME': 'cltbld', 18:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:33 INFO - 'MOZ_NO_REMOTE': '1', 18:57:33 INFO - 'NO_EM_RESTART': '1', 18:57:33 INFO - 'PAGER': '/bin/cat', 18:57:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:33 INFO - 'PWD': '/builds/slave/test', 18:57:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:33 INFO - 'SHELL': '/bin/bash', 18:57:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j7P4TenLOf/Listeners', 18:57:33 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:57:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:33 INFO - 'USER': 'cltbld', 18:57:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:33 INFO - 'XPC_FLAGS': '0x0', 18:57:33 INFO - 'XPC_SERVICE_NAME': '0', 18:57:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:33 INFO - Downloading/unpacking psutil>=3.1.1 18:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:57:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:57:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:57:37 INFO - Installing collected packages: psutil 18:57:37 INFO - Running setup.py install for psutil 18:57:37 INFO - building 'psutil._psutil_osx' extension 18:57:37 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 18:57:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:57:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:57:38 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 18:57:38 INFO - building 'psutil._psutil_posix' extension 18:57:38 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 18:57:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:57:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:57:38 INFO - ^ 18:57:38 INFO - 1 warning generated. 18:57:38 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 18:57:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:57:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:57:38 INFO - Successfully installed psutil 18:57:38 INFO - Cleaning up... 18:57:38 INFO - Return code: 0 18:57:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:38 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 0x108c30490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c3db4f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a44d30>, '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 0x10886adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a3cb20>, '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.3hKCuEJ59B/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.j7P4TenLOf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:57:38 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 18:57:38 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 18:57:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hKCuEJ59B/Render', 18:57:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:38 INFO - 'HOME': '/Users/cltbld', 18:57:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:38 INFO - 'LOGNAME': 'cltbld', 18:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:38 INFO - 'MOZ_NO_REMOTE': '1', 18:57:38 INFO - 'NO_EM_RESTART': '1', 18:57:38 INFO - 'PAGER': '/bin/cat', 18:57:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:38 INFO - 'PWD': '/builds/slave/test', 18:57:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:38 INFO - 'SHELL': '/bin/bash', 18:57:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j7P4TenLOf/Listeners', 18:57:38 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:57:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:38 INFO - 'USER': 'cltbld', 18:57:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:38 INFO - 'XPC_FLAGS': '0x0', 18:57:38 INFO - 'XPC_SERVICE_NAME': '0', 18:57:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:57:38 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 18:57:38 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 18:57:38 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 18:57:38 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 18:57:38 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 18:57:38 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 18:57:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:57:41 INFO - Installing collected packages: mozsystemmonitor 18:57:41 INFO - Running setup.py install for mozsystemmonitor 18:57:41 INFO - Successfully installed mozsystemmonitor 18:57:41 INFO - Cleaning up... 18:57:41 INFO - Return code: 0 18:57:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:41 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 0x108c30490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c3db4f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a44d30>, '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 0x10886adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a3cb20>, '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.3hKCuEJ59B/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.j7P4TenLOf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:57:41 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 18:57:41 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 18:57:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hKCuEJ59B/Render', 18:57:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:41 INFO - 'HOME': '/Users/cltbld', 18:57:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:41 INFO - 'LOGNAME': 'cltbld', 18:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:41 INFO - 'MOZ_NO_REMOTE': '1', 18:57:41 INFO - 'NO_EM_RESTART': '1', 18:57:41 INFO - 'PAGER': '/bin/cat', 18:57:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:41 INFO - 'PWD': '/builds/slave/test', 18:57:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:41 INFO - 'SHELL': '/bin/bash', 18:57:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j7P4TenLOf/Listeners', 18:57:41 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:57:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:41 INFO - 'USER': 'cltbld', 18:57:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:41 INFO - 'XPC_FLAGS': '0x0', 18:57:41 INFO - 'XPC_SERVICE_NAME': '0', 18:57:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:42 INFO - Downloading/unpacking jsonschema==2.5.1 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:57:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:57:44 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 18:57:44 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 18:57:44 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 18:57:44 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 18:57:44 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 18:57:44 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 18:57:44 INFO - Downloading functools32-3.2.3-2.tar.gz 18:57:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:57:45 INFO - warning: no files found matching '*.txt' 18:57:45 INFO - no previously-included directories found matching 'build' 18:57:45 INFO - no previously-included directories found matching 'dist' 18:57:45 INFO - no previously-included directories found matching '.git*' 18:57:45 INFO - Installing collected packages: jsonschema, functools32 18:57:45 INFO - Running setup.py install for functools32 18:57:45 INFO - warning: no files found matching '*.txt' 18:57:45 INFO - no previously-included directories found matching 'build' 18:57:45 INFO - no previously-included directories found matching 'dist' 18:57:45 INFO - no previously-included directories found matching '.git*' 18:57:45 INFO - Successfully installed jsonschema functools32 18:57:45 INFO - Cleaning up... 18:57:45 INFO - Return code: 0 18:57:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:57: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')]} 18:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57: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')]} 18:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57: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', '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 0x108c30490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c3db4f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a44d30>, '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 0x10886adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a3cb20>, '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.3hKCuEJ59B/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.j7P4TenLOf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:57: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:57: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 functools32==3.2.3-2 18:57:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hKCuEJ59B/Render', 18:57:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:45 INFO - 'HOME': '/Users/cltbld', 18:57:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:45 INFO - 'LOGNAME': 'cltbld', 18:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:45 INFO - 'MOZ_NO_REMOTE': '1', 18:57:45 INFO - 'NO_EM_RESTART': '1', 18:57:45 INFO - 'PAGER': '/bin/cat', 18:57:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:45 INFO - 'PWD': '/builds/slave/test', 18:57:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:45 INFO - 'SHELL': '/bin/bash', 18:57:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j7P4TenLOf/Listeners', 18:57:45 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:57:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:45 INFO - 'USER': 'cltbld', 18:57:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:45 INFO - 'XPC_FLAGS': '0x0', 18:57:45 INFO - 'XPC_SERVICE_NAME': '0', 18:57:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:57:45 INFO - Cleaning up... 18:57:45 INFO - Return code: 0 18:57:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:57: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')]} 18:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57: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')]} 18:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57: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', '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 0x108c30490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c3db4f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a44d30>, '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 0x10886adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a3cb20>, '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.3hKCuEJ59B/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.j7P4TenLOf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:57: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:57: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 blobuploader==1.2.4 18:57:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hKCuEJ59B/Render', 18:57:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:45 INFO - 'HOME': '/Users/cltbld', 18:57:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:45 INFO - 'LOGNAME': 'cltbld', 18:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:45 INFO - 'MOZ_NO_REMOTE': '1', 18:57:45 INFO - 'NO_EM_RESTART': '1', 18:57:45 INFO - 'PAGER': '/bin/cat', 18:57:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:45 INFO - 'PWD': '/builds/slave/test', 18:57:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:45 INFO - 'SHELL': '/bin/bash', 18:57:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j7P4TenLOf/Listeners', 18:57:45 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:57:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:45 INFO - 'USER': 'cltbld', 18:57:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:45 INFO - 'XPC_FLAGS': '0x0', 18:57:45 INFO - 'XPC_SERVICE_NAME': '0', 18:57:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:45 INFO - Downloading/unpacking blobuploader==1.2.4 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57:48 INFO - Downloading blobuploader-1.2.4.tar.gz 18:57:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:57:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:57:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57:49 INFO - Downloading docopt-0.6.1.tar.gz 18:57:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:57:49 INFO - Installing collected packages: blobuploader, requests, docopt 18:57:49 INFO - Running setup.py install for blobuploader 18:57:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:57:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:57:49 INFO - Running setup.py install for requests 18:57:50 INFO - Running setup.py install for docopt 18:57:50 INFO - Successfully installed blobuploader requests docopt 18:57:50 INFO - Cleaning up... 18:57:50 INFO - Return code: 0 18:57:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57:50 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')]} 18:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:50 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')]} 18:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:50 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 0x108c30490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c3db4f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a44d30>, '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 0x10886adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a3cb20>, '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.3hKCuEJ59B/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.j7P4TenLOf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:57:50 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 18:57:50 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 18:57:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hKCuEJ59B/Render', 18:57:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:50 INFO - 'HOME': '/Users/cltbld', 18:57:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:50 INFO - 'LOGNAME': 'cltbld', 18:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:50 INFO - 'MOZ_NO_REMOTE': '1', 18:57:50 INFO - 'NO_EM_RESTART': '1', 18:57:50 INFO - 'PAGER': '/bin/cat', 18:57:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:50 INFO - 'PWD': '/builds/slave/test', 18:57:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:50 INFO - 'SHELL': '/bin/bash', 18:57:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j7P4TenLOf/Listeners', 18:57:50 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:57:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:50 INFO - 'USER': 'cltbld', 18:57:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:50 INFO - 'XPC_FLAGS': '0x0', 18:57:50 INFO - 'XPC_SERVICE_NAME': '0', 18:57:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:57:50 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-CqDlCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:57:50 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-DD0J7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:57:50 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-FX6Yk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:57:51 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-A3Eizj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:57:51 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-bettGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:57:51 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Xs4eRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:57:51 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-2ejoUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:57:51 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Xojfxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:57:51 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-gArfwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:57:51 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-hR4KfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:57:51 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-nGctGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:57:51 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-QTO6IT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:57:52 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-qWVTvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:57:52 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-a05KmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:52 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-zT2mme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:57:52 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-wE49Cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:57:52 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-OixxiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:57:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:57:52 INFO - Running setup.py install for manifestparser 18:57:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:57:52 INFO - Running setup.py install for mozcrash 18:57:52 INFO - Running setup.py install for mozdebug 18:57:52 INFO - Running setup.py install for mozdevice 18:57:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:57:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:57:53 INFO - Running setup.py install for mozfile 18:57:53 INFO - Running setup.py install for mozhttpd 18:57:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:57:53 INFO - Running setup.py install for mozinfo 18:57:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:57:53 INFO - Running setup.py install for mozInstall 18:57:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:57:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:57:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:57:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:57:53 INFO - Running setup.py install for mozleak 18:57:53 INFO - Running setup.py install for mozlog 18:57:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:57:54 INFO - Running setup.py install for moznetwork 18:57:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:57:54 INFO - Running setup.py install for mozprocess 18:57:54 INFO - Running setup.py install for mozprofile 18:57:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:57:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:57:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:57:54 INFO - Running setup.py install for mozrunner 18:57:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:57:54 INFO - Running setup.py install for mozscreenshot 18:57:54 INFO - Running setup.py install for moztest 18:57:54 INFO - Running setup.py install for mozversion 18:57:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:57:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:57:55 INFO - Cleaning up... 18:57:55 INFO - Return code: 0 18:57:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:55 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 0x108c30490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c3db4f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a44d30>, '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 0x10886adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a3cb20>, '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.3hKCuEJ59B/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.j7P4TenLOf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:57:55 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 18:57:55 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 18:57:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hKCuEJ59B/Render', 18:57:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:55 INFO - 'HOME': '/Users/cltbld', 18:57:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:55 INFO - 'LOGNAME': 'cltbld', 18:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:55 INFO - 'MOZ_NO_REMOTE': '1', 18:57:55 INFO - 'NO_EM_RESTART': '1', 18:57:55 INFO - 'PAGER': '/bin/cat', 18:57:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:55 INFO - 'PWD': '/builds/slave/test', 18:57:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:55 INFO - 'SHELL': '/bin/bash', 18:57:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j7P4TenLOf/Listeners', 18:57:55 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:57:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:55 INFO - 'USER': 'cltbld', 18:57:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:55 INFO - 'XPC_FLAGS': '0x0', 18:57:55 INFO - 'XPC_SERVICE_NAME': '0', 18:57:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:57:55 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-uV3cEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:57:55 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)) 18:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:57:55 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-kPE_Ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:57:55 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)) 18:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:57:55 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Ibdnoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:57:55 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)) 18:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:57:55 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-jG2otA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:57:55 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)) 18:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:57:55 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-wD_9op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:57:55 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)) 18:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:57:55 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-ZmzD9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:57:56 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)) 18:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:57:56 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-1EMU5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:57:56 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)) 18:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:57:56 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-sCmVXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:57:56 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)) 18:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:57:56 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-bTQwLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:57:56 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)) 18:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:57:56 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-QnMMtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:57:56 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)) 18:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:57:56 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Dxl9wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:57:56 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)) 18:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:57:56 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-wsKJDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:57:56 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)) 18:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:57:56 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-oko72p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:57:56 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)) 18:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:57:56 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-gtgMDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:57:56 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)) 18:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:56 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-eAkoGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:57 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)) 18:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:57:57 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-KNVtvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:57:57 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)) 18:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:57:57 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-DqKVzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:57:57 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)) 18:57:57 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)) 18:57:57 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)) 18:57:57 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)) 18:57:57 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)) 18:57:57 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)) 18:57:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:57:57 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 18:57:57 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 18:57:57 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 18:57:57 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 18:57:57 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 18:57:57 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 18:57:59 INFO - Downloading blessings-1.6.tar.gz 18:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:57:59 INFO - Installing collected packages: blessings 18:57:59 INFO - Running setup.py install for blessings 18:58:00 INFO - Successfully installed blessings 18:58:00 INFO - Cleaning up... 18:58:00 INFO - Return code: 0 18:58:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:58:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:58:00 INFO - Reading from file tmpfile_stdout 18:58:00 INFO - Current package versions: 18:58:00 INFO - blessings == 1.6 18:58:00 INFO - blobuploader == 1.2.4 18:58:00 INFO - docopt == 0.6.1 18:58:00 INFO - functools32 == 3.2.3-2 18:58:00 INFO - jsonschema == 2.5.1 18:58:00 INFO - manifestparser == 1.1 18:58:00 INFO - mozInstall == 1.12 18:58:00 INFO - mozcrash == 0.17 18:58:00 INFO - mozdebug == 0.1 18:58:00 INFO - mozdevice == 0.48 18:58:00 INFO - mozfile == 1.2 18:58:00 INFO - mozhttpd == 0.7 18:58:00 INFO - mozinfo == 0.9 18:58:00 INFO - mozleak == 0.1 18:58:00 INFO - mozlog == 3.4 18:58:00 INFO - moznetwork == 0.27 18:58:00 INFO - mozprocess == 0.23 18:58:00 INFO - mozprofile == 0.28 18:58:00 INFO - mozrunner == 6.12 18:58:00 INFO - mozscreenshot == 0.1 18:58:00 INFO - mozsystemmonitor == 0.3 18:58:00 INFO - moztest == 0.7 18:58:00 INFO - mozversion == 1.4 18:58:00 INFO - psutil == 3.1.1 18:58:00 INFO - requests == 1.2.3 18:58:00 INFO - wsgiref == 0.1.2 18:58:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:58:00 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')]} 18:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:00 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')]} 18:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:00 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 0x108c30490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c3db4f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a44d30>, '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 0x10886adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a3cb20>, '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.3hKCuEJ59B/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.j7P4TenLOf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:58:00 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 18:58:00 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 18:58:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hKCuEJ59B/Render', 18:58:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:00 INFO - 'HOME': '/Users/cltbld', 18:58:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:00 INFO - 'LOGNAME': 'cltbld', 18:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:00 INFO - 'MOZ_NO_REMOTE': '1', 18:58:00 INFO - 'NO_EM_RESTART': '1', 18:58:00 INFO - 'PAGER': '/bin/cat', 18:58:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:00 INFO - 'PWD': '/builds/slave/test', 18:58:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:00 INFO - 'SHELL': '/bin/bash', 18:58:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j7P4TenLOf/Listeners', 18:58:00 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:58:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:00 INFO - 'USER': 'cltbld', 18:58:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:00 INFO - 'XPC_FLAGS': '0x0', 18:58:00 INFO - 'XPC_SERVICE_NAME': '0', 18:58:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:00 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)) 18:58:00 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)) 18:58:00 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)) 18:58:00 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)) 18:58:00 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)) 18:58:00 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)) 18:58:00 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)) 18:58:00 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)) 18:58:00 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)) 18:58:00 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)) 18:58:00 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)) 18:58:00 INFO - Cleaning up... 18:58:00 INFO - Return code: 0 18:58:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:58:00 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')]} 18:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:00 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')]} 18:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:00 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 0x108c30490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6c3db4f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a44d30>, '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 0x10886adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a3cb20>, '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.3hKCuEJ59B/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.j7P4TenLOf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 18:58:00 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 18:58:00 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 18:58:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hKCuEJ59B/Render', 18:58:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:00 INFO - 'HOME': '/Users/cltbld', 18:58:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:00 INFO - 'LOGNAME': 'cltbld', 18:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:00 INFO - 'MOZ_NO_REMOTE': '1', 18:58:00 INFO - 'NO_EM_RESTART': '1', 18:58:00 INFO - 'PAGER': '/bin/cat', 18:58:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:00 INFO - 'PWD': '/builds/slave/test', 18:58:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:00 INFO - 'SHELL': '/bin/bash', 18:58:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j7P4TenLOf/Listeners', 18:58:00 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:58:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:00 INFO - 'USER': 'cltbld', 18:58:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:00 INFO - 'XPC_FLAGS': '0x0', 18:58:00 INFO - 'XPC_SERVICE_NAME': '0', 18:58:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:58:01 INFO - Cleaning up... 18:58:01 INFO - Return code: 0 18:58:01 INFO - Running post-action listener: _resource_record_post_action 18:58:01 INFO - Running post-action listener: _start_resource_monitoring 18:58:01 INFO - Starting resource monitoring. 18:58:01 INFO - [mozharness: 2016-10-24 01:58:01.047471Z] Finished create-virtualenv step (success) 18:58:01 INFO - [mozharness: 2016-10-24 01:58:01.048443Z] Running install step. 18:58:01 INFO - Running pre-action listener: _resource_record_pre_action 18:58:01 INFO - Running main action method: install 18:58:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:58:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:58:01 INFO - Reading from file tmpfile_stdout 18:58:01 INFO - Detecting whether we're running mozinstall >=1.0... 18:58:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:58:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:58:01 INFO - Reading from file tmpfile_stdout 18:58:01 INFO - Output received: 18:58:01 INFO - Usage: mozinstall [options] installer 18:58:01 INFO - Options: 18:58:01 INFO - -h, --help show this help message and exit 18:58:01 INFO - -d DEST, --destination=DEST 18:58:01 INFO - Directory to install application into. [default: 18:58:01 INFO - "/builds/slave/test"] 18:58:01 INFO - --app=APP Application being installed. [default: firefox] 18:58:01 INFO - mkdir: /builds/slave/test/build/application 18:58:01 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'] 18:58:01 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 18:58:35 INFO - Reading from file tmpfile_stdout 18:58:35 INFO - Output received: 18:58:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:58:35 INFO - Running post-action listener: _resource_record_post_action 18:58:35 INFO - [mozharness: 2016-10-24 01:58:35.910346Z] Finished install step (success) 18:58:35 INFO - [mozharness: 2016-10-24 01:58:35.910474Z] Running run-tests step. 18:58:35 INFO - Running pre-action listener: _resource_record_pre_action 18:58:35 INFO - Running main action method: run_tests 18:58:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:58:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:58:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:58:35 INFO - 2016-10-23 18:58:35.924 screenresolution[1648:8436] starting screenresolution argv=screenresolution get 18:58:35 INFO - 2016-10-23 18:58:35.927 screenresolution[1648:8436] Display 0: 1600x1200x32@60 18:58:35 INFO - 2016-10-23 18:58:35.933 screenresolution[1649:8438] starting screenresolution argv=screenresolution list 18:58:35 INFO - Available Modes on Display 0 18:58:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:58:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:58:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:58:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:58:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:58:36 INFO - Intel Iris: 18:58:36 INFO - Chipset Model: Intel Iris 18:58:36 INFO - Type: GPU 18:58:36 INFO - Bus: Built-In 18:58:36 INFO - VRAM (Dynamic, Max): 1536 MB 18:58:36 INFO - Vendor: Intel (0x8086) 18:58:36 INFO - Device ID: 0x0a2e 18:58:36 INFO - Revision ID: 0x0009 18:58:36 INFO - Displays: 18:58:36 INFO - Display: 18:58:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:58:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:58:36 INFO - Display Serial Number: 1600x1200 60 18:58:36 INFO - Main Display: Yes 18:58:36 INFO - Mirror: Off 18:58:36 INFO - Online: Yes 18:58:36 INFO - Rotation: Supported 18:58:36 INFO - Return code: 0 18:58:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:58:36 INFO - Python 2.7.3 18:58:36 INFO - Return code: 0 18:58:36 INFO - grabbing minidump binary from tooltool 18:58: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')]} 18:58:36 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 0x108a44d30>, '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 0x10886adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a3cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:58:36 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 18:58:36 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 18:58:36 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 18:58:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:58:36 INFO - Return code: 0 18:58:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:58:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:58:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:58:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:58:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:58:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0340', '--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 18:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0340 --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 18:58:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hKCuEJ59B/Render', 18:58:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:36 INFO - 'HOME': '/Users/cltbld', 18:58:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:36 INFO - 'LOGNAME': 'cltbld', 18:58:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:58:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:36 INFO - 'MOZ_NO_REMOTE': '1', 18:58:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:58:36 INFO - 'NO_EM_RESTART': '1', 18:58:36 INFO - 'PAGER': '/bin/cat', 18:58:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:36 INFO - 'PWD': '/builds/slave/test', 18:58:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:58:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:36 INFO - 'SHELL': '/bin/bash', 18:58:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j7P4TenLOf/Listeners', 18:58:36 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 18:58:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:36 INFO - 'USER': 'cltbld', 18:58:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:36 INFO - 'XPC_FLAGS': '0x0', 18:58:36 INFO - 'XPC_SERVICE_NAME': '0', 18:58:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0340', '--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 18:58:36 INFO - mozversion application_buildid: 20161023170523 18:58:36 INFO - mozversion application_changeset: 215f9686117673a2c914ed207bc7da9bb8d741ad 18:58:36 INFO - mozversion application_display_name: Nightly 18:58:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:58:36 INFO - mozversion application_name: Firefox 18:58:36 INFO - mozversion application_remotingname: firefox 18:58:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:58:36 INFO - mozversion application_vendor: Mozilla 18:58:36 INFO - mozversion application_version: 52.0a1 18:58:36 INFO - mozversion platform_buildid: 20161023170523 18:58:36 INFO - mozversion platform_changeset: 215f9686117673a2c914ed207bc7da9bb8d741ad 18:58:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:58:36 INFO - mozversion platform_version: 52.0a1 18:58:36 INFO - using testdate: 1477274316 18:58:36 INFO - actual date: 1477274316 18:58:36 INFO - starting webserver on 'localhost:49267' 18:58:36 INFO - SUITE-START | Running 2 tests 18:58:36 INFO - TEST-START | dromaeo_css 18:58:36 INFO - operating with platform_type : mac_ 18:58:36 INFO - Initialising browser for dromaeo_css test... 18:58:36 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpDzCpkD/profile http://localhost:49267/getInfo.html) 18:58:38 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 18:58:38 INFO - PROCESS | 1659 | colorDepth:24 18:58:38 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 18:58:38 INFO - PROCESS | 1659 | __metrics 18:58:38 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:58:38 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:58:39 INFO - TEST-INFO | 1659: exit 0 18:58:39 INFO - Browser initialized. 18:58:39 INFO - Running cycle 1/1 for dromaeo_css test... 18:58:39 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpDzCpkD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:58:51 INFO - PROCESS | 1662 | RSS: Main: 231391232 18:58:51 INFO - PROCESS | 1662 | 18:59:43 INFO - PROCESS | 1662 | 1477274383256 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] 19:01:56 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 19:01:58 INFO - PROCESS | 1662 | RSS: Main: 410513408 19:01:58 INFO - PROCESS | 1662 | 19:05:01 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 19:05:02 INFO - PROCESS | 1662 | RSS: Main: 372232192 19:05:02 INFO - PROCESS | 1662 | 19:08:04 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 19:08:05 INFO - PROCESS | 1662 | RSS: Main: 340406272 19:08:05 INFO - PROCESS | 1662 | 19:11:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 19:11:08 INFO - PROCESS | 1662 | RSS: Main: 336855040 19:11:08 INFO - PROCESS | 1662 | 19:14:11 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 19:14:12 INFO - PROCESS | 1662 | RSS: Main: 333664256 19:14:12 INFO - PROCESS | 1662 | 19:17:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 19:17:15 INFO - PROCESS | 1662 | RSS: Main: 479211520 19:17:15 INFO - PROCESS | 1662 | 19:17:15 INFO - PROCESS | 1662 | __start_tp_report 19:17:15 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 19:17:15 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 19:17:15 INFO - PROCESS | 1662 | |i|pagename|runs| 19:17:15 INFO - PROCESS | 1662 | |0;dojo.html;2947.46945549801;3278.393497203016;3280.0979730574095;3314.270860410709;3328.983355083224;5453.836384908449;5458.617896747224;5502.147167189082;5514.117741161415;5565.0817615093465;5549.916751248735;5592.412796656354;5674.489295963363;5681.119426488901;5691.08942569189;5042.067217564744;5055.140626093573;5062.519060689228;5105.897882042375;5148.974255128719;4553.544645535453;5114.539691427771;5130.333056702642;5261.105612045962;5261.526462618363;5247.580193584542;5254.343207099113;5265.315508983846;5267.078261304276;5314.654547454403;5076.162433198555;5141.408737995141;5147.897042059175;5172.379314482248;5174.197999310075;5109.105906466353;5141.203113517411;5144.485551444863;5155.7679904404395;5165.199394093921;5580.748866301026;5605.159226116074;5624.690642014688;5627.127795191752;5628.127640215773;6096.786359395769;6111.7436766921655;6136.01823708209;6139.416755408229;6140.600860944069;6097.97841994295;6131.724072416752;6134.559047376655;6143.54563505925;6149.446549810538;5679.460451257124;5750.482456578886;5774.566907481955;5779.653220806765;5785.797497087624;6120.538559592075;6195.132681424604;6195.535334849904;6200.844978875564;6212.099245609361;5974;6010.338862725097;6027.457528822427;6031.276246850406;6101.298350689727;6137.39578054044;6172.814815555541;6181.96909015452;6202.41077097675;6202.627842329474;6115.785947491817;6122.7550897964475;6129.172561704113;6129.662868542273;6148.1085242640465;6030;6105.732692890381;6112.235970503687;6112.816615501542;6127.955868343207;4827.589654879304;4910.238912968495;4910.533499317559;4910.533499317559;4914.680545764585;4422.933655995163;4450.910981780346;4456.442944631921;4459.375687403766;4464.821407143743;5569.749361278752;5656.547476201894;5675.2054712340305;5675.914861277084;5677.489025987681;6125.47964319526;6144.586745048664;6145.446909778052;6146.463384153962;6149.600275982047;5623.943760562423;5654.85862853432;5657.094864821609;5665.348484924204;5670.659760414388;5313.973430132902;5315.707636080053;5327.0145023170835;5332.33345831771;5374.91937620936;6215.160953271341;6216.44052035319;6244.562880598405;6249.593776404519;6250.6874656267;6110.236220472441;6120.08198770188;6131.713108457373;6148.385161483816;6187.81436556904;6137.0399217141685;6162.938370616236;6191.133241346125;6199.070139479114;6205.906911396423;5102.4642412546145;6076.878462430638;6102.812976549295;6105.951237954871;6115.235595550556;5887.911681324869;5994.88010239784;6162.476189523941;6171.105189747551;6175.475084617858;5074.137396642654;5824.679642619527;5975.760969561169;5993.430624090704;6045.032794752994;6050.062240352752;6055.969720151371;6057.909131363122;6064.514838812796;6093.421124993119;5823.7379317929945;5836.533077353716;5870.236869207147;5888.263967004124;5888.646681199141;4949.331840201527;5882.558808089325;5951.256092988377;5963.880722385441;6028.306744724413;4904.828331008398;5882.352941176553;5892.7642894283745;5936.28764548257;5944.791932282523 19:17:15 INFO - PROCESS | 1662 | |1;ext.html;489.7820469890899;491.6460148692941;522.1906045629273;528.5032069854336;531.4419859147894;24716;33926.66073339266;39840;40530;42424.515141970034;42023.78988105055;42217;42460;42517.937051573725;42575.36136957948;9382.202512786404;9553.952230238874;9563.282753793459;9566.808663826754;9575.856362154573;9319.860202096974;9424.858627120599;9425.387349822275;9435;9437.433753974748;9349.953250233773;9416.952915235413;9424.293178011641;9430.669926552571;9437.528123593827;8104.473209241381;9382.343235973485;9399.57701903416;9425.057494250623;9439.24486041122;9358.157765801043;9446.244300455946;9454.290928180346;9460.763480912963;9461.432314061109;40166.397504037464;40460.59539404598;40470.59529404698;40507.18985620271;40571.59428405708;3032.666406695284;3513.0690367052753;3569.446735755962;3819.5034645495907;4072.6334629883454;29713.702862971524;30853.691463085306;30901;30936;31050;3129.702678245563;3253.7722359434847;3283.7865538740143;3321.750868684834;3330.2506935939464;460135;461601;461638;462298;466947;56471;56600.58498537487;57149;57255.71372143113;57514.42485575174;60362.69818650967;60448.697756510934;60558;60567.69716151391;60693.69653151794;15668.216589170495;15902.92048539773;15933.521994340188;15950;16018.519444416686;12466.688332791753;12534.874651253553;12535.561255356019;12542.498300068077;12549.372531373578;14808.555743327717;15347.923260383626;15361.308741106677;15402.614934626725;15576.766348504781;5850.239468869105;6746.291639377893;6790.626515541692;6801.4558835293055;6963.582185068912;879.305348774461;936.9109934556207;955.8040601676639;958.3277181318505;1060.4591658254346;24927.750722492907;29461.705382946326;29522.704772952424;29969.400611988076;30464;870.4081224767219;1029.7425643589104;1053.5048527192362;1060.4379678770265;1094.2996482251365;14791.260436978107;15186;15208.315625796866;15346.782094088063;15561;583187;586712;587748;589567;589735;55808.441915581134;55821;55860.44139558553;55873;55946.720266398406;1099.7580532283046;1207.6799648093263;1257.1137348169336;1360.8979326550548;1378.207530669869;25056.24831255065;30689.53965690561;31652;31920.88276910297;32717.509237360984;51241.48758512516;51779.482205178974;51811.74094129656;51844.481555183964;51888.48111518836;521097;525088.3710233126;525688;526538;527972;37753;37985.62014379821;38760.80619596997;39096.609033910434;39207;46575;46689.76655116703;47171.82070448266;47206;48326.5167348322;34365.96902092941;38849.44602215993;39098.41352379773;39128.2174356517;39976.40035399413;36476;38297.808510957264;38879.6112038876;39917.600823991386;40217.79891100526;32050;32561.674383255864;32617.673823262412;37528.62471375251;37968.01335859695;31213.8439307802;32710;34087.65912340845;34475.4828677565;34716.47925281072;23061.846907654213;24260.544367338018;25393.619095713948;25772.61341079923;26217.213483595522 19:17:15 INFO - PROCESS | 1662 | |2;jquery.html;371.7695029081968;374.3150035435154;375.5493407910508;390.47481137869556;398.2135282816438;14569.715142428786;15032.398704051824;19294.51763705908;21082.57834843302;21213.075581017503;18967.430977070675;20087.698684519743;20706.378808635727;20754.7169811321;21219.151233950663;5724.7137643117885;6015.578909476339;6019.097135429699;6023.126646636235;6025.698715064251;4058.5129784425762;4283.121959998193;5836.854078648046;5982.521398288127;6209.87580248397;6378.904316435257;6558.11465452165;6562.343765623424;6583.275839657634;6596.901046484307;6244.937550624481;6482.416582507573;6543.541952063358;6556.508261880331;6556.93443065568;5428.972855135699;5563.610547261694;5673.716314184274;5680.971595142039;5687.630304030266;25392.49215015708;25434.36414089644;25477.8534965927;25683.871580642164;25778.484430311477;1931.2661188748327;2346.4485845826216;2349.9530009399887;2590.0546300600145;2632.2366513711;14887.255637218095;15062.32219550112;15139.924300378427;15856.127912964783;15993.680126397523;1721.173836558459;1837.4395809278165;1839.5217243516647;1867.5891303913118;1869.8223668751448;84014;107222.46388768085;110756;118979.4051029748;119151;8280.461769984931;10135.7466063349;10277.126444252173;10552.947235263775;10791;12922.9353853232;13320.267385293902;13361;13365.198088114745;13372.398242079129;7875.803104922308;8110.716124935717;8143.226393492609;8260.297874680598;8288.875666865002;8007.07918589358;8021.5187088774865;8028.394321135796;8198.344132469389;8214.917850821535;6344.238691356974;6404.1674582304;6456.7740129095255;6511.797520253918;6538.221255966196;1685.6207353345399;1726.2318268370454;1778.2086971297906;1803.8105998870192;1823.4803081121815;867.2931560777946;888.1961824548794;894.3203165594196;947.6683160893632;1003.663772636175;21225.787742122382;21989.471210810643;21990.340289791333;22029.66955495669;22133.446663833212;948.3788118782209;957.9568919398644;977.9755506112405;1031.3090229546222;1067.5409573883148;10782.921707829311;11769.470373833197;11826.467808948619;11882.821757673642;11898.940505297418;521327.39336303074;532381;534426;543004;544911;103743;109659.25851853768;110231;110538.44730776295;112211;960.5053397500433;968.2350942755286;997.3866072365588;998.1465846701111;998.9910190707437;19212.519687007938;19516.121774519896;19573.804261957197;19590.804091958897;19724.50688732793;45057.324140137265;48469.75765121293;50853.237201442746;51596.48403515917;52295;66055.66972165108;70627.64686176536;72985.9052114208;74194;77120.6143969299;7766.184550622329;7980.8802867955865;8146.185381462044;8185.836283274421;8224.753257402288;6809.148856392951;10082.890882003121;10291.794164116825;12647.494100235888;13213.735725285633;10914.29057111317;10939.507722152362;11430.14273929442;11478.966892979672;11519.539218431504;10973.286736362112;11017.779644406906;11167.801869961924;11225.045871101049;11356.659300221007;11103.444827758742;11446.771064578828;11453.770924581295;11501.309921404743;11550.711232219262;6974.546654467444;7300.525465844703;7956.323712484272;8125.4490300949665;8308.459950103224;10093.444860532742;11022;11379.54481820718;11421.885781142082;11578.247413918069 19:17:15 INFO - PROCESS | 1662 | |3;mootools.html;1391.318254055513;1453.2080016391067;1548.0247444110212;1780.4302623160586;1969.8128677775615;7840.137584865667;8325.209105135018;8676.266975902594;8899.510526921016;8909.97535283441;8713.564321783917;8811.206991370775;8828;8828.07305232951;8845.867311990325;2307.9538409231805;2322.3729593009875;2325.988370058156;2333.4049817296564;2337.100216416675;2260.468789834396;2284.1776960294283;2308.976910230893;2310.584094862924;2312.9653055204185;2284.748677645466;2307.90768369265;2316.525112351964;2320.234322673514;2325.5232677301115;2081.458820706612;2201.801837834603;2290.141197051106;2296.3799774061076;2302.689136966513;2286.6112760830697;2286.668433077211;2292.1289909834322;2297.3911913342977;2300.2409204962323;7399.70401183952;8785.209331160162;8824.338174636863;8842.778930526723;8864.024957254696;5144.4083930348115;5312.973435132838;5338.386085600167;5364.356277246756;5370.543503802142;3437.9656203438144;3583.014670965479;3655.3968595181764;3656.7074634029213;3657.1040095176586;1030.5568605499632;1064.542246833861;1065.275612583443;1081.691717860414;1084.2139448899484;10854.185936054748;10986.176036797273;11069.889301107047;11105.167112466597;11152.832707509393;4179.853705120307;4343.370211319341;4421.137878113737;4443.37792709021;4447.3329000650165;8747.475151490931;8763.649454021896;8778.034416214212;8786.989496208018;8793.736187914245;5056.317397151338;5057.089723849669;5060.316857224301;5064.18972964324;5066.417362003417;4087.6321131097748;4375.16871794358;4441.378207051015;4537.137943790735;4733.242681171065;3661.761985470936;3703.4444833275224;3704.5739739930254;3759.642833930772;3761.6426439488205;950.7813202963357;988.1995583577325;1100.9064229540418;1105.0441368216595;1105.4086063955745;831.3930830493653;857.3055824781947;875.1729615513278;912.2838571721167;951.0990587979104;5287.709175995357;5384.461553844584;5941.168236446901;6088.360722124113;6092.055731361646;829.3365307753772;880.4189235104928;885.6811547842772;961.6057416459219;974.7270764185897;3384.323135372935;3839.1937693084765;3911.5501717302304;3986.0433495961342;4086.7547947123267;10406.219533535015;10647.73380665474;10763.300385474919;10784.08335291509;10797.136229101652;10772.569097236179;10791.568337266579;10812.783744325227;10821.458927053616;10847.077998370227;7800.336971357498;8006.599670016476;8142.063662678867;8163;8210.30212431938;5893.145493903275;6079.088136779342;6092.299385570539;6146.446819786241;6153.507719382528;9501.382410143318;9570.712878613653;9957.402555846673;10028.047335503115;10037.44794036335;9827.606895724091;10079.143272821892;10240.18078553699;10252.43611601369;10256.743581410525;7348.559086454616;7470.215627359049;7515.09818821723;8289.295409889986;8295.875561866456;8403.285720713808;8435.662573496991;8516.74449766508;8519.8722019171;8520.914790852261;7341.229170936975;7413.777586672409;7448.553086814808;7528.284812942762;7549.0935989643285;7275.272472752682;7286.453515986216;7335.7432489862595;7336.229695881855;7429.14564825052;6865.519413640997;6975.267596902252;6991.650417479207;7003.369696727115;7007.719691212498;4906.3376444181;4943;5006.62450316235;5041.873953151201;5207.29701490294;4435.556444355539;4633.467151277646;5005.249212618136;5042;5081.364829396325 19:17:15 INFO - PROCESS | 1662 | |4;prototype.html;285.4234446418235;292.3145224448668;293.8912602337136;305.7294294549323;306.8481101854582;4250.596193361634;4727.014653845385;5255.737213139342;5258.973705131469;5282.313299271094;4204.5375008749015;4327.918020494876;4447.666425018128;4947.307376967227;5272.578193744501;3525.0834782956485;3561.8397172127316;3927.7054220933546;4013.6989725770536;4037.454943582608;3468.618451970281;3709.462127991453;4053.6351728344443;4060.634542891139;4070.3894415837713;3080.3069309405428;3486.9016259878185;3684.907877303062;3752.924941501168;3801.752886062397;3799.6580307772156;3960.3069462843887;3968.3253846846105;4008.83964641414;4046.5953404659595;3147.1345380020675;3504.26410453805;3504.526888869995;3506.4740288956605;3517.66582174693;4849.539293767087;5173.534381905646;5174.534291913746;5184.377874655028;5191.636585439021;4184.644305234059;4461.241588929857;4515.209838278288;4526.510419269389;4563;4698.2851259290455;5382.869597384554;5466.972665136649;5489.451054894518;5546.86132846678;3204.9679503205134;3721.6278372162838;3766.39737641976;3774.5467994821915;3777.508923839883;4764.951710623657;5251.579873610141;5782.479576838105;5800.129980502916;5819.912701309484;3739.139997800521;3762.285165818486;3774.358359078963;3785.545734511876;3789.621037896188;3832.984259171266;3833.21419109082;3835.7506762060375;3836.4437156612694;3849.672777813861;4152.211079894871;4451.6199978006925;4481.215787237221;4484.260097084009;4519.593236608721;4732.337472753818;5027.2207807789855;5380.461953804666;5475.945240547623;5530.695811730394;1113.5267511307825;1208.468273959455;1320.5642138094406;1321.6497628128554;1322.6759443936296;741.3402072155785;769.0310209136417;783.8549868274388;847.7626264645909;855.341387131905;4498.707584007095;5107.131787596043;5226.5818734501145;5232.555232805178;5256.553192978639;5608.242887210256;5615.2700148980375;5618.887622247614;5662.292213473316;5693.975084484832;4948.282499037691;5139.58883289336;5200.505951934636;5211.817586384458;5316.229146773696;2614.516314481827;2897.47845387828;2935.473553752037;2967.5103607904452;2972.687867773896;5427;5523.834284971457;5876.500497457679;5890.381509941394;5903.76384944606;4450.865029417478;5402.91895621566;5522.536527820131;5720.570957178228;5789.218455508537;4968.6025117990475;5031.371078615173;5634.183043458757;5726.914096288642;5787.971060144672;5352.304200453916;5538.280023596906;5563.939833091702;5582.9720851397105;5604.243427137284;4971.936646291893;5645.887082258414;5662.292213473316;5666.716664166693;5688.203651488878;5904.940950590611;5905.498032667271;5946.640148316187;5951.315598706205;5954.851128721816;3695.2055308108884;3819.82954148062;3833.195029043932;3869.458275841441;3871.1870507193803;5681;5681.17622944679;5703.315602127771;5708.543316534584;5867.740919745843;5235.136202526541;5547.5007249347755;5560.4161563035295;5567.693776842312;5603.411641777718;4264.701470897007;5242.921356179737;5259.868503287448;5297.841064768063;5605.617612514747;5101.474769988879;5439.48324909133;5447.3735520414075;5452.700101494297;5455.536279416294;4862.4651288357545;5025.321581586585;5474.863128421821;5487;5529.336479622471;5014.448410674896;5422.13245880673;5514.338279406497;5531.529819965187;5559.8888022240135 19:17:15 INFO - PROCESS | 1662 | |5;yui.html;724.8332883436809;725.6589402980599;784.5880912520926;809.8663720486119;820.3273315880973;15087.547373578784;15717.92141039296;15737.763933540977;15743.527694169165;15752.921235393822;14345.641358966031;14375.568732938029;14379.856201437982;14411.495597654084;14648.121112733217;691.4433880726014;710.9431245500348;714.4034730999596;864.7708357285325;878.9121087891208;874.1346067393298;884.8407286688393;885.0132102705502;886.2245535156737;886.352962337494;930.3812964378714;943.8725772020792;944.617429940875;945.7730144765276;946.1768261612373;937.4422218779815;938.2165891480622;939.671115109713;940.8165407745493;940.9059094090536;469.8872270655052;539.6384422436937;674.3189378727471;699.024860319851;700.8107810891031;14562.708745825024;15105;15124.395024199019;15138.621534461727;15140.167290799001;13283.136596121221;13704.177749335071;13724.039317247796;13830.23933683647;14029.719405611831;12122.515099396014;12249.326287054208;12318.568850090203;12376.443060062229;12874.87125128746;4209.0950445654025;4218.135282267128;4303.386230163688;4307.741535507879;4414.426124603813;111691.44154279177;113394;113874;114030;114135;8796.47221166732;10382.844257336146;10738.78522429547;10817.729556761144;10979.341239525655;21192.258270960443;21479.248226312004;21532.13871445156;21543.46141346479;21554.784452155593;7198.568085914757;7506.737264195727;7635.160132385433;7783.29950304464;7804.47812676534;4341.891452713644;4381.7370957742;4421.270490369117;4509.1658043262105;4516.954830451719;3222.5810644616517;3572.91067723309;3694.722895782827;3737.8691745788765;3738.7475195809166;684.2780866186122;694.5901917868482;695.2144077192739;730.1931365840776;733.0397872203357;560.4619565217356;585.3093349847221;684;688.6737060000187;696.1854630082815;8259.906962859844;9136.451812891248;9687.66093186735;9847.901520984698;9861.901380986243;546.6282927609184;585.8125399872;589.3634874335708;593.0274350065895;611.3336463255073;4245.299525578245;4597.310403439444;4615.723056616614;4759.619230461555;4771;131338.34330828284;133295.3335233337;134092;135045.3247733755;139028.3048584771;99600.501997491;117290;118873;125672;127024;108206.37690434493;108503;108874.94688429651;109585.27465056366;111932;7870.842583148419;8179.936608240891;9141.954290228507;9188.989211186898;9367.718968430958;58032.41967580439;59423.514412140044;60143;60478.39521604904;60740;73002.63498682472;92326;92993.95539289924;94200;94406.58390124016;11495.885041149482;11787.351695656822;12115.697107572028;12138.696532586757;12329.198602090835;13172.275524846225;13241.404136813673;13424.308315213395;13567.457301707822;13907.930460347634;12165.878341216474;12242.081843861924;12368.814467782811;12508.061895357703;12864.678383040124;11844.466998984894;12137.939310303393;12427.875721243034;12462;12822.87177128254;11717.414129293331;11946.163768536118;12173.147879648339;12220.961218296545;12715.872841271468;8434.915650843413;9850.556724947537;9913.900860991298;10689.465526723789;10697.893021070002;7771.805704857424;9364.859527107235;9387.765305867408;9436.95281523588;9721.9027809721 19:17:15 INFO - PROCESS | 1662 | __end_tp_report 19:17:15 INFO - PROCESS | 1662 | __start_cc_report 19:17:15 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1816 19:17:15 INFO - PROCESS | 1662 | __end_cc_report 19:17:15 INFO - PROCESS | 1662 | __startTimestamp1477275435810__endTimestamp 19:17:15 INFO - PROCESS | 1662 | 19:17:15 INFO - PROCESS | 1662 | ------- Summary: start ------- 19:17:15 INFO - PROCESS | 1662 | Number of tests: 6 19:17:15 INFO - PROCESS | 1662 | 19:17:15 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5640.83 Median:5870.24 stddev:635.90 (10.8%) stddev-sans-first:601.72 19:17:15 INFO - PROCESS | 1662 | Values: 2947.5 3278.4 3280.1 3314.3 3329.0 5453.8 5458.6 5502.1 5514.1 5565.1 5549.9 5592.4 5674.5 5681.1 5691.1 5042.1 5055.1 5062.5 5105.9 5149.0 4553.5 5114.5 5130.3 5261.1 5261.5 5247.6 5254.3 5265.3 5267.1 5314.7 5076.2 5141.4 5147.9 5172.4 5174.2 5109.1 5141.2 5144.5 5155.8 5165.2 5580.7 5605.2 5624.7 5627.1 5628.1 6096.8 6111.7 6136.0 6139.4 6140.6 6098.0 6131.7 6134.6 6143.5 6149.4 5679.5 5750.5 5774.6 5779.7 5785.8 6120.5 6195.1 6195.5 6200.8 6212.1 5974.0 6010.3 6027.5 6031.3 6101.3 6137.4 6172.8 6182.0 6202.4 6202.6 6115.8 6122.8 6129.2 6129.7 6148.1 6030.0 6105.7 6112.2 6112.8 6128.0 4827.6 4910.2 4910.5 4910.5 4914.7 4422.9 4450.9 4456.4 4459.4 4464.8 5569.7 5656.5 5675.2 5675.9 5677.5 6125.5 6144.6 6145.4 6146.5 6149.6 5623.9 5654.9 5657.1 5665.3 5670.7 5314.0 5315.7 5327.0 5332.3 5374.9 6215.2 6216.4 6244.6 6249.6 6250.7 6110.2 6120.1 6131.7 6148.4 6187.8 6137.0 6162.9 6191.1 6199.1 6205.9 5102.5 6076.9 6102.8 6106.0 6115.2 5887.9 5994.9 6162.5 6171.1 6175.5 5074.1 5824.7 5975.8 5993.4 6045.0 6050.1 6056.0 6057.9 6064.5 6093.4 5823.7 5836.5 5870.2 5888.3 5888.6 4949.3 5882.6 5951.3 5963.9 6028.3 4904.8 5882.4 5892.8 5936.3 5944.8 19:17:15 INFO - PROCESS | 1662 | 19:17:15 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:66338.45 Median:40518.59 stddev:140597.83 (347.0%) stddev-sans-first:140905.32 19:17:15 INFO - PROCESS | 1662 | Values: 489.8 491.6 522.2 528.5 531.4 24716.0 33926.7 39840.0 40530.0 42424.5 42023.8 42217.0 42460.0 42517.9 42575.4 9382.2 9554.0 9563.3 9566.8 9575.9 9319.9 9424.9 9425.4 9435.0 9437.4 9350.0 9417.0 9424.3 9430.7 9437.5 8104.5 9382.3 9399.6 9425.1 9439.2 9358.2 9446.2 9454.3 9460.8 9461.4 40166.4 40460.6 40470.6 40507.2 40571.6 3032.7 3513.1 3569.4 3819.5 4072.6 29713.7 30853.7 30901.0 30936.0 31050.0 3129.7 3253.8 3283.8 3321.8 3330.3 460135.0 461601.0 461638.0 462298.0 466947.0 56471.0 56600.6 57149.0 57255.7 57514.4 60362.7 60448.7 60558.0 60567.7 60693.7 15668.2 15902.9 15933.5 15950.0 16018.5 12466.7 12534.9 12535.6 12542.5 12549.4 14808.6 15347.9 15361.3 15402.6 15576.8 5850.2 6746.3 6790.6 6801.5 6963.6 879.3 936.9 955.8 958.3 1060.5 24927.8 29461.7 29522.7 29969.4 30464.0 870.4 1029.7 1053.5 1060.4 1094.3 14791.3 15186.0 15208.3 15346.8 15561.0 583187.0 586712.0 587748.0 589567.0 589735.0 55808.4 55821.0 55860.4 55873.0 55946.7 1099.8 1207.7 1257.1 1360.9 1378.2 25056.2 30689.5 31652.0 31920.9 32717.5 51241.5 51779.5 51811.7 51844.5 51888.5 521097.0 525088.4 525688.0 526538.0 527972.0 37753.0 37985.6 38760.8 39096.6 39207.0 46575.0 46689.8 47171.8 47206.0 48326.5 34366.0 38849.4 39098.4 39128.2 39976.4 36476.0 38297.8 38879.6 39917.6 40217.8 32050.0 32561.7 32617.7 37528.6 37968.0 31213.8 32710.0 34087.7 34475.5 34716.5 23061.8 24260.5 25393.6 25772.6 26217.2 19:17:15 INFO - PROCESS | 1662 | 19:17:15 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:32313.68 Median:25580.86 stddev:89137.43 (348.5%) stddev-sans-first:89355.22 19:17:15 INFO - PROCESS | 1662 | Values: 371.8 374.3 375.5 390.5 398.2 14569.7 15032.4 19294.5 21082.6 21213.1 18967.4 20087.7 20706.4 20754.7 21219.2 5724.7 6015.6 6019.1 6023.1 6025.7 4058.5 4283.1 5836.9 5982.5 6209.9 6378.9 6558.1 6562.3 6583.3 6596.9 6244.9 6482.4 6543.5 6556.5 6556.9 5429.0 5563.6 5673.7 5681.0 5687.6 25392.5 25434.4 25477.9 25683.9 25778.5 1931.3 2346.4 2350.0 2590.1 2632.2 14887.3 15062.3 15139.9 15856.1 15993.7 1721.2 1837.4 1839.5 1867.6 1869.8 84014.0 107222.5 110756.0 118979.4 119151.0 8280.5 10135.7 10277.1 10552.9 10791.0 12922.9 13320.3 13361.0 13365.2 13372.4 7875.8 8110.7 8143.2 8260.3 8288.9 8007.1 8021.5 8028.4 8198.3 8214.9 6344.2 6404.2 6456.8 6511.8 6538.2 1685.6 1726.2 1778.2 1803.8 1823.5 867.3 888.2 894.3 947.7 1003.7 21225.8 21989.5 21990.3 22029.7 22133.4 948.4 958.0 978.0 1031.3 1067.5 10782.9 11769.5 11826.5 11882.8 11898.9 521327.4 532381.0 534426.0 543004.0 544911.0 103743.0 109659.3 110231.0 110538.4 112211.0 960.5 968.2 997.4 998.1 999.0 19212.5 19516.1 19573.8 19590.8 19724.5 45057.3 48469.8 50853.2 51596.5 52295.0 66055.7 70627.6 72985.9 74194.0 77120.6 7766.2 7980.9 8146.2 8185.8 8224.8 6809.1 10082.9 10291.8 12647.5 13213.7 10914.3 10939.5 11430.1 11479.0 11519.5 10973.3 11017.8 11167.8 11225.0 11356.7 11103.4 11446.8 11453.8 11501.3 11550.7 6974.5 7300.5 7956.3 8125.4 8308.5 10093.4 11022.0 11379.5 11421.9 11578.2 19:17:15 INFO - PROCESS | 1662 | 19:17:15 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5617.33 Median:5041.94 stddev:3162.89 (62.7%) stddev-sans-first:3155.81 19:17:15 INFO - PROCESS | 1662 | Values: 1391.3 1453.2 1548.0 1780.4 1969.8 7840.1 8325.2 8676.3 8899.5 8910.0 8713.6 8811.2 8828.0 8828.1 8845.9 2308.0 2322.4 2326.0 2333.4 2337.1 2260.5 2284.2 2309.0 2310.6 2313.0 2284.7 2307.9 2316.5 2320.2 2325.5 2081.5 2201.8 2290.1 2296.4 2302.7 2286.6 2286.7 2292.1 2297.4 2300.2 7399.7 8785.2 8824.3 8842.8 8864.0 5144.4 5313.0 5338.4 5364.4 5370.5 3438.0 3583.0 3655.4 3656.7 3657.1 1030.6 1064.5 1065.3 1081.7 1084.2 10854.2 10986.2 11069.9 11105.2 11152.8 4179.9 4343.4 4421.1 4443.4 4447.3 8747.5 8763.6 8778.0 8787.0 8793.7 5056.3 5057.1 5060.3 5064.2 5066.4 4087.6 4375.2 4441.4 4537.1 4733.2 3661.8 3703.4 3704.6 3759.6 3761.6 950.8 988.2 1100.9 1105.0 1105.4 831.4 857.3 875.2 912.3 951.1 5287.7 5384.5 5941.2 6088.4 6092.1 829.3 880.4 885.7 961.6 974.7 3384.3 3839.2 3911.6 3986.0 4086.8 10406.2 10647.7 10763.3 10784.1 10797.1 10772.6 10791.6 10812.8 10821.5 10847.1 7800.3 8006.6 8142.1 8163.0 8210.3 5893.1 6079.1 6092.3 6146.4 6153.5 9501.4 9570.7 9957.4 10028.0 10037.4 9827.6 10079.1 10240.2 10252.4 10256.7 7348.6 7470.2 7515.1 8289.3 8295.9 8403.3 8435.7 8516.7 8519.9 8520.9 7341.2 7413.8 7448.6 7528.3 7549.1 7275.3 7286.5 7335.7 7336.2 7429.1 6865.5 6975.3 6991.7 7003.4 7007.7 4906.3 4943.0 5006.6 5041.9 5207.3 4435.6 4633.5 5005.2 5042.0 5081.4 19:17:15 INFO - PROCESS | 1662 | 19:17:15 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4454.69 Median:5066.42 stddev:1388.43 (27.4%) stddev-sans-first:1356.60 19:17:15 INFO - PROCESS | 1662 | Values: 285.4 292.3 293.9 305.7 306.8 4250.6 4727.0 5255.7 5259.0 5282.3 4204.5 4327.9 4447.7 4947.3 5272.6 3525.1 3561.8 3927.7 4013.7 4037.5 3468.6 3709.5 4053.6 4060.6 4070.4 3080.3 3486.9 3684.9 3752.9 3801.8 3799.7 3960.3 3968.3 4008.8 4046.6 3147.1 3504.3 3504.5 3506.5 3517.7 4849.5 5173.5 5174.5 5184.4 5191.6 4184.6 4461.2 4515.2 4526.5 4563.0 4698.3 5382.9 5467.0 5489.5 5546.9 3205.0 3721.6 3766.4 3774.5 3777.5 4765.0 5251.6 5782.5 5800.1 5819.9 3739.1 3762.3 3774.4 3785.5 3789.6 3833.0 3833.2 3835.8 3836.4 3849.7 4152.2 4451.6 4481.2 4484.3 4519.6 4732.3 5027.2 5380.5 5475.9 5530.7 1113.5 1208.5 1320.6 1321.6 1322.7 741.3 769.0 783.9 847.8 855.3 4498.7 5107.1 5226.6 5232.6 5256.6 5608.2 5615.3 5618.9 5662.3 5694.0 4948.3 5139.6 5200.5 5211.8 5316.2 2614.5 2897.5 2935.5 2967.5 2972.7 5427.0 5523.8 5876.5 5890.4 5903.8 4450.9 5402.9 5522.5 5720.6 5789.2 4968.6 5031.4 5634.2 5726.9 5788.0 5352.3 5538.3 5563.9 5583.0 5604.2 4971.9 5645.9 5662.3 5666.7 5688.2 5904.9 5905.5 5946.6 5951.3 5954.9 3695.2 3819.8 3833.2 3869.5 3871.2 5681.0 5681.2 5703.3 5708.5 5867.7 5235.1 5547.5 5560.4 5567.7 5603.4 4264.7 5242.9 5259.9 5297.8 5605.6 5101.5 5439.5 5447.4 5452.7 5455.5 4862.5 5025.3 5474.9 5487.0 5529.3 5014.4 5422.1 5514.3 5531.5 5559.9 19:17:15 INFO - PROCESS | 1662 | 19:17:15 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:23835.91 Median:4361.81 stddev:37716.75 (864.7%) stddev-sans-first:37782.63 19:17:15 INFO - PROCESS | 1662 | Values: 724.8 725.7 784.6 809.9 820.3 15087.5 15717.9 15737.8 15743.5 15752.9 14345.6 14375.6 14379.9 14411.5 14648.1 691.4 710.9 714.4 864.8 878.9 874.1 884.8 885.0 886.2 886.4 930.4 943.9 944.6 945.8 946.2 937.4 938.2 939.7 940.8 940.9 469.9 539.6 674.3 699.0 700.8 14562.7 15105.0 15124.4 15138.6 15140.2 13283.1 13704.2 13724.0 13830.2 14029.7 12122.5 12249.3 12318.6 12376.4 12874.9 4209.1 4218.1 4303.4 4307.7 4414.4 111691.4 113394.0 113874.0 114030.0 114135.0 8796.5 10382.8 10738.8 10817.7 10979.3 21192.3 21479.2 21532.1 21543.5 21554.8 7198.6 7506.7 7635.2 7783.3 7804.5 4341.9 4381.7 4421.3 4509.2 4517.0 3222.6 3572.9 3694.7 3737.9 3738.7 684.3 694.6 695.2 730.2 733.0 560.5 585.3 684.0 688.7 696.2 8259.9 9136.5 9687.7 9847.9 9861.9 546.6 585.8 589.4 593.0 611.3 4245.3 4597.3 4615.7 4759.6 4771.0 131338.3 133295.3 134092.0 135045.3 139028.3 99600.5 117290.0 118873.0 125672.0 127024.0 108206.4 108503.0 108874.9 109585.3 111932.0 7870.8 8179.9 9142.0 9189.0 9367.7 58032.4 59423.5 60143.0 60478.4 60740.0 73002.6 92326.0 92994.0 94200.0 94406.6 11495.9 11787.4 12115.7 12138.7 12329.2 13172.3 13241.4 13424.3 13567.5 13907.9 12165.9 12242.1 12368.8 12508.1 12864.7 11844.5 12137.9 12427.9 12462.0 12822.9 11717.4 11946.2 12173.1 12221.0 12715.9 8434.9 9850.6 9913.9 10689.5 10697.9 7771.8 9364.9 9387.8 9437.0 9721.9 19:17:15 INFO - PROCESS | 1662 | -------- Summary: end -------- 19:17:15 INFO - PROCESS | 1662 | 19:17:16 INFO - TEST-INFO | 1662: exit 0 19:17:16 INFO - TEST-OK | dromaeo_css | took 1119928ms 19:17:16 INFO - TEST-START | kraken 19:17:16 INFO - operating with platform_type : mac_ 19:17:16 INFO - Initialising browser for kraken test... 19:17:16 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmp5w1n5R/profile http://localhost:49267/getInfo.html) 19:17:18 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 19:17:18 INFO - PROCESS | 1669 | colorDepth:24 19:17:18 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 19:17:18 INFO - PROCESS | 1669 | __metrics 19:17:18 INFO - PROCESS | 1669 | 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" 19:17:18 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:17:19 INFO - TEST-INFO | 1669: exit 0 19:17:19 INFO - Browser initialized. 19:17:19 INFO - Running cycle 1/1 for kraken test... 19:17:19 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmp5w1n5R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:17:31 INFO - PROCESS | 1670 | RSS: Main: 231919616 19:17:31 INFO - PROCESS | 1670 | 19:17:34 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 19:17:35 INFO - PROCESS | 1670 | RSS: Main: 290783232 19:17:35 INFO - PROCESS | 1670 | 19:17:38 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 19:17:38 INFO - PROCESS | 1670 | RSS: Main: 291680256 19:17:38 INFO - PROCESS | 1670 | 19:17:42 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 19:17:42 INFO - PROCESS | 1670 | RSS: Main: 382455808 19:17:42 INFO - PROCESS | 1670 | 19:17:44 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 19:17:45 INFO - PROCESS | 1670 | RSS: Main: 284200960 19:17:45 INFO - PROCESS | 1670 | 19:17:47 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:17:48 INFO - PROCESS | 1670 | RSS: Main: 288075776 19:17:48 INFO - PROCESS | 1670 | 19:17:50 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 19:17:51 INFO - PROCESS | 1670 | RSS: Main: 326369280 19:17:51 INFO - PROCESS | 1670 | 19:17:54 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 19:17:54 INFO - PROCESS | 1670 | RSS: Main: 328658944 19:17:54 INFO - PROCESS | 1670 | 19:17:57 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 19:17:58 INFO - PROCESS | 1670 | RSS: Main: 327004160 19:17:58 INFO - PROCESS | 1670 | 19:17:59 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:18:00 INFO - PROCESS | 1670 | RSS: Main: 302936064 19:18:00 INFO - PROCESS | 1670 | 19:18:02 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:18:02 INFO - PROCESS | 1670 | RSS: Main: 306401280 19:18:02 INFO - PROCESS | 1670 | 19:18:05 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:18:05 INFO - PROCESS | 1670 | RSS: Main: 313081856 19:18:05 INFO - PROCESS | 1670 | 19:18:08 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:18:09 INFO - PROCESS | 1670 | RSS: Main: 318181376 19:18:09 INFO - PROCESS | 1670 | 19:18:12 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:18:13 INFO - PROCESS | 1670 | RSS: Main: 318271488 19:18:13 INFO - PROCESS | 1670 | 19:18:14 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 19:18:15 INFO - PROCESS | 1670 | RSS: Main: 362348544 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - PROCESS | 1670 | __start_tp_report 19:18:15 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 19:18:15 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 19:18:15 INFO - PROCESS | 1670 | |i|pagename|runs| 19:18:15 INFO - PROCESS | 1670 | |0;ai-astar;143;99;160;168;166;113;116;114;113;114 19:18:15 INFO - PROCESS | 1670 | |1;audio-beat-detection;150;113;111;149;117;135;132;134;155;110 19:18:15 INFO - PROCESS | 1670 | |2;audio-dft;182;182;183;184;182;181;182;180;182;185 19:18:15 INFO - PROCESS | 1670 | |3;audio-fft;80;59;59;88;59;60;59;57;83;57 19:18:15 INFO - PROCESS | 1670 | |4;audio-oscillator;84;70;90;69;68;68;91;67;69;88 19:18:15 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;89;86;89;88;89;87;90;87;89;86 19:18:15 INFO - PROCESS | 1670 | |6;imaging-darkroom;93;97;96;96;95;95;95;95;96;95 19:18:15 INFO - PROCESS | 1670 | |7;imaging-desaturate;84;80;81;80;81;81;83;85;81;83 19:18:15 INFO - PROCESS | 1670 | |8;json-parse-financial;58;56;55;55;56;57;54;53;74;74 19:18:15 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;64;72;69;81;72;72;69;70;70;69 19:18:15 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;90;90;90;85;90;83;86;88;93;87 19:18:15 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;158;147;158;155;153;146;151;136;213;151 19:18:15 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;177;177;172;174;177;175;176;173;169;174 19:18:15 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;70;69;70;69;67;70;68;69;69;69 19:18:15 INFO - PROCESS | 1670 | __end_tp_report 19:18:15 INFO - PROCESS | 1670 | __start_cc_report 19:18:15 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,2013 19:18:15 INFO - PROCESS | 1670 | __end_cc_report 19:18:15 INFO - PROCESS | 1670 | __startTimestamp1477275495047__endTimestamp 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - PROCESS | 1670 | ------- Summary: start ------- 19:18:15 INFO - PROCESS | 1670 | Number of tests: 14 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:130.60 Median:151.50 stddev:25.93 (17.1%) stddev-sans-first:27.11 19:18:15 INFO - PROCESS | 1670 | Values: 143.0 99.0 160.0 168.0 166.0 113.0 116.0 114.0 113.0 114.0 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:130.60 Median:134.50 stddev:17.15 (12.7%) stddev-sans-first:16.69 19:18:15 INFO - PROCESS | 1670 | Values: 150.0 113.0 111.0 149.0 117.0 135.0 132.0 134.0 155.0 110.0 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:182.30 Median:182.00 stddev:1.42 (0.8%) stddev-sans-first:1.50 19:18:15 INFO - PROCESS | 1670 | Values: 182.0 182.0 183.0 184.0 182.0 181.0 182.0 180.0 182.0 185.0 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:66.10 Median:59.50 stddev:12.31 (20.7%) stddev-sans-first:11.98 19:18:15 INFO - PROCESS | 1670 | Values: 80.0 59.0 59.0 88.0 59.0 60.0 59.0 57.0 83.0 57.0 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:76.40 Median:77.00 stddev:10.38 (13.5%) stddev-sans-first:10.64 19:18:15 INFO - PROCESS | 1670 | Values: 84.0 70.0 90.0 69.0 68.0 68.0 91.0 67.0 69.0 88.0 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:89.00 stddev:1.41 (1.6%) stddev-sans-first:1.45 19:18:15 INFO - PROCESS | 1670 | Values: 89.0 86.0 89.0 88.0 89.0 87.0 90.0 87.0 89.0 86.0 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.50 stddev:1.06 (1.1%) stddev-sans-first:0.73 19:18:15 INFO - PROCESS | 1670 | Values: 93.0 97.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:81.90 Median:82.00 stddev:1.73 (2.1%) stddev-sans-first:1.66 19:18:15 INFO - PROCESS | 1670 | Values: 84.0 80.0 81.0 80.0 81.0 81.0 83.0 85.0 81.0 83.0 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:56.50 stddev:7.93 (14.0%) stddev-sans-first:8.40 19:18:15 INFO - PROCESS | 1670 | Values: 58.0 56.0 55.0 55.0 56.0 57.0 54.0 53.0 74.0 74.0 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.00 stddev:4.29 (6.0%) stddev-sans-first:3.78 19:18:15 INFO - PROCESS | 1670 | Values: 64.0 72.0 69.0 81.0 72.0 72.0 69.0 70.0 70.0 69.0 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:90.00 stddev:2.97 (3.3%) stddev-sans-first:3.08 19:18:15 INFO - PROCESS | 1670 | Values: 90.0 90.0 90.0 85.0 90.0 83.0 86.0 88.0 93.0 87.0 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:156.80 Median:154.00 stddev:20.79 (13.5%) stddev-sans-first:22.05 19:18:15 INFO - PROCESS | 1670 | Values: 158.0 147.0 158.0 155.0 153.0 146.0 151.0 136.0 213.0 151.0 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:175.50 stddev:2.59 (1.5%) stddev-sans-first:2.57 19:18:15 INFO - PROCESS | 1670 | Values: 177.0 177.0 172.0 174.0 177.0 175.0 176.0 173.0 169.0 174.0 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 19:18:15 INFO - PROCESS | 1670 | Values: 70.0 69.0 70.0 69.0 67.0 70.0 68.0 69.0 69.0 69.0 19:18:15 INFO - PROCESS | 1670 | -------- Summary: end -------- 19:18:15 INFO - PROCESS | 1670 | 19:18:15 INFO - TEST-INFO | 1670: exit 0 19:18:15 INFO - TEST-OK | kraken | took 59483ms 19:18:15 INFO - SUITE-END | took 1179s 19:18:16 INFO - Completed test suite (00:19:39) 19:18:16 INFO - javascript benchmark 19:18:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2947.46945549801, 3278.393497203016, 3280.0979730574095, 3314.270860410709, 3328.983355083224, 5453.836384908449, 5458.617896747224, 5502.147167189082, 5514.117741161415, 5565.0817615093465, 5549.916751248735, 5592.412796656354, 5674.489295963363, 5681.119426488901, 5691.08942569189, 5042.067217564744, 5055.140626093573, 5062.519060689228, 5105.897882042375, 5148.974255128719, 4553.544645535453, 5114.539691427771, 5130.333056702642, 5261.105612045962, 5261.526462618363, 5247.580193584542, 5254.343207099113, 5265.315508983846, 5267.078261304276, 5314.654547454403, 5076.162433198555, 5141.408737995141, 5147.897042059175, 5172.379314482248, 5174.197999310075, 5109.105906466353, 5141.203113517411, 5144.485551444863, 5155.7679904404395, 5165.199394093921, 5580.748866301026, 5605.159226116074, 5624.690642014688, 5627.127795191752, 5628.127640215773, 6096.786359395769, 6111.7436766921655, 6136.01823708209, 6139.416755408229, 6140.600860944069, 6097.97841994295, 6131.724072416752, 6134.559047376655, 6143.54563505925, 6149.446549810538, 5679.460451257124, 5750.482456578886, 5774.566907481955, 5779.653220806765, 5785.797497087624, 6120.538559592075, 6195.132681424604, 6195.535334849904, 6200.844978875564, 6212.099245609361, 5974.0, 6010.338862725097, 6027.457528822427, 6031.276246850406, 6101.298350689727, 6137.39578054044, 6172.814815555541, 6181.96909015452, 6202.41077097675, 6202.627842329474, 6115.785947491817, 6122.7550897964475, 6129.172561704113, 6129.662868542273, 6148.1085242640465, 6030.0, 6105.732692890381, 6112.235970503687, 6112.816615501542, 6127.955868343207, 4827.589654879304, 4910.238912968495, 4910.533499317559, 4910.533499317559, 4914.680545764585, 4422.933655995163, 4450.910981780346, 4456.442944631921, 4459.375687403766, 4464.821407143743, 5569.749361278752, 5656.547476201894, 5675.2054712340305, 5675.914861277084, 5677.489025987681, 6125.47964319526, 6144.586745048664, 6145.446909778052, 6146.463384153962, 6149.600275982047, 5623.943760562423, 5654.85862853432, 5657.094864821609, 5665.348484924204, 5670.659760414388, 5313.973430132902, 5315.707636080053, 5327.0145023170835, 5332.33345831771, 5374.91937620936, 6215.160953271341, 6216.44052035319, 6244.562880598405, 6249.593776404519, 6250.6874656267, 6110.236220472441, 6120.08198770188, 6131.713108457373, 6148.385161483816, 6187.81436556904, 6137.0399217141685, 6162.938370616236, 6191.133241346125, 6199.070139479114, 6205.906911396423, 5102.4642412546145, 6076.878462430638, 6102.812976549295, 6105.951237954871, 6115.235595550556, 5887.911681324869, 5994.88010239784, 6162.476189523941, 6171.105189747551, 6175.475084617858, 5074.137396642654, 5824.679642619527, 5975.760969561169, 5993.430624090704, 6045.032794752994, 6050.062240352752, 6055.969720151371, 6057.909131363122, 6064.514838812796, 6093.421124993119, 5823.7379317929945, 5836.533077353716, 5870.236869207147, 5888.263967004124, 5888.646681199141, 4949.331840201527, 5882.558808089325, 5951.256092988377, 5963.880722385441, 6028.306744724413, 4904.828331008398, 5882.352941176553, 5892.7642894283745, 5936.28764548257, 5944.791932282523], "value": 5600.184847409848, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.7820469890899, 491.6460148692941, 522.1906045629273, 528.5032069854336, 531.4419859147894, 24716.0, 33926.66073339266, 39840.0, 40530.0, 42424.515141970034, 42023.78988105055, 42217.0, 42460.0, 42517.937051573725, 42575.36136957948, 9382.202512786404, 9553.952230238874, 9563.282753793459, 9566.808663826754, 9575.856362154573, 9319.860202096974, 9424.858627120599, 9425.387349822275, 9435.0, 9437.433753974748, 9349.953250233773, 9416.952915235413, 9424.293178011641, 9430.669926552571, 9437.528123593827, 8104.473209241381, 9382.343235973485, 9399.57701903416, 9425.057494250623, 9439.24486041122, 9358.157765801043, 9446.244300455946, 9454.290928180346, 9460.763480912963, 9461.432314061109, 40166.397504037464, 40460.59539404598, 40470.59529404698, 40507.18985620271, 40571.59428405708, 3032.666406695284, 3513.0690367052753, 3569.446735755962, 3819.5034645495907, 4072.6334629883454, 29713.702862971524, 30853.691463085306, 30901.0, 30936.0, 31050.0, 3129.702678245563, 3253.7722359434847, 3283.7865538740143, 3321.750868684834, 3330.2506935939464, 460135.0, 461601.0, 461638.0, 462298.0, 466947.0, 56471.0, 56600.58498537487, 57149.0, 57255.71372143113, 57514.42485575174, 60362.69818650967, 60448.697756510934, 60558.0, 60567.69716151391, 60693.69653151794, 15668.216589170495, 15902.92048539773, 15933.521994340188, 15950.0, 16018.519444416686, 12466.688332791753, 12534.874651253553, 12535.561255356019, 12542.498300068077, 12549.372531373578, 14808.555743327717, 15347.923260383626, 15361.308741106677, 15402.614934626725, 15576.766348504781, 5850.239468869105, 6746.291639377893, 6790.626515541692, 6801.4558835293055, 6963.582185068912, 879.305348774461, 936.9109934556207, 955.8040601676639, 958.3277181318505, 1060.4591658254346, 24927.750722492907, 29461.705382946326, 29522.704772952424, 29969.400611988076, 30464.0, 870.4081224767219, 1029.7425643589104, 1053.5048527192362, 1060.4379678770265, 1094.2996482251365, 14791.260436978107, 15186.0, 15208.315625796866, 15346.782094088063, 15561.0, 583187.0, 586712.0, 587748.0, 589567.0, 589735.0, 55808.441915581134, 55821.0, 55860.44139558553, 55873.0, 55946.720266398406, 1099.7580532283046, 1207.6799648093263, 1257.1137348169336, 1360.8979326550548, 1378.207530669869, 25056.24831255065, 30689.53965690561, 31652.0, 31920.88276910297, 32717.509237360984, 51241.48758512516, 51779.482205178974, 51811.74094129656, 51844.481555183964, 51888.48111518836, 521097.0, 525088.3710233126, 525688.0, 526538.0, 527972.0, 37753.0, 37985.62014379821, 38760.80619596997, 39096.609033910434, 39207.0, 46575.0, 46689.76655116703, 47171.82070448266, 47206.0, 48326.5167348322, 34365.96902092941, 38849.44602215993, 39098.41352379773, 39128.2174356517, 39976.40035399413, 36476.0, 38297.808510957264, 38879.6112038876, 39917.600823991386, 40217.79891100526, 32050.0, 32561.674383255864, 32617.673823262412, 37528.62471375251, 37968.01335859695, 31213.8439307802, 32710.0, 34087.65912340845, 34475.4828677565, 34716.47925281072, 23061.846907654213, 24260.544367338018, 25393.619095713948, 25772.61341079923, 26217.213483595522], "value": 19562.800216780986, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.7695029081968, 374.3150035435154, 375.5493407910508, 390.47481137869556, 398.2135282816438, 14569.715142428786, 15032.398704051824, 19294.51763705908, 21082.57834843302, 21213.075581017503, 18967.430977070675, 20087.698684519743, 20706.378808635727, 20754.7169811321, 21219.151233950663, 5724.7137643117885, 6015.578909476339, 6019.097135429699, 6023.126646636235, 6025.698715064251, 4058.5129784425762, 4283.121959998193, 5836.854078648046, 5982.521398288127, 6209.87580248397, 6378.904316435257, 6558.11465452165, 6562.343765623424, 6583.275839657634, 6596.901046484307, 6244.937550624481, 6482.416582507573, 6543.541952063358, 6556.508261880331, 6556.93443065568, 5428.972855135699, 5563.610547261694, 5673.716314184274, 5680.971595142039, 5687.630304030266, 25392.49215015708, 25434.36414089644, 25477.8534965927, 25683.871580642164, 25778.484430311477, 1931.2661188748327, 2346.4485845826216, 2349.9530009399887, 2590.0546300600145, 2632.2366513711, 14887.255637218095, 15062.32219550112, 15139.924300378427, 15856.127912964783, 15993.680126397523, 1721.173836558459, 1837.4395809278165, 1839.5217243516647, 1867.5891303913118, 1869.8223668751448, 84014.0, 107222.46388768085, 110756.0, 118979.4051029748, 119151.0, 8280.461769984931, 10135.7466063349, 10277.126444252173, 10552.947235263775, 10791.0, 12922.9353853232, 13320.267385293902, 13361.0, 13365.198088114745, 13372.398242079129, 7875.803104922308, 8110.716124935717, 8143.226393492609, 8260.297874680598, 8288.875666865002, 8007.07918589358, 8021.5187088774865, 8028.394321135796, 8198.344132469389, 8214.917850821535, 6344.238691356974, 6404.1674582304, 6456.7740129095255, 6511.797520253918, 6538.221255966196, 1685.6207353345399, 1726.2318268370454, 1778.2086971297906, 1803.8105998870192, 1823.4803081121815, 867.2931560777946, 888.1961824548794, 894.3203165594196, 947.6683160893632, 1003.663772636175, 21225.787742122382, 21989.471210810643, 21990.340289791333, 22029.66955495669, 22133.446663833212, 948.3788118782209, 957.9568919398644, 977.9755506112405, 1031.3090229546222, 1067.5409573883148, 10782.921707829311, 11769.470373833197, 11826.467808948619, 11882.821757673642, 11898.940505297418, 521327.39336303074, 532381.0, 534426.0, 543004.0, 544911.0, 103743.0, 109659.25851853768, 110231.0, 110538.44730776295, 112211.0, 960.5053397500433, 968.2350942755286, 997.3866072365588, 998.1465846701111, 998.9910190707437, 19212.519687007938, 19516.121774519896, 19573.804261957197, 19590.804091958897, 19724.50688732793, 45057.324140137265, 48469.75765121293, 50853.237201442746, 51596.48403515917, 52295.0, 66055.66972165108, 70627.64686176536, 72985.9052114208, 74194.0, 77120.6143969299, 7766.184550622329, 7980.8802867955865, 8146.185381462044, 8185.836283274421, 8224.753257402288, 6809.148856392951, 10082.890882003121, 10291.794164116825, 12647.494100235888, 13213.735725285633, 10914.29057111317, 10939.507722152362, 11430.14273929442, 11478.966892979672, 11519.539218431504, 10973.286736362112, 11017.779644406906, 11167.801869961924, 11225.045871101049, 11356.659300221007, 11103.444827758742, 11446.771064578828, 11453.770924581295, 11501.309921404743, 11550.711232219262, 6974.546654467444, 7300.525465844703, 7956.323712484272, 8125.4490300949665, 8308.459950103224, 10093.444860532742, 11022.0, 11379.54481820718, 11421.885781142082, 11578.247413918069], "value": 9552.703293792134, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.318254055513, 1453.2080016391067, 1548.0247444110212, 1780.4302623160586, 1969.8128677775615, 7840.137584865667, 8325.209105135018, 8676.266975902594, 8899.510526921016, 8909.97535283441, 8713.564321783917, 8811.206991370775, 8828.0, 8828.07305232951, 8845.867311990325, 2307.9538409231805, 2322.3729593009875, 2325.988370058156, 2333.4049817296564, 2337.100216416675, 2260.468789834396, 2284.1776960294283, 2308.976910230893, 2310.584094862924, 2312.9653055204185, 2284.748677645466, 2307.90768369265, 2316.525112351964, 2320.234322673514, 2325.5232677301115, 2081.458820706612, 2201.801837834603, 2290.141197051106, 2296.3799774061076, 2302.689136966513, 2286.6112760830697, 2286.668433077211, 2292.1289909834322, 2297.3911913342977, 2300.2409204962323, 7399.70401183952, 8785.209331160162, 8824.338174636863, 8842.778930526723, 8864.024957254696, 5144.4083930348115, 5312.973435132838, 5338.386085600167, 5364.356277246756, 5370.543503802142, 3437.9656203438144, 3583.014670965479, 3655.3968595181764, 3656.7074634029213, 3657.1040095176586, 1030.5568605499632, 1064.542246833861, 1065.275612583443, 1081.691717860414, 1084.2139448899484, 10854.185936054748, 10986.176036797273, 11069.889301107047, 11105.167112466597, 11152.832707509393, 4179.853705120307, 4343.370211319341, 4421.137878113737, 4443.37792709021, 4447.3329000650165, 8747.475151490931, 8763.649454021896, 8778.034416214212, 8786.989496208018, 8793.736187914245, 5056.317397151338, 5057.089723849669, 5060.316857224301, 5064.18972964324, 5066.417362003417, 4087.6321131097748, 4375.16871794358, 4441.378207051015, 4537.137943790735, 4733.242681171065, 3661.761985470936, 3703.4444833275224, 3704.5739739930254, 3759.642833930772, 3761.6426439488205, 950.7813202963357, 988.1995583577325, 1100.9064229540418, 1105.0441368216595, 1105.4086063955745, 831.3930830493653, 857.3055824781947, 875.1729615513278, 912.2838571721167, 951.0990587979104, 5287.709175995357, 5384.461553844584, 5941.168236446901, 6088.360722124113, 6092.055731361646, 829.3365307753772, 880.4189235104928, 885.6811547842772, 961.6057416459219, 974.7270764185897, 3384.323135372935, 3839.1937693084765, 3911.5501717302304, 3986.0433495961342, 4086.7547947123267, 10406.219533535015, 10647.73380665474, 10763.300385474919, 10784.08335291509, 10797.136229101652, 10772.569097236179, 10791.568337266579, 10812.783744325227, 10821.458927053616, 10847.077998370227, 7800.336971357498, 8006.599670016476, 8142.063662678867, 8163.0, 8210.30212431938, 5893.145493903275, 6079.088136779342, 6092.299385570539, 6146.446819786241, 6153.507719382528, 9501.382410143318, 9570.712878613653, 9957.402555846673, 10028.047335503115, 10037.44794036335, 9827.606895724091, 10079.143272821892, 10240.18078553699, 10252.43611601369, 10256.743581410525, 7348.559086454616, 7470.215627359049, 7515.09818821723, 8289.295409889986, 8295.875561866456, 8403.285720713808, 8435.662573496991, 8516.74449766508, 8519.8722019171, 8520.914790852261, 7341.229170936975, 7413.777586672409, 7448.553086814808, 7528.284812942762, 7549.0935989643285, 7275.272472752682, 7286.453515986216, 7335.7432489862595, 7336.229695881855, 7429.14564825052, 6865.519413640997, 6975.267596902252, 6991.650417479207, 7003.369696727115, 7007.719691212498, 4906.3376444181, 4943.0, 5006.62450316235, 5041.873953151201, 5207.29701490294, 4435.556444355539, 4633.467151277646, 5005.249212618136, 5042.0, 5081.364829396325], "value": 4490.780011461613, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.4234446418235, 292.3145224448668, 293.8912602337136, 305.7294294549323, 306.8481101854582, 4250.596193361634, 4727.014653845385, 5255.737213139342, 5258.973705131469, 5282.313299271094, 4204.5375008749015, 4327.918020494876, 4447.666425018128, 4947.307376967227, 5272.578193744501, 3525.0834782956485, 3561.8397172127316, 3927.7054220933546, 4013.6989725770536, 4037.454943582608, 3468.618451970281, 3709.462127991453, 4053.6351728344443, 4060.634542891139, 4070.3894415837713, 3080.3069309405428, 3486.9016259878185, 3684.907877303062, 3752.924941501168, 3801.752886062397, 3799.6580307772156, 3960.3069462843887, 3968.3253846846105, 4008.83964641414, 4046.5953404659595, 3147.1345380020675, 3504.26410453805, 3504.526888869995, 3506.4740288956605, 3517.66582174693, 4849.539293767087, 5173.534381905646, 5174.534291913746, 5184.377874655028, 5191.636585439021, 4184.644305234059, 4461.241588929857, 4515.209838278288, 4526.510419269389, 4563.0, 4698.2851259290455, 5382.869597384554, 5466.972665136649, 5489.451054894518, 5546.86132846678, 3204.9679503205134, 3721.6278372162838, 3766.39737641976, 3774.5467994821915, 3777.508923839883, 4764.951710623657, 5251.579873610141, 5782.479576838105, 5800.129980502916, 5819.912701309484, 3739.139997800521, 3762.285165818486, 3774.358359078963, 3785.545734511876, 3789.621037896188, 3832.984259171266, 3833.21419109082, 3835.7506762060375, 3836.4437156612694, 3849.672777813861, 4152.211079894871, 4451.6199978006925, 4481.215787237221, 4484.260097084009, 4519.593236608721, 4732.337472753818, 5027.2207807789855, 5380.461953804666, 5475.945240547623, 5530.695811730394, 1113.5267511307825, 1208.468273959455, 1320.5642138094406, 1321.6497628128554, 1322.6759443936296, 741.3402072155785, 769.0310209136417, 783.8549868274388, 847.7626264645909, 855.341387131905, 4498.707584007095, 5107.131787596043, 5226.5818734501145, 5232.555232805178, 5256.553192978639, 5608.242887210256, 5615.2700148980375, 5618.887622247614, 5662.292213473316, 5693.975084484832, 4948.282499037691, 5139.58883289336, 5200.505951934636, 5211.817586384458, 5316.229146773696, 2614.516314481827, 2897.47845387828, 2935.473553752037, 2967.5103607904452, 2972.687867773896, 5427.0, 5523.834284971457, 5876.500497457679, 5890.381509941394, 5903.76384944606, 4450.865029417478, 5402.91895621566, 5522.536527820131, 5720.570957178228, 5789.218455508537, 4968.6025117990475, 5031.371078615173, 5634.183043458757, 5726.914096288642, 5787.971060144672, 5352.304200453916, 5538.280023596906, 5563.939833091702, 5582.9720851397105, 5604.243427137284, 4971.936646291893, 5645.887082258414, 5662.292213473316, 5666.716664166693, 5688.203651488878, 5904.940950590611, 5905.498032667271, 5946.640148316187, 5951.315598706205, 5954.851128721816, 3695.2055308108884, 3819.82954148062, 3833.195029043932, 3869.458275841441, 3871.1870507193803, 5681.0, 5681.17622944679, 5703.315602127771, 5708.543316534584, 5867.740919745843, 5235.136202526541, 5547.5007249347755, 5560.4161563035295, 5567.693776842312, 5603.411641777718, 4264.701470897007, 5242.921356179737, 5259.868503287448, 5297.841064768063, 5605.617612514747, 5101.474769988879, 5439.48324909133, 5447.3735520414075, 5452.700101494297, 5455.536279416294, 4862.4651288357545, 5025.321581586585, 5474.863128421821, 5487.0, 5529.336479622471, 5014.448410674896, 5422.13245880673, 5514.338279406497, 5531.529819965187, 5559.8888022240135], "value": 4003.151366571122, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.8332883436809, 725.6589402980599, 784.5880912520926, 809.8663720486119, 820.3273315880973, 15087.547373578784, 15717.92141039296, 15737.763933540977, 15743.527694169165, 15752.921235393822, 14345.641358966031, 14375.568732938029, 14379.856201437982, 14411.495597654084, 14648.121112733217, 691.4433880726014, 710.9431245500348, 714.4034730999596, 864.7708357285325, 878.9121087891208, 874.1346067393298, 884.8407286688393, 885.0132102705502, 886.2245535156737, 886.352962337494, 930.3812964378714, 943.8725772020792, 944.617429940875, 945.7730144765276, 946.1768261612373, 937.4422218779815, 938.2165891480622, 939.671115109713, 940.8165407745493, 940.9059094090536, 469.8872270655052, 539.6384422436937, 674.3189378727471, 699.024860319851, 700.8107810891031, 14562.708745825024, 15105.0, 15124.395024199019, 15138.621534461727, 15140.167290799001, 13283.136596121221, 13704.177749335071, 13724.039317247796, 13830.23933683647, 14029.719405611831, 12122.515099396014, 12249.326287054208, 12318.568850090203, 12376.443060062229, 12874.87125128746, 4209.0950445654025, 4218.135282267128, 4303.386230163688, 4307.741535507879, 4414.426124603813, 111691.44154279177, 113394.0, 113874.0, 114030.0, 114135.0, 8796.47221166732, 10382.844257336146, 10738.78522429547, 10817.729556761144, 10979.341239525655, 21192.258270960443, 21479.248226312004, 21532.13871445156, 21543.46141346479, 21554.784452155593, 7198.568085914757, 7506.737264195727, 7635.160132385433, 7783.29950304464, 7804.47812676534, 4341.891452713644, 4381.7370957742, 4421.270490369117, 4509.1658043262105, 4516.954830451719, 3222.5810644616517, 3572.91067723309, 3694.722895782827, 3737.8691745788765, 3738.7475195809166, 684.2780866186122, 694.5901917868482, 695.2144077192739, 730.1931365840776, 733.0397872203357, 560.4619565217356, 585.3093349847221, 684.0, 688.6737060000187, 696.1854630082815, 8259.906962859844, 9136.451812891248, 9687.66093186735, 9847.901520984698, 9861.901380986243, 546.6282927609184, 585.8125399872, 589.3634874335708, 593.0274350065895, 611.3336463255073, 4245.299525578245, 4597.310403439444, 4615.723056616614, 4759.619230461555, 4771.0, 131338.34330828284, 133295.3335233337, 134092.0, 135045.3247733755, 139028.3048584771, 99600.501997491, 117290.0, 118873.0, 125672.0, 127024.0, 108206.37690434493, 108503.0, 108874.94688429651, 109585.27465056366, 111932.0, 7870.842583148419, 8179.936608240891, 9141.954290228507, 9188.989211186898, 9367.718968430958, 58032.41967580439, 59423.514412140044, 60143.0, 60478.39521604904, 60740.0, 73002.63498682472, 92326.0, 92993.95539289924, 94200.0, 94406.58390124016, 11495.885041149482, 11787.351695656822, 12115.697107572028, 12138.696532586757, 12329.198602090835, 13172.275524846225, 13241.404136813673, 13424.308315213395, 13567.457301707822, 13907.930460347634, 12165.878341216474, 12242.081843861924, 12368.814467782811, 12508.061895357703, 12864.678383040124, 11844.466998984894, 12137.939310303393, 12427.875721243034, 12462.0, 12822.87177128254, 11717.414129293331, 11946.163768536118, 12173.147879648339, 12220.961218296545, 12715.872841271468, 8434.915650843413, 9850.556724947537, 9913.900860991298, 10689.465526723789, 10697.893021070002, 7771.805704857424, 9364.859527107235, 9387.765305867408, 9436.95281523588, 9721.9027809721], "value": 7615.432324568166, "unit": "score"}], "name": "dromaeo_css", "value": 7233.872873020678, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 99.0, 160.0, 168.0, 166.0, 113.0, 116.0, 114.0, 113.0, 114.0], "value": 130.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 113.0, 111.0, 149.0, 117.0, 135.0, 132.0, 134.0, 155.0, 110.0], "value": 130.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 183.0, 184.0, 182.0, 181.0, 182.0, 180.0, 182.0, 185.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 88.0, 59.0, 60.0, 59.0, 57.0, 83.0, 57.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 90.0, 69.0, 68.0, 68.0, 91.0, 67.0, 69.0, 88.0], "value": 76.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 88.0, 89.0, 87.0, 90.0, 87.0, 89.0, 86.0], "value": 88.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 97.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 81.0, 80.0, 81.0, 81.0, 83.0, 85.0, 81.0, 83.0], "value": 81.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 55.0, 55.0, 56.0, 57.0, 54.0, 53.0, 74.0, 74.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 69.0, 81.0, 72.0, 72.0, 69.0, 70.0, 70.0, 69.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 90.0, 85.0, 90.0, 83.0, 86.0, 88.0, 93.0, 87.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 147.0, 158.0, 155.0, 153.0, 146.0, 151.0, 136.0, 213.0, 151.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 172.0, 174.0, 177.0, 175.0, 176.0, 173.0, 169.0, 174.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 69.0, 67.0, 70.0, 68.0, 69.0, 69.0, 69.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1469.6, "alertThreshold": 2.0}]} 19:18:16 INFO - Return code: 0 19:18:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:18:16 INFO - # TBPL SUCCESS # 19:18:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:18:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:18:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:18:16 INFO - 2016-10-23 19:18:16.362 screenresolution[1674:10574] starting screenresolution argv=screenresolution get 19:18:16 INFO - 2016-10-23 19:18:16.365 screenresolution[1674:10574] Display 0: 1600x1200x32@60 19:18:16 INFO - 2016-10-23 19:18:16.371 screenresolution[1675:10576] starting screenresolution argv=screenresolution list 19:18:16 INFO - Available Modes on Display 0 19:18:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:18:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:18:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:18:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:18:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:18:16 INFO - Intel Iris: 19:18:16 INFO - Chipset Model: Intel Iris 19:18:16 INFO - Type: GPU 19:18:16 INFO - Bus: Built-In 19:18:16 INFO - VRAM (Dynamic, Max): 1536 MB 19:18:16 INFO - Vendor: Intel (0x8086) 19:18:16 INFO - Device ID: 0x0a2e 19:18:16 INFO - Revision ID: 0x0009 19:18:16 INFO - Displays: 19:18:16 INFO - Display: 19:18:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:18:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:18:16 INFO - Display Serial Number: 1600x1200 60 19:18:16 INFO - Main Display: Yes 19:18:16 INFO - Mirror: Off 19:18:16 INFO - Online: Yes 19:18:16 INFO - Rotation: Supported 19:18:16 INFO - Return code: 0 19:18:16 INFO - Running post-action listener: _resource_record_post_action 19:18:16 INFO - [mozharness: 2016-10-24 02:18:16.619672Z] Finished run-tests step (success) 19:18:16 INFO - Running post-run listener: _resource_record_post_run 19:18:16 INFO - Total resource usage - Wall time: 1215s; CPU: 53.0%; Read bytes: 32177152; Write bytes: 708742144; Read time: 197; Write time: 2021 19:18:16 INFO - TinderboxPrint: CPU usage
53.4% 19:18:16 INFO - TinderboxPrint: I/O read bytes / time
32,177,152 / 197 19:18:16 INFO - TinderboxPrint: I/O write bytes / time
708,742,144 / 2,021 19:18:16 INFO - TinderboxPrint: CPU idle
2,265.2 (46.6%) 19:18:16 INFO - TinderboxPrint: CPU system
970.9 (20.0%) 19:18:16 INFO - TinderboxPrint: CPU user
1,625.6 (33.4%) 19:18:16 INFO - TinderboxPrint: Swap in / out
433,246,208 / 0 19:18:16 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 387232256; Write bytes: 382902272; Read time: 29102; Write time: 825 19:18:16 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 31255552; Write bytes: 299924480; Read time: 186; Write time: 1129 19:18:17 INFO - Running post-run listener: _upload_blobber_files 19:18:17 INFO - Blob upload gear active. 19:18:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:18:17 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 19:18:17 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'] 19:18:17 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 19:18:17 INFO - (blobuploader) - INFO - Open directory for files ... 19:18:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:18:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:18:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:18 INFO - (blobuploader) - INFO - Done attempting. 19:18:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:18:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:18:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:19 INFO - (blobuploader) - INFO - Done attempting. 19:18:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:18:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:18:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:21 INFO - (blobuploader) - INFO - Done attempting. 19:18:21 INFO - (blobuploader) - INFO - Iteration through files over. 19:18:21 INFO - Return code: 0 19:18:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:18:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:18:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7243f2cfcc5a18241886bd6481b6eee52359d42df8232e684051c1fd92565645c11088cf04adfbd79a45e6b18ad1d06bf38cee6fb17943b70e4e023c7ecce03e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43c8a3ce17c1f298913e6ab5efc9eeb0a370c98228027f02e34b00b4a8c644c27bf431ecdc212f97388fddaf7b8c3ab8dd13b07c492ae8257b4b12fe4c612253", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e4e14fb039fa05ba03e2b8e75bba17c6dbfc4db0dc12579297f6e108472453b7fb88253c628d3dca034192133db4e9ca609feab806b4632e3b3f2135947efa3"} 19:18:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:18:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:18:21 INFO - Contents: 19:18:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7243f2cfcc5a18241886bd6481b6eee52359d42df8232e684051c1fd92565645c11088cf04adfbd79a45e6b18ad1d06bf38cee6fb17943b70e4e023c7ecce03e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43c8a3ce17c1f298913e6ab5efc9eeb0a370c98228027f02e34b00b4a8c644c27bf431ecdc212f97388fddaf7b8c3ab8dd13b07c492ae8257b4b12fe4c612253", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e4e14fb039fa05ba03e2b8e75bba17c6dbfc4db0dc12579297f6e108472453b7fb88253c628d3dca034192133db4e9ca609feab806b4632e3b3f2135947efa3"} 19:18:21 INFO - Running post-run listener: copy_logs_to_upload_dir 19:18:21 INFO - Copying logs to upload dir... 19:18:21 INFO - mkdir: /builds/slave/test/build/upload/logs 19:18:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.668097 ========= master_lag: 2.28 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-23 19:18:23.951898) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 19:18:23.955360) ========= 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.3hKCuEJ59B/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.j7P4TenLOf/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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/7243f2cfcc5a18241886bd6481b6eee52359d42df8232e684051c1fd92565645c11088cf04adfbd79a45e6b18ad1d06bf38cee6fb17943b70e4e023c7ecce03e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43c8a3ce17c1f298913e6ab5efc9eeb0a370c98228027f02e34b00b4a8c644c27bf431ecdc212f97388fddaf7b8c3ab8dd13b07c492ae8257b4b12fe4c612253", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e4e14fb039fa05ba03e2b8e75bba17c6dbfc4db0dc12579297f6e108472453b7fb88253c628d3dca034192133db4e9ca609feab806b4632e3b3f2135947efa3"} build_url:https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011644 build_url: 'https://queue.taskcluster.net/v1/task/WARu6alRRrGjBdhL9kfsbA/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/7243f2cfcc5a18241886bd6481b6eee52359d42df8232e684051c1fd92565645c11088cf04adfbd79a45e6b18ad1d06bf38cee6fb17943b70e4e023c7ecce03e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43c8a3ce17c1f298913e6ab5efc9eeb0a370c98228027f02e34b00b4a8c644c27bf431ecdc212f97388fddaf7b8c3ab8dd13b07c492ae8257b4b12fe4c612253", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e4e14fb039fa05ba03e2b8e75bba17c6dbfc4db0dc12579297f6e108472453b7fb88253c628d3dca034192133db4e9ca609feab806b4632e3b3f2135947efa3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 19:18:23.989918) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 19:18:23.990303) ========= 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.3hKCuEJ59B/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.j7P4TenLOf/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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.005373 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 19:18:24.038854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-23 19:18:24.039157) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-23 19:18:24.039466) ========= ========= Total master_lag: 2.44 =========