builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0261 starttime: 1479509326.69 results: success (0) buildid: 20161118124622 builduid: bea343dd6fcc4d26b86ae0272cee9291 revision: 46f55e7e305aeff69657cab5fdba3d6f1996d2d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 14:48:46.693729) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 14:48:46.694189) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 14:48:46.694472) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 14:48:47.210335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 14:48:47.210805) ========= 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.Qitv9KXtvf/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.xzPe8UuYwA/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-18 14:48:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2016-11-18 14:48:47 (18.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088091 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 14:48:47.323494) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 14:48:47.323852) ========= 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.Qitv9KXtvf/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.xzPe8UuYwA/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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.024287 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 14:48:47.377373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 14:48:47.377821) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 46f55e7e305aeff69657cab5fdba3d6f1996d2d8 --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 46f55e7e305aeff69657cab5fdba3d6f1996d2d8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Qitv9KXtvf/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.xzPe8UuYwA/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-18 14:48:47,482 truncating revision to first 12 chars 2016-11-18 14:48:47,482 Setting DEBUG logging. 2016-11-18 14:48:47,482 attempt 1/10 2016-11-18 14:48:47,482 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/46f55e7e305a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 14:48:48,720 unpacking tar archive at: mozilla-central-46f55e7e305a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.493768 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 14:48:48.898417) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 14:48:48.898792) ========= script_repo_revision: 46f55e7e305aeff69657cab5fdba3d6f1996d2d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 14:48:48.903307) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 14:48:48.903706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 14:48:48.925372) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-18 14:48:48.925795) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.Qitv9KXtvf/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.xzPe8UuYwA/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 14:48:49 INFO - MultiFileLogger online at 20161118 14:48:49 in /builds/slave/test 14:48:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:48:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:48:49 INFO - {'append_to_log': False, 14:48:49 INFO - 'base_work_dir': '/builds/slave/test', 14:48:49 INFO - 'blob_upload_branch': 'Firefox', 14:48:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:48:49 INFO - 'branch': 'Firefox', 14:48:49 INFO - 'buildbot_json_path': 'buildprops.json', 14:48:49 INFO - 'config_files': ('talos/mac_config.py',), 14:48:49 INFO - 'default_actions': ('clobber', 14:48:49 INFO - 'read-buildbot-config', 14:48:49 INFO - 'download-and-extract', 14:48:49 INFO - 'populate-webroot', 14:48:49 INFO - 'create-virtualenv', 14:48:49 INFO - 'install', 14:48:49 INFO - 'run-tests'), 14:48:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:48:49 INFO - 'download_minidump_stackwalk': True, 14:48:49 INFO - 'download_symbols': 'ondemand', 14:48:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:48:49 INFO - 'tooltool.py': '/tools/tooltool.py', 14:48:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:48:49 INFO - '/tools/misc-python/virtualenv.py')}, 14:48:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:48:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:48:49 INFO - 'installer_path': 'installer.exe', 14:48:49 INFO - 'log_level': 'info', 14:48:49 INFO - 'log_name': 'talos', 14:48:49 INFO - 'log_to_console': True, 14:48:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:48:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:48:49 INFO - 'opt_config_files': (), 14:48:49 INFO - 'pip_index': False, 14:48:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:48:49 INFO - 'cmd': ('bash', 14:48:49 INFO - '-c', 14:48:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:48:49 INFO - 'enabled': True, 14:48:49 INFO - 'halt_on_failure': False, 14:48:49 INFO - 'name': 'check_screen_resolution'},), 14:48:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:48:49 INFO - 'cmd': ('bash', 14:48:49 INFO - '-c', 14:48:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:48:49 INFO - 'enabled': True, 14:48:49 INFO - 'halt_on_failure': False, 14:48:49 INFO - 'name': 'check_screen_resolution'},), 14:48:49 INFO - 'run_cmd_checks_enabled': True, 14:48:49 INFO - 'sps_profile': False, 14:48:49 INFO - 'sps_profile_interval': 0, 14:48:49 INFO - 'suite': 'dromaeojs-e10s', 14:48:49 INFO - 'system_bits': '32', 14:48:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:48:49 INFO - 'title': 't-yosemite-r7-0261', 14:48:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:48:49 INFO - 'use_talos_json': True, 14:48:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:48:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:48:49 INFO - 'work_dir': 'build'} 14:48:49 INFO - [mozharness: 2016-11-18 22:48:49.135194Z] Running clobber step. 14:48:49 INFO - Running pre-action listener: _resource_record_pre_action 14:48:49 INFO - Running main action method: clobber 14:48:49 INFO - rmtree: /builds/slave/test/build 14:48:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:48:51 INFO - Running post-action listener: _resource_record_post_action 14:48:51 INFO - [mozharness: 2016-11-18 22:48:51.389347Z] Finished clobber step (success) 14:48:51 INFO - [mozharness: 2016-11-18 22:48:51.389480Z] Running read-buildbot-config step. 14:48:51 INFO - Running pre-action listener: _resource_record_pre_action 14:48:51 INFO - Running main action method: read_buildbot_config 14:48:51 INFO - Using buildbot properties: 14:48:51 INFO - { 14:48:51 INFO - "project": "", 14:48:51 INFO - "product": "firefox", 14:48:51 INFO - "script_repo_revision": "production", 14:48:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 14:48:51 INFO - "repository": "", 14:48:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 14:48:51 INFO - "buildid": "20161118124622", 14:48:51 INFO - "pgo_build": "False", 14:48:51 INFO - "basedir": "/builds/slave/test", 14:48:51 INFO - "buildnumber": 174, 14:48:51 INFO - "slavename": "t-yosemite-r7-0261", 14:48:51 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 14:48:51 INFO - "platform": "yosemite_r7", 14:48:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:48:51 INFO - "branch": "mozilla-central", 14:48:51 INFO - "repo_path": "mozilla-central", 14:48:51 INFO - "revision": "46f55e7e305aeff69657cab5fdba3d6f1996d2d8", 14:48:51 INFO - "stage_platform": "macosx64", 14:48:51 INFO - "builduid": "bea343dd6fcc4d26b86ae0272cee9291", 14:48:51 INFO - "slavebuilddir": "test" 14:48:51 INFO - } 14:48:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 14:48:51 INFO - Running post-action listener: _resource_record_post_action 14:48:51 INFO - [mozharness: 2016-11-18 22:48:51.393485Z] Finished read-buildbot-config step (success) 14:48:51 INFO - [mozharness: 2016-11-18 22:48:51.393635Z] Running download-and-extract step. 14:48:51 INFO - Running pre-action listener: _resource_record_pre_action 14:48:51 INFO - Running main action method: download_and_extract 14:48:51 INFO - mkdir: /builds/slave/test/build/tests 14:48:51 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')]} 14:48:51 INFO - trying https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 14:48:51 INFO - Downloading https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:48:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 14:48:52 INFO - Downloaded 1199 bytes. 14:48:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:48:52 INFO - Using the following test package requirements: 14:48:52 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:48:52 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:48:52 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 14:48:52 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:48:52 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 14:48:52 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:48:52 INFO - u'jsshell-mac.zip'], 14:48:52 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:48:52 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 14:48:52 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:48:52 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:48:52 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 14:48:52 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:48:52 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 14:48:52 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:48:52 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 14:48:52 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:48:52 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 14:48:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:48:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:48:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:48:52 INFO - Fetch https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:48:53 INFO - Http code: 200 14:48:53 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 14:48:53 INFO - x-amz-cf-id: oG1gInV0owq5rLAuz5LECLA_rqG4xWYmUoQ9EzMuBZIzTLo34iLVrA== 14:48:53 INFO - x-amz-version-id: _tv1VoxvG7EBCF3WYotcLOi5JMzhM2Bz 14:48:53 INFO - Expected file size: 16233342 14:48:53 INFO - Obtained file size: 16233342 14:49:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:49:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:49:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:49:00 INFO - Fetch https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:49:00 INFO - Http code: 200 14:49:00 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 14:49:00 INFO - x-amz-cf-id: yTkvH4gtOBd8Ex44wOrsNYbZjGQ-uMc3i_D3VBN1_Pmb7T0gwJASmQ== 14:49:00 INFO - x-amz-version-id: _tv1VoxvG7EBCF3WYotcLOi5JMzhM2Bz 14:49:01 INFO - Expected file size: 16233342 14:49:01 INFO - Obtained file size: 16233342 14:49:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 14:49:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:49:07 INFO - Fetch https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 14:49:08 INFO - Http code: 200 14:49:08 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 14:49:08 INFO - x-amz-cf-id: KlDnjOmUpsDEOQKSF8FA4wmIyb3mxir7GDo2NhC37OFx4ntnk-CLeA== 14:49:08 INFO - x-amz-version-id: VQxqKIK7TgeyU304.q_BArEQ8n9HUg83 14:49:08 INFO - Expected file size: 14409392 14:49:08 INFO - Obtained file size: 14409392 14:49: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')]} 14:49:08 INFO - trying https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:49:08 INFO - Downloading https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 14:49:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 14:49:11 INFO - Downloaded 107380112 bytes. 14:49:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:49:11 INFO - mkdir: /builds/slave/test/properties 14:49:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:49:11 INFO - Writing to file /builds/slave/test/properties/build_url 14:49:11 INFO - Contents: 14:49:11 INFO - build_url:https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:49:12 INFO - Running post-action listener: _resource_record_post_action 14:49:12 INFO - Running post-action listener: set_extra_try_arguments 14:49:12 INFO - [mozharness: 2016-11-18 22:49:12.247083Z] Finished download-and-extract step (success) 14:49:12 INFO - [mozharness: 2016-11-18 22:49:12.247205Z] Running populate-webroot step. 14:49:12 INFO - Running pre-action listener: _resource_record_pre_action 14:49:12 INFO - Running main action method: populate_webroot 14:49:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:49:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:49:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:49:12 INFO - '--tppagecycles', 14:49:12 INFO - '7'], 14:49:12 INFO - 'tests': ['tsvgm']}}, 14:49:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:49:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:49:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:49:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:49:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:49:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:49:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:49:12 INFO - 'talos_options': ['--disable-e10s'], 14:49:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:49:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:49:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:49:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:49:12 INFO - 'talos_options': ['--disable-e10s'], 14:49:12 INFO - 'tests': ['damp', 'tps']}, 14:49:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:49:12 INFO - 'tests': ['damp', 'tps']}, 14:49:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:49:12 INFO - 'tests': ['dromaeo_dom']}, 14:49:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:49:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:49:12 INFO - 'tests': ['basic_compositor_video']}, 14:49:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:49:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:49:12 INFO - 'tests': ['a11yr', 14:49:12 INFO - 'ts_paint', 14:49:12 INFO - 'tpaint', 14:49:12 INFO - 'sessionrestore', 14:49:12 INFO - 'sessionrestore_no_auto_restore', 14:49:12 INFO - 'tabpaint']}, 14:49:12 INFO - 'other-e10s': {'tests': ['a11yr', 14:49:12 INFO - 'ts_paint', 14:49:12 INFO - 'tpaint', 14:49:12 INFO - 'sessionrestore', 14:49:12 INFO - 'sessionrestore_no_auto_restore', 14:49:12 INFO - 'tabpaint']}, 14:49:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:49:12 INFO - 'ts_paint', 14:49:12 INFO - 'tpaint', 14:49:12 INFO - 'sessionrestore', 14:49:12 INFO - 'sessionrestore_no_auto_restore', 14:49:12 INFO - 'tabpaint']}, 14:49:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:49:12 INFO - 'ts_paint', 14:49:12 INFO - 'tpaint', 14:49:12 INFO - 'sessionrestore', 14:49:12 INFO - 'sessionrestore_no_auto_restore', 14:49:12 INFO - 'tabpaint']}, 14:49:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:49:12 INFO - 'tests': ['a11yr', 14:49:12 INFO - 'ts_paint', 14:49:12 INFO - 'tpaint', 14:49:12 INFO - 'sessionrestore', 14:49:12 INFO - 'sessionrestore_no_auto_restore', 14:49:12 INFO - 'tabpaint']}, 14:49:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:49:12 INFO - 'tests': ['a11yr', 14:49:12 INFO - 'ts_paint', 14:49:12 INFO - 'tpaint', 14:49:12 INFO - 'sessionrestore', 14:49:12 INFO - 'sessionrestore_no_auto_restore', 14:49:12 INFO - 'tabpaint']}, 14:49:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:49:12 INFO - 'tests': ['tsvgx', 14:49:12 INFO - 'tsvgr_opacity', 14:49:12 INFO - 'tart', 14:49:12 INFO - 'tscrollx', 14:49:12 INFO - 'cart']}, 14:49:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:49:12 INFO - 'tsvgr_opacity', 14:49:12 INFO - 'tart', 14:49:12 INFO - 'tscrollx', 14:49:12 INFO - 'cart']}, 14:49:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:49:12 INFO - 'talos_options': ['--disable-e10s'], 14:49:12 INFO - 'tests': ['tp5o']}, 14:49:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:49:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:49:12 INFO - 'talos_options': ['--disable-e10s', 14:49:12 INFO - '--xperf_path', 14:49:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:49:12 INFO - 'tests': ['tp5n']}, 14:49:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:49:12 INFO - 'talos_options': ['--xperf_path', 14:49:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:49:12 INFO - 'tests': ['tp5n']}}, 14:49:12 INFO - 'talos.zip': {'path': '', 14:49:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:49:12 INFO - Running post-action listener: _resource_record_post_action 14:49:12 INFO - [mozharness: 2016-11-18 22:49:12.265268Z] Finished populate-webroot step (success) 14:49:12 INFO - [mozharness: 2016-11-18 22:49:12.265406Z] Running create-virtualenv step. 14:49:12 INFO - Running pre-action listener: _resource_record_pre_action 14:49:12 INFO - Running main action method: create_virtualenv 14:49:12 INFO - Creating virtualenv /builds/slave/test/build/venv 14:49:12 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 14:49:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:49:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:49:12 INFO - Using real prefix '/tools/python27' 14:49:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:49:13 INFO - Installing distribute.............................................................................................................................................................................................done. 14:49:15 INFO - Installing pip.................done. 14:49:15 INFO - Return code: 0 14:49:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:49:16 INFO - Reading from file tmpfile_stdout 14:49:16 INFO - Output received: 14:49:16 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) 14:49:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:49:16 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')]} 14:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:16 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')]} 14:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:16 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 0x10ffc73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9d35551e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdddd30>, '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 0x10fc44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd5b20>, '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.Qitv9KXtvf/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.xzPe8UuYwA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 14:49:16 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 14:49:16 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 14:49:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qitv9KXtvf/Render', 14:49:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:49:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:49:16 INFO - 'HOME': '/Users/cltbld', 14:49:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:49:16 INFO - 'LOGNAME': 'cltbld', 14:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:16 INFO - 'MOZ_NO_REMOTE': '1', 14:49:16 INFO - 'NO_EM_RESTART': '1', 14:49:16 INFO - 'PAGER': '/bin/cat', 14:49:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:16 INFO - 'PWD': '/builds/slave/test', 14:49:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:49:16 INFO - 'SHELL': '/bin/bash', 14:49:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xzPe8UuYwA/Listeners', 14:49:16 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 14:49:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:49:16 INFO - 'USER': 'cltbld', 14:49:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:49:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:16 INFO - 'XPC_FLAGS': '0x0', 14:49:16 INFO - 'XPC_SERVICE_NAME': '0', 14:49:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:16 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 14:49:16 INFO - Cleaning up... 14:49:16 INFO - Return code: 0 14:49:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:49:16 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')]} 14:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:16 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')]} 14:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:16 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 0x10ffc73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9d35551e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdddd30>, '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 0x10fc44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd5b20>, '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.Qitv9KXtvf/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.xzPe8UuYwA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 14:49:16 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 14:49:16 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 14:49:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qitv9KXtvf/Render', 14:49:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:49:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:49:16 INFO - 'HOME': '/Users/cltbld', 14:49:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:49:16 INFO - 'LOGNAME': 'cltbld', 14:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:16 INFO - 'MOZ_NO_REMOTE': '1', 14:49:16 INFO - 'NO_EM_RESTART': '1', 14:49:16 INFO - 'PAGER': '/bin/cat', 14:49:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:16 INFO - 'PWD': '/builds/slave/test', 14:49:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:49:16 INFO - 'SHELL': '/bin/bash', 14:49:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xzPe8UuYwA/Listeners', 14:49:16 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 14:49:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:49:16 INFO - 'USER': 'cltbld', 14:49:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:49:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:16 INFO - 'XPC_FLAGS': '0x0', 14:49:16 INFO - 'XPC_SERVICE_NAME': '0', 14:49:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:16 INFO - Downloading/unpacking psutil>=3.1.1 14:49:16 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 14:49:16 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 14:49:16 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 14:49:16 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 14:49:16 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 14:49:16 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 14:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:49:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:49:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:49:20 INFO - Installing collected packages: psutil 14:49:20 INFO - Running setup.py install for psutil 14:49:20 INFO - building 'psutil._psutil_osx' extension 14:49:20 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 14:49:20 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 14:49:20 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 14:49:21 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 14:49:21 INFO - building 'psutil._psutil_posix' extension 14:49:21 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 14:49:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:49:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:49:21 INFO - ^ 14:49:21 INFO - 1 warning generated. 14:49:21 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 14:49:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:49:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:49:21 INFO - Successfully installed psutil 14:49:21 INFO - Cleaning up... 14:49:21 INFO - Return code: 0 14:49:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:49:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ffc73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9d35551e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdddd30>, '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 0x10fc44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd5b20>, '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.Qitv9KXtvf/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.xzPe8UuYwA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 14:49:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:49:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qitv9KXtvf/Render', 14:49:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:49:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:49:21 INFO - 'HOME': '/Users/cltbld', 14:49:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:49:21 INFO - 'LOGNAME': 'cltbld', 14:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:21 INFO - 'MOZ_NO_REMOTE': '1', 14:49:21 INFO - 'NO_EM_RESTART': '1', 14:49:21 INFO - 'PAGER': '/bin/cat', 14:49:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:21 INFO - 'PWD': '/builds/slave/test', 14:49:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:49:21 INFO - 'SHELL': '/bin/bash', 14:49:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xzPe8UuYwA/Listeners', 14:49:21 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 14:49:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:49:21 INFO - 'USER': 'cltbld', 14:49:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:49:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:21 INFO - 'XPC_FLAGS': '0x0', 14:49:21 INFO - 'XPC_SERVICE_NAME': '0', 14:49:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:49:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:49:24 INFO - Installing collected packages: mozsystemmonitor 14:49:24 INFO - Running setup.py install for mozsystemmonitor 14:49:24 INFO - Successfully installed mozsystemmonitor 14:49:24 INFO - Cleaning up... 14:49:24 INFO - Return code: 0 14:49:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:49:24 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')]} 14:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:24 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')]} 14:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:24 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 0x10ffc73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9d35551e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdddd30>, '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 0x10fc44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd5b20>, '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.Qitv9KXtvf/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.xzPe8UuYwA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 14:49:24 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 14:49:24 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 14:49:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qitv9KXtvf/Render', 14:49:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:49:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:49:24 INFO - 'HOME': '/Users/cltbld', 14:49:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:49:24 INFO - 'LOGNAME': 'cltbld', 14:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:24 INFO - 'MOZ_NO_REMOTE': '1', 14:49:24 INFO - 'NO_EM_RESTART': '1', 14:49:24 INFO - 'PAGER': '/bin/cat', 14:49:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:24 INFO - 'PWD': '/builds/slave/test', 14:49:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:49:24 INFO - 'SHELL': '/bin/bash', 14:49:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xzPe8UuYwA/Listeners', 14:49:24 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 14:49:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:49:24 INFO - 'USER': 'cltbld', 14:49:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:49:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:24 INFO - 'XPC_FLAGS': '0x0', 14:49:24 INFO - 'XPC_SERVICE_NAME': '0', 14:49:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:24 INFO - Downloading/unpacking jsonschema==2.5.1 14:49:24 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 14:49:24 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 14:49:24 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 14:49:24 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 14:49:24 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 14:49:24 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 14:49:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:49:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:49:27 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 14:49:27 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 14:49:27 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 14:49:27 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 14:49:27 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 14:49:27 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 14:49:27 INFO - Downloading functools32-3.2.3-2.tar.gz 14:49:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:49:27 INFO - warning: no files found matching '*.txt' 14:49:27 INFO - no previously-included directories found matching 'build' 14:49:27 INFO - no previously-included directories found matching 'dist' 14:49:27 INFO - no previously-included directories found matching '.git*' 14:49:27 INFO - Installing collected packages: jsonschema, functools32 14:49:27 INFO - Running setup.py install for functools32 14:49:27 INFO - warning: no files found matching '*.txt' 14:49:27 INFO - no previously-included directories found matching 'build' 14:49:27 INFO - no previously-included directories found matching 'dist' 14:49:27 INFO - no previously-included directories found matching '.git*' 14:49:27 INFO - Successfully installed jsonschema functools32 14:49:27 INFO - Cleaning up... 14:49:28 INFO - Return code: 0 14:49:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ffc73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9d35551e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdddd30>, '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 0x10fc44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd5b20>, '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.Qitv9KXtvf/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.xzPe8UuYwA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 14:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:49:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qitv9KXtvf/Render', 14:49:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:49:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:49:28 INFO - 'HOME': '/Users/cltbld', 14:49:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:49:28 INFO - 'LOGNAME': 'cltbld', 14:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:28 INFO - 'MOZ_NO_REMOTE': '1', 14:49:28 INFO - 'NO_EM_RESTART': '1', 14:49:28 INFO - 'PAGER': '/bin/cat', 14:49:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:28 INFO - 'PWD': '/builds/slave/test', 14:49:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:49:28 INFO - 'SHELL': '/bin/bash', 14:49:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xzPe8UuYwA/Listeners', 14:49:28 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 14:49:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:49:28 INFO - 'USER': 'cltbld', 14:49:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:49:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:28 INFO - 'XPC_FLAGS': '0x0', 14:49:28 INFO - 'XPC_SERVICE_NAME': '0', 14:49:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:49:28 INFO - Cleaning up... 14:49:28 INFO - Return code: 0 14:49:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ffc73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9d35551e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdddd30>, '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 0x10fc44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd5b20>, '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.Qitv9KXtvf/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.xzPe8UuYwA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 14:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:49:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qitv9KXtvf/Render', 14:49:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:49:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:49:28 INFO - 'HOME': '/Users/cltbld', 14:49:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:49:28 INFO - 'LOGNAME': 'cltbld', 14:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:28 INFO - 'MOZ_NO_REMOTE': '1', 14:49:28 INFO - 'NO_EM_RESTART': '1', 14:49:28 INFO - 'PAGER': '/bin/cat', 14:49:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:28 INFO - 'PWD': '/builds/slave/test', 14:49:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:49:28 INFO - 'SHELL': '/bin/bash', 14:49:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xzPe8UuYwA/Listeners', 14:49:28 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 14:49:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:49:28 INFO - 'USER': 'cltbld', 14:49:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:49:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:28 INFO - 'XPC_FLAGS': '0x0', 14:49:28 INFO - 'XPC_SERVICE_NAME': '0', 14:49:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:28 INFO - Downloading/unpacking blobuploader==1.2.4 14:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:31 INFO - Downloading blobuploader-1.2.4.tar.gz 14:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:49:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:49:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:32 INFO - Downloading docopt-0.6.1.tar.gz 14:49:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:49:32 INFO - Installing collected packages: blobuploader, requests, docopt 14:49:32 INFO - Running setup.py install for blobuploader 14:49:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:49:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:49:32 INFO - Running setup.py install for requests 14:49:33 INFO - Running setup.py install for docopt 14:49:33 INFO - Successfully installed blobuploader requests docopt 14:49:33 INFO - Cleaning up... 14:49:33 INFO - Return code: 0 14:49:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49: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')]} 14:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49: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')]} 14:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:33 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 0x10ffc73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9d35551e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdddd30>, '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 0x10fc44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd5b20>, '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.Qitv9KXtvf/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.xzPe8UuYwA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 14:49:33 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 14:49:33 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 14:49:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qitv9KXtvf/Render', 14:49:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:49:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:49:33 INFO - 'HOME': '/Users/cltbld', 14:49:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:49:33 INFO - 'LOGNAME': 'cltbld', 14:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:33 INFO - 'MOZ_NO_REMOTE': '1', 14:49:33 INFO - 'NO_EM_RESTART': '1', 14:49:33 INFO - 'PAGER': '/bin/cat', 14:49:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:33 INFO - 'PWD': '/builds/slave/test', 14:49:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:49:33 INFO - 'SHELL': '/bin/bash', 14:49:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xzPe8UuYwA/Listeners', 14:49:33 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 14:49:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:49:33 INFO - 'USER': 'cltbld', 14:49:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:49:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:33 INFO - 'XPC_FLAGS': '0x0', 14:49:33 INFO - 'XPC_SERVICE_NAME': '0', 14:49:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:49:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:49:33 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-yPvAkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:49:33 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-mAbdW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:49:33 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-GkyPDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:49:33 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-5LDNyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:49:33 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-HJB0ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:49:34 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-MQGvZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:49:34 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-aVR7F9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:49:34 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-c87Yxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:49:34 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-Z_eNHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:49:34 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-WeCYQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:49:34 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-nW4Uz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:49:34 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-BqxVS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:49:34 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-mQ0c7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:49:34 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-FVZ0r5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:34 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-ByKuOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:49:35 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-yFD_YX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:49:35 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-g7WaGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:49:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:49:35 INFO - Running setup.py install for manifestparser 14:49:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:49:35 INFO - Running setup.py install for mozcrash 14:49:35 INFO - Running setup.py install for mozdebug 14:49:35 INFO - Running setup.py install for mozdevice 14:49:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:49:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:49:35 INFO - Running setup.py install for mozfile 14:49:36 INFO - Running setup.py install for mozhttpd 14:49:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:49:36 INFO - Running setup.py install for mozinfo 14:49:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:49:36 INFO - Running setup.py install for mozInstall 14:49:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:49:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:49:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:49:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:49:36 INFO - Running setup.py install for mozleak 14:49:36 INFO - Running setup.py install for mozlog 14:49:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:49:36 INFO - Running setup.py install for moznetwork 14:49:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:49:36 INFO - Running setup.py install for mozprocess 14:49:37 INFO - Running setup.py install for mozprofile 14:49:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:49:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:49:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:49:37 INFO - Running setup.py install for mozrunner 14:49:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:49:37 INFO - Running setup.py install for mozscreenshot 14:49:37 INFO - Running setup.py install for moztest 14:49:37 INFO - Running setup.py install for mozversion 14:49:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:49:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:49:37 INFO - Cleaning up... 14:49:37 INFO - Return code: 0 14:49:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49: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')]} 14:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:38 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 0x10ffc73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9d35551e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdddd30>, '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 0x10fc44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd5b20>, '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.Qitv9KXtvf/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.xzPe8UuYwA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 14:49:38 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 14:49:38 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 14:49:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qitv9KXtvf/Render', 14:49:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:49:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:49:38 INFO - 'HOME': '/Users/cltbld', 14:49:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:49:38 INFO - 'LOGNAME': 'cltbld', 14:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:38 INFO - 'MOZ_NO_REMOTE': '1', 14:49:38 INFO - 'NO_EM_RESTART': '1', 14:49:38 INFO - 'PAGER': '/bin/cat', 14:49:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:38 INFO - 'PWD': '/builds/slave/test', 14:49:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:49:38 INFO - 'SHELL': '/bin/bash', 14:49:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xzPe8UuYwA/Listeners', 14:49:38 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 14:49:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:49:38 INFO - 'USER': 'cltbld', 14:49:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:49:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:38 INFO - 'XPC_FLAGS': '0x0', 14:49:38 INFO - 'XPC_SERVICE_NAME': '0', 14:49:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:49:38 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-btv9yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:49:39 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)) 14:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:49:39 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-RnmaDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:49:39 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-YeaRVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:49:39 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)) 14:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:49:39 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-84B3D7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:49:39 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-ApQH6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:49:39 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)) 14:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:49:39 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-jCD3Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:49:39 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)) 14:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:49:39 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-ELN723-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:49:39 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)) 14:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:49:39 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-P3C3v0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:49:39 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)) 14:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:49:39 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-g4lxmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:49:39 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)) 14:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:49:39 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-Amk4bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:49:40 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)) 14:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:49:40 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-SS1Gx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:49:40 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)) 14:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:49:40 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-VRYgJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:49:40 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)) 14:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:49:40 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-u6A3Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:49:40 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)) 14:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:49:40 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-R2ZdMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:40 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-GSjZLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:40 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)) 14:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:49:40 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-5VQR69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:49:40 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)) 14:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:49:40 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-vIVccF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:49:40 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)) 14:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:49:40 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)) 14:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:49:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:43 INFO - Downloading blessings-1.6.tar.gz 14:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:49:43 INFO - Installing collected packages: blessings 14:49:43 INFO - Running setup.py install for blessings 14:49:43 INFO - Successfully installed blessings 14:49:43 INFO - Cleaning up... 14:49:44 INFO - Return code: 0 14:49:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:49:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:49:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:49:44 INFO - Reading from file tmpfile_stdout 14:49:44 INFO - Current package versions: 14:49:44 INFO - blessings == 1.6 14:49:44 INFO - blobuploader == 1.2.4 14:49:44 INFO - docopt == 0.6.1 14:49:44 INFO - functools32 == 3.2.3-2 14:49:44 INFO - jsonschema == 2.5.1 14:49:44 INFO - manifestparser == 1.1 14:49:44 INFO - mozInstall == 1.12 14:49:44 INFO - mozcrash == 1.0 14:49:44 INFO - mozdebug == 0.1 14:49:44 INFO - mozdevice == 0.49 14:49:44 INFO - mozfile == 1.2 14:49:44 INFO - mozhttpd == 0.7 14:49:44 INFO - mozinfo == 0.9 14:49:44 INFO - mozleak == 0.1 14:49:44 INFO - mozlog == 3.4 14:49:44 INFO - moznetwork == 0.27 14:49:44 INFO - mozprocess == 0.23 14:49:44 INFO - mozprofile == 0.28 14:49:44 INFO - mozrunner == 6.13 14:49:44 INFO - mozscreenshot == 0.1 14:49:44 INFO - mozsystemmonitor == 0.3 14:49:44 INFO - moztest == 0.7 14:49:44 INFO - mozversion == 1.4 14:49:44 INFO - psutil == 3.1.1 14:49:44 INFO - requests == 1.2.3 14:49:44 INFO - wsgiref == 0.1.2 14:49:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49:44 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')]} 14:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:44 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')]} 14:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:44 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 0x10ffc73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9d35551e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdddd30>, '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 0x10fc44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd5b20>, '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.Qitv9KXtvf/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.xzPe8UuYwA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 14:49:44 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 14:49:44 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 14:49:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qitv9KXtvf/Render', 14:49:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:49:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:49:44 INFO - 'HOME': '/Users/cltbld', 14:49:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:49:44 INFO - 'LOGNAME': 'cltbld', 14:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:44 INFO - 'MOZ_NO_REMOTE': '1', 14:49:44 INFO - 'NO_EM_RESTART': '1', 14:49:44 INFO - 'PAGER': '/bin/cat', 14:49:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:44 INFO - 'PWD': '/builds/slave/test', 14:49:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:49:44 INFO - 'SHELL': '/bin/bash', 14:49:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xzPe8UuYwA/Listeners', 14:49:44 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 14:49:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:49:44 INFO - 'USER': 'cltbld', 14:49:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:49:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:44 INFO - 'XPC_FLAGS': '0x0', 14:49:44 INFO - 'XPC_SERVICE_NAME': '0', 14:49:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:44 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)) 14:49:44 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)) 14:49:44 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)) 14:49:44 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)) 14:49:44 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)) 14:49:44 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)) 14:49:44 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)) 14:49:44 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)) 14:49:44 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)) 14:49:44 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)) 14:49:44 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)) 14:49:44 INFO - Cleaning up... 14:49:44 INFO - Return code: 0 14:49:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:49:44 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')]} 14:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:44 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')]} 14:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:49:44 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 0x10ffc73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9d35551e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdddd30>, '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 0x10fc44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd5b20>, '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.Qitv9KXtvf/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.xzPe8UuYwA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 14:49:44 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 14:49:44 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 14:49:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qitv9KXtvf/Render', 14:49:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:49:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:49:44 INFO - 'HOME': '/Users/cltbld', 14:49:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:49:44 INFO - 'LOGNAME': 'cltbld', 14:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:44 INFO - 'MOZ_NO_REMOTE': '1', 14:49:44 INFO - 'NO_EM_RESTART': '1', 14:49:44 INFO - 'PAGER': '/bin/cat', 14:49:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:44 INFO - 'PWD': '/builds/slave/test', 14:49:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:49:44 INFO - 'SHELL': '/bin/bash', 14:49:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xzPe8UuYwA/Listeners', 14:49:44 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 14:49:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:49:44 INFO - 'USER': 'cltbld', 14:49:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:49:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:44 INFO - 'XPC_FLAGS': '0x0', 14:49:44 INFO - 'XPC_SERVICE_NAME': '0', 14:49:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:49:44 INFO - Cleaning up... 14:49:44 INFO - Return code: 0 14:49:44 INFO - Running post-action listener: _resource_record_post_action 14:49:44 INFO - Running post-action listener: _start_resource_monitoring 14:49:44 INFO - Starting resource monitoring. 14:49:44 INFO - [mozharness: 2016-11-18 22:49:44.848201Z] Finished create-virtualenv step (success) 14:49:44 INFO - [mozharness: 2016-11-18 22:49:44.849196Z] Running install step. 14:49:44 INFO - Running pre-action listener: _resource_record_pre_action 14:49:44 INFO - Running main action method: install 14:49:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:49:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:49:45 INFO - Reading from file tmpfile_stdout 14:49:45 INFO - Detecting whether we're running mozinstall >=1.0... 14:49:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:49:45 INFO - Reading from file tmpfile_stdout 14:49:45 INFO - Output received: 14:49:45 INFO - Usage: mozinstall [options] installer 14:49:45 INFO - Options: 14:49:45 INFO - -h, --help show this help message and exit 14:49:45 INFO - -d DEST, --destination=DEST 14:49:45 INFO - Directory to install application into. [default: 14:49:45 INFO - "/builds/slave/test"] 14:49:45 INFO - --app=APP Application being installed. [default: firefox] 14:49:45 INFO - mkdir: /builds/slave/test/build/application 14:49:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:50:18 INFO - Reading from file tmpfile_stdout 14:50:18 INFO - Output received: 14:50:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:50:18 INFO - Running post-action listener: _resource_record_post_action 14:50:18 INFO - [mozharness: 2016-11-18 22:50:18.518755Z] Finished install step (success) 14:50:18 INFO - [mozharness: 2016-11-18 22:50:18.518895Z] Running run-tests step. 14:50:18 INFO - Running pre-action listener: _resource_record_pre_action 14:50:18 INFO - Running main action method: run_tests 14:50:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:50:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:50:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:50:18 INFO - 2016-11-18 14:50:18.533 screenresolution[1620:7300] starting screenresolution argv=screenresolution get 14:50:18 INFO - 2016-11-18 14:50:18.535 screenresolution[1620:7300] Display 0: 1600x1200x32@60 14:50:18 INFO - 2016-11-18 14:50:18.541 screenresolution[1621:7302] starting screenresolution argv=screenresolution list 14:50:18 INFO - Available Modes on Display 0 14:50:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:50:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:50:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:50:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:50:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:50:18 INFO - Intel Iris: 14:50:18 INFO - Chipset Model: Intel Iris 14:50:18 INFO - Type: GPU 14:50:18 INFO - Bus: Built-In 14:50:18 INFO - VRAM (Dynamic, Max): 1536 MB 14:50:18 INFO - Vendor: Intel (0x8086) 14:50:18 INFO - Device ID: 0x0a2e 14:50:18 INFO - Revision ID: 0x0009 14:50:18 INFO - Displays: 14:50:18 INFO - Display: 14:50:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:50:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:50:18 INFO - Display Serial Number: 1600x1200 60 14:50:18 INFO - Main Display: Yes 14:50:18 INFO - Mirror: Off 14:50:18 INFO - Online: Yes 14:50:18 INFO - Rotation: Supported 14:50:18 INFO - Return code: 0 14:50:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:50:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:50:18 INFO - Python 2.7.3 14:50:18 INFO - Return code: 0 14:50:18 INFO - grabbing minidump binary from tooltool 14:50:18 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')]} 14:50:18 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 0x10fdddd30>, '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 0x10fc44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:50:18 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 14:50:18 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 14:50:18 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 14:50:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:50:18 INFO - Return code: 0 14:50:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:50:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:50:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:50:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:50:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:50:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0261', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:50:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0261 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:50:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qitv9KXtvf/Render', 14:50:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:50:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:50:18 INFO - 'HOME': '/Users/cltbld', 14:50:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:50:18 INFO - 'LOGNAME': 'cltbld', 14:50:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:50:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:18 INFO - 'MOZ_NO_REMOTE': '1', 14:50:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:50:18 INFO - 'NO_EM_RESTART': '1', 14:50:18 INFO - 'PAGER': '/bin/cat', 14:50:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:18 INFO - 'PWD': '/builds/slave/test', 14:50:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:50:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:50:18 INFO - 'SHELL': '/bin/bash', 14:50:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xzPe8UuYwA/Listeners', 14:50:18 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 14:50:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:50:18 INFO - 'USER': 'cltbld', 14:50:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:50:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:18 INFO - 'XPC_FLAGS': '0x0', 14:50:18 INFO - 'XPC_SERVICE_NAME': '0', 14:50:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:50:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0261', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:50:19 INFO - mozversion application_buildid: 20161118124622 14:50:19 INFO - mozversion application_changeset: 46f55e7e305aeff69657cab5fdba3d6f1996d2d8 14:50:19 INFO - mozversion application_display_name: Nightly 14:50:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:50:19 INFO - mozversion application_name: Firefox 14:50:19 INFO - mozversion application_remotingname: firefox 14:50:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:50:19 INFO - mozversion application_vendor: Mozilla 14:50:19 INFO - mozversion application_version: 53.0a1 14:50:19 INFO - mozversion platform_buildid: 20161118124622 14:50:19 INFO - mozversion platform_changeset: 46f55e7e305aeff69657cab5fdba3d6f1996d2d8 14:50:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:50:19 INFO - mozversion platform_version: 53.0a1 14:50:19 INFO - using testdate: 1479509419 14:50:19 INFO - actual date: 1479509419 14:50:19 INFO - starting webserver on 'localhost:49243' 14:50:19 INFO - SUITE-START | Running 2 tests 14:50:19 INFO - TEST-START | dromaeo_css 14:50:19 INFO - operating with platform_type : mac_ 14:50:19 INFO - Initialising browser for dromaeo_css test... 14:50:19 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpIclgFO/profile http://localhost:49243/getInfo.html) 14:50:22 INFO - PROCESS | 1631 | 2016-11-18 14:50:22.128 plugin-container[1633:7478] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d43, name = 'com.apple.tsm.portname' 14:50:22 INFO - PROCESS | 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:50:22 INFO - PROCESS | 1631 | 2016-11-18 14:50:22.132 plugin-container[1633:7478] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b07, name = 'com.apple.CFPasteboardClient' 14:50:22 INFO - PROCESS | 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:50:22 INFO - PROCESS | 1631 | 2016-11-18 14:50:22.132 plugin-container[1633:7478] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:50:22 INFO - PROCESS | 1631 | __metrics Screen width/height:1600/1200 14:50:22 INFO - PROCESS | 1631 | colorDepth:24 14:50:22 INFO - PROCESS | 1631 | Browser inner width/height: 1024/689 14:50:22 INFO - PROCESS | 1631 | __metrics 14:50:22 ERROR - PROCESS | 1631 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 14:50:23 INFO - TEST-INFO | 1631: exit 0 14:50:23 INFO - Browser initialized. 14:50:23 INFO - Running cycle 1/1 for dromaeo_css test... 14:50:23 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpIclgFO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:50:25 INFO - PROCESS | 1634 | 2016-11-18 14:50:25.842 plugin-container[1635:7598] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3b, name = 'com.apple.tsm.portname' 14:50:25 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:50:25 INFO - PROCESS | 1634 | 2016-11-18 14:50:25.843 plugin-container[1635:7598] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 14:50:25 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:50:25 INFO - PROCESS | 1634 | 2016-11-18 14:50:25.843 plugin-container[1635:7598] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:50:35 INFO - PROCESS | 1634 | RSS: Main: 243044352 14:50:35 INFO - PROCESS | 1634 | 14:51:25 INFO - PROCESS | 1634 | 1479509485122 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] 14:53:38 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 14:53:41 INFO - PROCESS | 1634 | RSS: Main: 249970688 14:53:41 INFO - PROCESS | 1634 | 14:56:44 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 14:56:44 INFO - PROCESS | 1634 | RSS: Main: 259817472 14:56:44 INFO - PROCESS | 1634 | 14:59:46 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 14:59:47 INFO - PROCESS | 1634 | RSS: Main: 264212480 14:59:47 INFO - PROCESS | 1634 | 15:02:49 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 15:02:49 INFO - PROCESS | 1634 | RSS: Main: 262803456 15:02:49 INFO - PROCESS | 1634 | 15:05:52 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 15:05:53 INFO - PROCESS | 1634 | RSS: Main: 267055104 15:05:53 INFO - PROCESS | 1634 | 15:08:56 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 15:08:56 INFO - PROCESS | 1634 | RSS: Main: 269094912 15:08:56 INFO - PROCESS | 1634 | 15:08:56 INFO - PROCESS | 1634 | __start_tp_report 15:08:56 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 15:08:56 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 15:08:56 INFO - PROCESS | 1634 | |i|pagename|runs| 15:08:56 INFO - PROCESS | 1634 | |0;dojo.html;3215.3569286142765;3344.347852168828;3408;3420.640832712567;3440.191554984578;5529.281193444856;5596.888062238758;5610.69141197234;5643.46387093226;5671.7164141792955;5552.805651802188;5687.345955215152;5711.7715291388395;5737.856553586163;5845.210896528967;5101.846944591668;5129.615278854101;5197.740112994354;5251.711155886424;5300.840974770763;4116.794160291988;4572.542745725417;4636.907261854761;4940.308356830046;5198.818041368553;4758.405199350082;5099.184130539096;5237.476252374732;5274.367075950872;5332.280142180814;5085.160948443502;5120.078385890538;5162.92255616166;5183.792648294064;5234.057869583474;4290.506591741959;5083.745812709387;5153.819616313449;5173.637845350827;5191.480851914816;5435.755391007414;5515.227868098469;5687.971560142214;5703.54371650267;5709.400512946164;6104.06507294887;6121.666376154749;6142.406692085136;6157.938420615781;6211.937880621181;6242.344553821828;6252.968735156295;6256.624602523863;6259;6286.339934306878;5203.739813009334;5660.037793575102;5793.131030345482;5809.912851307234;5822.941770582324;6145.600535965148;6171.876562468815;6197.287311959182;6207.131001659771;6208.286047104551;6117.84705382369;6138.664296166128;6167.537434692416;6174.629522228681;6180;6081.57428979976;6148.78479253224;6236.875262494725;6255.343188965184;6261.5616906816995;6093.512518998469;6103.337669688931;6140.4473597376455;6170.382961703884;6224.284207316126;6163.84590385235;6201.069839524108;6226.439620434183;6235.438810507076;6271.529635277372;4462.888427789331;4933.358663373739;4934.383202099738;4944.134776414113;4960.23116416956;4335.891602709958;4345.130973805251;4358.302671572533;4383.49589797171;4451.59935605797;4731.432228132646;5755;5761.596688231783;5831.737571809279;5938.6436813791315;6159.291681456601;6212.751489940442;6225.315215326311;6230.314665386803;6248;5668;5883.352831188566;5894.410558944071;5919.289685237799;5928.7332070056955;5301.734913254322;5372.113601255749;5410.864728381744;5413.891722165535;5416.133418653076;6258.249010118815;6262.436380725757;6280.874382512416;6292.182016337847;6327.683615819098;6149.907751383644;6218.409251121137;6224.657643829632;6235.594686345373;6247;6370.140031095742;6405.551611387158;6413.262474815269;6423.325550817097;6445.806625801233;6077.392260773887;6120.051392034242;6129.724162412613;6209.037599172136;6217.564770466024;4843.740627436821;6003.279606447254;6183.350748171377;6191.876162476815;6260.812175634738;5051.924221136613;6060.030395136933;6084;6104.34177152232;6124.448799608057;6063.484603808725;6104.38956104386;6108.6945652716295;6116.2660480740815;6135.233095863017;4814.579698988737;5201.92197117036;5853.9121913172185;5917.881642367042;5930.703464826827;6032.517398608188;6039.78860739872;6072.362401947732;6074.42292982166;6076.483498902643;4953.801847926043;4962.900741985212;5864.589478736448;5992.64044157352;6010.579259451796 15:08:56 INFO - PROCESS | 1634 | |1;ext.html;440.1373308315701;485.4587135344091;494.86885975216575;498.9376327959003;566.235581964348;36559.63440365595;38690.226195476076;38943.610563894355;38993;38996.83009509719;39341.60658393415;40055;40169.79915100428;40203.39694904579;40212.798936005354;9263.166315031664;9441.575129119172;9447.90552094477;9453.62185512582;9454.81090378192;9278.257739380868;9376.953115234413;9386.81226375472;9399.013103624124;9399.859002114974;9381.061893810633;9383.43699378036;9409.106134917172;9433.575489103006;9443.38617989832;9360.672376466826;9390.201832844217;9409;9424.811503769886;9425.575849086808;9199.264058875275;9231.953840230823;9307.581158847868;9331.626734930594;9339.066093390675;38239.23521529582;38279.660211892726;38510.3042787005;38543;38606.42090368647;3363.2432702641954;3417.8974630761118;3470.670286322795;3901.726879118463;4085.3259212229946;28863;29729.851350743324;29909.850450747606;30043.69956300431;30118;3209.9679003209903;3258.6904244096772;3286.227736481949;3292.884749033796;3350.0452371074125;455319;458997;461025.38974610495;462104;462755;57769;57977.710111449174;58119.837603247695;58131.709341453025;58342.58231594521;59593.70203149043;59887.40112598818;59981.80036399248;60092.39907600868;60127;15428.997115187702;15676.137812420198;15778.526644200692;15820.841791582166;15823.525294241192;11784.705382365339;12203.755924881452;12211.877881221075;12246.693832654255;12262.325572093441;12763.975026101054;15707.450239241572;15993.920030399773;16046.438374656831;16173.191340432932;3132.561441398206;3220.146661134801;3261.315123823976;6444.645544495098;6506.707198176094;929.7257309093834;985.8866230383454;1025.6512785652915;1040.422565476168;1059.433203236265;27833.443331133265;29366.342939022263;29409.264768380533;30058.098257052323;30084.69915300819;996.4619105682995;1019.1235537437798;1054.5201933120566;1067.9305845120043;1084.9566017359218;15042.473513426978;15251.23743812805;15278.923605381902;15412.229388530528;15461.96545847753;582472;582767;585238;587280;590491;56008;56537;56645.43354566402;56719;56790.43209567934;1284.8907842833464;1341.4701193028893;1354;1357.5859362894412;1358.8844948179317;23336.416589584718;26427.6361164701;29166.645835729163;29186.124416267547;29749.256268593457;52194.739026306146;53872.73063634813;53985.73007134939;57192.71403642955;57375.71312143413;559129;582287;587641;589396;591432;39698.60301396949;40010.19979600333;40287.39568906528;40324.39513407242;40455.59544404636;44581;45022.77488612536;45646.63060108202;45710.77144614256;46068.30897536473;38057.61942380541;38247.42628860514;38341.23317533689;39494.61768838077;39529.604703953744;30412.134058550524;37809.810950945066;38007.41487043838;38822.6117738819;39059.80470097631;36556.26887462289;37170;37363;37379.81310093432;37508.624913750515;31378.686213137575;33432.1641958953;33525.16187095342;33605;33650.66349336573;24756.504869902863;25604.743952560235;29547.409051818413;30810.69189308078;32581.674183258812 15:08:56 INFO - PROCESS | 1634 | |2;jquery.html;335.9344927739091;374.1226823099832;379.8176875099951;385.22569635033574;401.7248184993278;19144.234230630776;19149.617007659857;19560;19908;20118.195272189132;19550.608987820237;19615.607687846234;19986.70019949702;20264.18943242272;20330.39008829734;4895.241237608177;4983.103041452537;5242.397124330712;5325.893482130355;5443.265159203516;5820.534357251431;6000.309964354112;6004.819855404323;6010.789622363196;6017.819465416044;5312.521873031426;5348.973255133719;5529.921665275273;5939.287285525743;5963.194968679238;5284;5294.788208471657;5371.973140134294;5376.435474275184;5377.354717433914;4405.867823965286;4521.208788462006;5225.294585230983;5231.843044708665;5334.146536554172;12687.365631718378;12740.235585864877;12989.740205195938;13037.282949437777;13191.010674199473;2073.8859362735043;2251.617225071742;2304.308707387777;2379.9524009519887;2388.474535602165;9509.381890177116;10038.64864729731;10207.081362677394;12256.938715306367;14292.785608215885;1792.059168936306;1844.4651051195137;1868.4955062133283;1887.5281179705073;1889.7527631763107;63777.681111594145;75477;77855;120726;129271;9117.626478203107;9387.953060234655;9687.41875487473;9905.20758339331;9970.551325190383;12217.633470995885;12236.449359778831;12237.877621223852;12282.692932676577;12299.446524906401;7712.460127791113;7846.254605812439;7862;7971.641276142587;8050.5169689818795;7978.401619878532;7989.320907722792;8024.5586492742295;8142.18578142181;8235.752927412188;3291.4075466415798;3811.19964807388;3863.864764733221;3870.3420418528917;3889.8055097245024;1903.7525121734086;1943.319838056697;1943.87364821289;1945.5233467800197;1954.7361106250758;866.2204016385303;882.2324577617513;909.4679612426672;920.3465539467053;937.4188003437912;20318.08568614416;20756.68864967027;21021.05405256767;21157.30741540704;21584.244551440624;902.6479672927563;920.9447433154032;958.1328897347911;992.9156021738089;998.7553049502918;9732.951335243279;11131.777364452828;11203.551857925591;11204.271722338022;11243.718907027227;552398;554442;554915;590289;596519;102787;113769;114411.42794286142;114777;116152;946.8958414574391;960.8894977077586;972.0668158567854;972.9951350243346;998.0368943969105;18389.448316550526;18532.536686582942;18916.527086822938;19037.333693320666;19168.808311916702;28860;51931.2210316838;52483;52633;53156.93686126178;49095;67522;74859.62570187332;75412;77422;5806.796762113306;6604.108445360007;6867.725290988305;7291.234420385783;7656.540607563564;9820.803583928138;12021.75956480883;12345;12423.571289301846;12495.500179992698;10397.376157430579;10485.790284194121;10756.731081723019;10852.403117828595;10997;10284.897151028394;10381;10635.20235982289;10715.892841071802;10836.783264334512;10026.598936042477;10727.463626818471;10951.069159121245;10975.451227438436;11055.115590752881;6699.832504187434;7223.927760722326;7234.240404757425;7394.336274338231;7466.850662986819;8142.674293028213;8309.916900830915;9908.157806586521;10186;10537.367757934548 15:08:56 INFO - PROCESS | 1634 | |3;mootools.html;1252.254908329544;1472.8748056415204;1630.2582325042108;1780.528160037591;1817.6637322095405;7224.566526008443;7630.236976302381;7863.174366691486;8171.10117887032;8649.178328058832;8109.91890081099;8403.705870294541;8411.158884111586;8542.060373358941;8542.530160841152;1956.7358406615067;2281.646344816556;2316.4787922717337;2335.92992210234;2338.088145623208;2279.783420575051;2347.0611755297846;2362.7400985891536;2375.7149142102885;2379.4170428245106;2312;2319.014418871981;2322.036354912709;2335.614623587106;2341.672165896776;2266.648669456237;2286.199830059474;2316.3282648032136;2317.154238702878;2321.1527792355837;2306.573283942476;2348.929532114022;2350.3654013416453;2352.9647055294186;2358.2217868103658;8422.747317580483;8524.8721269181;8540.274076703488;8545.871811922827;8589.570521473965;5122.718250496221;5246.8688282792855;5251.684898906078;5288.10102282609;5312.229726689647;3254.8047117173046;3400.1839558506026;3547.3260080584605;3595.8741444049333;3597.4963505109304;1005.6228914157191;1035.6685860524635;1084.8264277715607;1088.2871719024051;1101.3887292552631;9646.228301735844;11184.993350598405;11244;11245.493952772227;11288.548458061668;4499.4150760400935;4621.4223222097235;4718.268668356411;4725.00774837288;4731.124741922756;9524.619015239452;9600.375975561707;9620.615175393046;9622.663206787729;9632.614695412245;5230.764615592308;5232.110541208004;5239.161734122522;5251.36983561975;5267.446918073624;3820.1213720843807;4096.067774936035;4761.833335833229;4812.628400905725;4822.807087716452;3109.891153809651;3808.2383523294898;3891.3190191716335;3898.5321761388814;3908.4332771747936;1262.7790136726037;1268.9428975696117;1278.7186818899827;1278.725074109071;1288.0339745191106;608.6317777744489;806.6370133439858;811.8944537210125;896.9865452018225;899.6491368366343;5186.40356359016;5593.328800543961;5719.685417302088;5764.193012978187;5774.595778295563;416.57509340472546;430.694207112947;431.4046615670355;431.9481662200493;437.03633488158533;3101.3022070034062;3477.808720520345;3777.792221427848;3789.905252368658;3894.883153505399;8624.482531048157;9414.681944527772;9780.804383912424;10189.286749927582;10325.63860264887;8735.213830755136;8884.822303553892;10053.497325133714;10237.59049638021;10411.427371494488;7785.883211751829;8060.717874874351;8074.313683336982;8082.595870206466;8097.190280971856;5773.393793651606;5810.7094645266725;5905.055191169392;5922.763089476372;5925.111233315038;9664.390614534177;9700.805983880142;9708.466034368177;9710.70867873965;9726.416415015121;7496.700131994659;8646;9572.66495672676;9669.468179250209;9715.36850104741;5774.913376299275;6640.966795165993;6838.076859624086;7095.077639906779;7277.59973201479;6253;8109.215972486044;8121.309688676529;8130;8136.511809291462;7205.71177152908;7327.230640782855;7393.963030184815;7406.629668516445;7484.812879678052;7055.576665400093;7123.964380178066;7178.641067946686;7280.162781280221;7312.744053958086;6552.312007239171;6687.431568316748;6705.262421133574;6725.730970761115;6727.629980350932;4680.976595117003;4762.523747625349;4788.186008378514;4842.4673285937815;4915.483874193158;4802.903941921212;4846.200376937907;4912.680675756064;4917.9016419672125;4923.064617722621 15:08:56 INFO - PROCESS | 1634 | |4;prototype.html;274.9766269867061;288.3368253018059;294.2628715068755;306.03903742249344;309.58206421331204;4777.8805529861775;5409.540189083923;5454.945450545493;5531.972340138299;5660.490555849972;5237.921431178526;5340.092184328664;5439.809606663767;5454.34547854258;5472.288602481682;3648.890533284006;4106.219818234534;4128.2042311594405;4157.544859299236;4171.416001759756;3791.4502397152396;4065.26825171469;4162.146759914225;4171.958280417202;4204.726692764976;3558.861164427384;4036.293648611496;4079.755214687128;4091.365838295069;4093.5087789465306;3734.4024956007042;4035.636792688672;4043.737157084795;4044.4944381952255;4074.8370065197655;2774.6392968914115;3019.8641061152302;3509.964900351015;3524.2246705724956;3525.294941011782;4016.0205696202356;4265.616094551505;4820.445648750404;5115.923261151086;5317.8404647860625;3934.0361611405388;4072.9592704072875;4230.238557059728;4271.743695378287;4629.120467111238;5446.509814116748;5449.56403487724;5506.504414602665;5707.400722924075;5721.742521586497;3544.4506101554302;3794.4687743715904;3830.7893065881367;3841.615838416164;3856.903577410559;4861.951380486185;5190.4550022247495;5296.708681022542;5615.494605485485;5986.940130598682;3282.0810173151553;3817.427385892083;3886.8833934981994;3917.7845218513257;3925.331734013033;3687.410014397737;3987.441758153861;3992.54085780139;3996.360582306875;3999.3601023836045;4125.546189919107;4564.748938808331;4635.745034023161;4647.18674232008;4688.343631891538;5737.88524229513;5808.273965754281;5845.386234445407;5870.412958704181;5872.970635146797;1055.6569115037644;1110.9277896936674;1200.789861774186;1294.7734146524322;1318.9975618529795;797.8005498625344;807.1403954788132;903.846346121161;922.6943874417758;934.2806039349663;4504.436945381827;4722.645801564897;5167.68993860362;5200.7919683213;5213.452587478336;4734.431868175841;5002.674826136289;5621.887562248732;5649.4350564944;5655.264815574032;4501.954980450154;5055.69665820052;5112.258722485219;5126.307948426989;5174.534291913746;2366.0598309386137;2648.25848762343;2959.9852000739857;2978.2107741448535;2981.761459083268;5664.6601203927075;5843.912341314884;5880.470757631833;5940.31686356066;5979.970100149471;4724.456687480915;5563.860903477445;5737.967165910176;5770.538356931435;5795.710214489259;5230;5355.866103347447;5521.337439507285;5834.5624078194305;5903.409659034062;4934.580560652241;5107.9489205107475;5331.413544510178;5698.971505142614;5742.655440673573;4677.742724150068;4817.325574419514;5843.29880414336;5912.70436478183;5922.851928701644;5505.889882202414;6226.159468471698;6238.282597501346;6239.194091604028;6276.838784824822;2886.826790392583;3212.6947939945667;3421.8460169291943;3909.354956432157;4013.478247827764;4642.791074401593;4843.370361852936;4917.852464426073;5070.8225212117395;5935;5271;5300.6024548158275;5653.915191272216;5802.883942321046;5839.941600584109;5211.557017653542;5471.616986811045;5647.124695672177;5711.771529138788;5834.27071616048;4982.829035176803;5336.866578335573;5461.726913654381;5622.690752008679;5643.827126556223;4535.818567257273;5288.920666190087;5773.191753154478;5773.797917072882;5791.305043394819;4954.529319714621;5261.657992230493;5601.579881508822;5623.606347555632;5736.397678243724 15:08:56 INFO - PROCESS | 1634 | |5;yui.html;638.4955884850968;679.2562144451825;688.0711040095869;693.1855070292405;693.4902846407889;14014.439422423104;14762.040467369641;14801.407943682267;14814.185219812905;14815.703685926288;13200.141990770593;13347.199168049923;13351.065425420224;13354.399052042658;13371.531996380128;642.7043559962423;664.5945972956492;798.3373799746197;799.2287442617873;817.9141190175035;815.4047545291941;828.1635548096436;829.5810615639094;830.1822704635958;832.3216578488513;862.7109918177387;871.4988881393192;873.1922971251566;876.430320291809;876.6011464783509;869.678219058946;870.2341939093557;872.3370238618633;872.8123453457474;875.448467465499;635.895077312243;638.9488840892764;648.9810996735127;651.5797310734597;652.0512654088291;13218.66953326165;13446.865531344756;13594.11638243521;13595.388207530586;14153.433862645585;13488.055836091478;13525.39135738894;13624.455021799116;13669.179849209078;13954.232517211549;11148.721281967935;11208;11280.379579123144;11314.208005439623;11683.106200550723;3133.2480204750923;3579.659932306453;3625.854965801365;3638.6179451157514;3641.7632853864416;64809.01033308853;88008.11991880063;89695;90101.54949225277;92532.68668283279;10474.109700675375;10497.685069447929;10575.15398768112;10886.782264354826;10902.890971090346;20247.797522024885;20325.898370508054;20447.488812779502;20463.4884127898;20501.692474612595;7292.41660667156;7307;7355.117385913618;7364.852702945911;7445.441591880631;4057.2494088593116;4107.196029776675;4109.239790638741;4124.587541245852;4147.6267135957905;3320.734341252694;3377.4933759936207;3396.9490457643155;3406.250624862576;3419.709324707378;614.3181069013392;626.8526896179394;634.1470721879065;637.8947473666885;658.0524045374646;637.5951270942892;652.2043107408954;653.4282502810041;653.9247986481615;654.8068319845657;8768.712500249198;8860.955695221612;9030.593623286968;9132.634694612141;9224.677136300197;623.4980840423502;645.3417514135556;645.515863102673;666.3037126203129;680.1158493957835;3435.896923092311;4112.444819949328;4205.453291072202;4220.008298049956;4360.697990317322;116671.6665666682;117957;118240.40879795718;120361.39819300847;122518.77481225073;104716.95283047225;105165.47417262864;107003.46498267459;107170.92829071765;107468.4626576862;73635.63182184161;74937.87593186107;76393;78065.60967195127;79283.20716792873;7295.379892709179;7884.763457096296;8107.594620269081;8350.749477515685;8402.163638793141;41090;41095.7945210272;51713.48286517087;52392.73803630957;52948.47051529436;52693;53905;68533.31466685269;73079.63460182665;74436.62781686056;10661.57353705874;12113.757724845278;12149.94784466191;12251.264924104582;12312;13276.169563769889;13820.101693389897;14172.858271417566;14187.219702916438;14332.785008225093;12797.552085676956;12984.157129291667;13003.739925201633;13029.739405211652;13623.678942455026;12929.224246545238;12974.935125324313;13154;13158.40787164599;13374.665633359244;11923.82114268304;12574.1198116131;13212.933935330262;13282.800757988445;13453.260070696206;10256.743581410525;10969.798840743562;11162.162837787037;11196.94401527987;11422.029127524254;9167.471354762934;10362.637307694195;11203.383813890314;11417.086633069168;11446.885531144915 15:08:56 INFO - PROCESS | 1634 | __end_tp_report 15:08:56 INFO - PROCESS | 1634 | __start_cc_report 15:08:56 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,360 15:08:56 INFO - PROCESS | 1634 | __end_cc_report 15:08:56 INFO - PROCESS | 1634 | __startTimestamp1479510536564__endTimestamp 15:08:56 INFO - PROCESS | 1634 | 15:08:56 INFO - PROCESS | 1634 | ------- Summary: start ------- 15:08:56 INFO - PROCESS | 1634 | Number of tests: 6 15:08:56 INFO - PROCESS | 1634 | 15:08:56 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:5661.21 Median:5928.73 stddev:690.89 (11.7%) stddev-sans-first:665.84 15:08:56 INFO - PROCESS | 1634 | Values: 3215.4 3344.3 3408.0 3420.6 3440.2 5529.3 5596.9 5610.7 5643.5 5671.7 5552.8 5687.3 5711.8 5737.9 5845.2 5101.8 5129.6 5197.7 5251.7 5300.8 4116.8 4572.5 4636.9 4940.3 5198.8 4758.4 5099.2 5237.5 5274.4 5332.3 5085.2 5120.1 5162.9 5183.8 5234.1 4290.5 5083.7 5153.8 5173.6 5191.5 5435.8 5515.2 5688.0 5703.5 5709.4 6104.1 6121.7 6142.4 6157.9 6211.9 6242.3 6253.0 6256.6 6259.0 6286.3 5203.7 5660.0 5793.1 5809.9 5822.9 6145.6 6171.9 6197.3 6207.1 6208.3 6117.8 6138.7 6167.5 6174.6 6180.0 6081.6 6148.8 6236.9 6255.3 6261.6 6093.5 6103.3 6140.4 6170.4 6224.3 6163.8 6201.1 6226.4 6235.4 6271.5 4462.9 4933.4 4934.4 4944.1 4960.2 4335.9 4345.1 4358.3 4383.5 4451.6 4731.4 5755.0 5761.6 5831.7 5938.6 6159.3 6212.8 6225.3 6230.3 6248.0 5668.0 5883.4 5894.4 5919.3 5928.7 5301.7 5372.1 5410.9 5413.9 5416.1 6258.2 6262.4 6280.9 6292.2 6327.7 6149.9 6218.4 6224.7 6235.6 6247.0 6370.1 6405.6 6413.3 6423.3 6445.8 6077.4 6120.1 6129.7 6209.0 6217.6 4843.7 6003.3 6183.4 6191.9 6260.8 5051.9 6060.0 6084.0 6104.3 6124.4 6063.5 6104.4 6108.7 6116.3 6135.2 4814.6 5201.9 5853.9 5917.9 5930.7 6032.5 6039.8 6072.4 6074.4 6076.5 4953.8 4962.9 5864.6 5992.6 6010.6 15:08:56 INFO - PROCESS | 1634 | 15:08:56 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:67817.52 Median:21480.77 stddev:145640.79 (678.0%) stddev-sans-first:145961.50 15:08:56 INFO - PROCESS | 1634 | Values: 440.1 485.5 494.9 498.9 566.2 36559.6 38690.2 38943.6 38993.0 38996.8 39341.6 40055.0 40169.8 40203.4 40212.8 9263.2 9441.6 9447.9 9453.6 9454.8 9278.3 9377.0 9386.8 9399.0 9399.9 9381.1 9383.4 9409.1 9433.6 9443.4 9360.7 9390.2 9409.0 9424.8 9425.6 9199.3 9232.0 9307.6 9331.6 9339.1 38239.2 38279.7 38510.3 38543.0 38606.4 3363.2 3417.9 3470.7 3901.7 4085.3 28863.0 29729.9 29909.9 30043.7 30118.0 3210.0 3258.7 3286.2 3292.9 3350.0 455319.0 458997.0 461025.4 462104.0 462755.0 57769.0 57977.7 58119.8 58131.7 58342.6 59593.7 59887.4 59981.8 60092.4 60127.0 15429.0 15676.1 15778.5 15820.8 15823.5 11784.7 12203.8 12211.9 12246.7 12262.3 12764.0 15707.5 15993.9 16046.4 16173.2 3132.6 3220.1 3261.3 6444.6 6506.7 929.7 985.9 1025.7 1040.4 1059.4 27833.4 29366.3 29409.3 30058.1 30084.7 996.5 1019.1 1054.5 1067.9 1085.0 15042.5 15251.2 15278.9 15412.2 15462.0 582472.0 582767.0 585238.0 587280.0 590491.0 56008.0 56537.0 56645.4 56719.0 56790.4 1284.9 1341.5 1354.0 1357.6 1358.9 23336.4 26427.6 29166.6 29186.1 29749.3 52194.7 53872.7 53985.7 57192.7 57375.7 559129.0 582287.0 587641.0 589396.0 591432.0 39698.6 40010.2 40287.4 40324.4 40455.6 44581.0 45022.8 45646.6 45710.8 46068.3 38057.6 38247.4 38341.2 39494.6 39529.6 30412.1 37809.8 38007.4 38822.6 39059.8 36556.3 37170.0 37363.0 37379.8 37508.6 31378.7 33432.2 33525.2 33605.0 33650.7 24756.5 25604.7 29547.4 30810.7 32581.7 15:08:56 INFO - PROCESS | 1634 | 15:08:56 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:31994.25 Median:2145.77 stddev:94634.30 (4410.3%) stddev-sans-first:94869.92 15:08:56 INFO - PROCESS | 1634 | Values: 335.9 374.1 379.8 385.2 401.7 19144.2 19149.6 19560.0 19908.0 20118.2 19550.6 19615.6 19986.7 20264.2 20330.4 4895.2 4983.1 5242.4 5325.9 5443.3 5820.5 6000.3 6004.8 6010.8 6017.8 5312.5 5349.0 5529.9 5939.3 5963.2 5284.0 5294.8 5372.0 5376.4 5377.4 4405.9 4521.2 5225.3 5231.8 5334.1 12687.4 12740.2 12989.7 13037.3 13191.0 2073.9 2251.6 2304.3 2380.0 2388.5 9509.4 10038.6 10207.1 12256.9 14292.8 1792.1 1844.5 1868.5 1887.5 1889.8 63777.7 75477.0 77855.0 120726.0 129271.0 9117.6 9388.0 9687.4 9905.2 9970.6 12217.6 12236.4 12237.9 12282.7 12299.4 7712.5 7846.3 7862.0 7971.6 8050.5 7978.4 7989.3 8024.6 8142.2 8235.8 3291.4 3811.2 3863.9 3870.3 3889.8 1903.8 1943.3 1943.9 1945.5 1954.7 866.2 882.2 909.5 920.3 937.4 20318.1 20756.7 21021.1 21157.3 21584.2 902.6 920.9 958.1 992.9 998.8 9733.0 11131.8 11203.6 11204.3 11243.7 552398.0 554442.0 554915.0 590289.0 596519.0 102787.0 113769.0 114411.4 114777.0 116152.0 946.9 960.9 972.1 973.0 998.0 18389.4 18532.5 18916.5 19037.3 19168.8 28860.0 51931.2 52483.0 52633.0 53156.9 49095.0 67522.0 74859.6 75412.0 77422.0 5806.8 6604.1 6867.7 7291.2 7656.5 9820.8 12021.8 12345.0 12423.6 12495.5 10397.4 10485.8 10756.7 10852.4 10997.0 10284.9 10381.0 10635.2 10715.9 10836.8 10026.6 10727.5 10951.1 10975.5 11055.1 6699.8 7223.9 7234.2 7394.3 7466.9 8142.7 8309.9 9908.2 10186.0 10537.4 15:08:56 INFO - PROCESS | 1634 | 15:08:56 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:5428.97 Median:5208.58 stddev:3006.40 (57.7%) stddev-sans-first:2998.45 15:08:56 INFO - PROCESS | 1634 | Values: 1252.3 1472.9 1630.3 1780.5 1817.7 7224.6 7630.2 7863.2 8171.1 8649.2 8109.9 8403.7 8411.2 8542.1 8542.5 1956.7 2281.6 2316.5 2335.9 2338.1 2279.8 2347.1 2362.7 2375.7 2379.4 2312.0 2319.0 2322.0 2335.6 2341.7 2266.6 2286.2 2316.3 2317.2 2321.2 2306.6 2348.9 2350.4 2353.0 2358.2 8422.7 8524.9 8540.3 8545.9 8589.6 5122.7 5246.9 5251.7 5288.1 5312.2 3254.8 3400.2 3547.3 3595.9 3597.5 1005.6 1035.7 1084.8 1088.3 1101.4 9646.2 11185.0 11244.0 11245.5 11288.5 4499.4 4621.4 4718.3 4725.0 4731.1 9524.6 9600.4 9620.6 9622.7 9632.6 5230.8 5232.1 5239.2 5251.4 5267.4 3820.1 4096.1 4761.8 4812.6 4822.8 3109.9 3808.2 3891.3 3898.5 3908.4 1262.8 1268.9 1278.7 1278.7 1288.0 608.6 806.6 811.9 897.0 899.6 5186.4 5593.3 5719.7 5764.2 5774.6 416.6 430.7 431.4 431.9 437.0 3101.3 3477.8 3777.8 3789.9 3894.9 8624.5 9414.7 9780.8 10189.3 10325.6 8735.2 8884.8 10053.5 10237.6 10411.4 7785.9 8060.7 8074.3 8082.6 8097.2 5773.4 5810.7 5905.1 5922.8 5925.1 9664.4 9700.8 9708.5 9710.7 9726.4 7496.7 8646.0 9572.7 9669.5 9715.4 5774.9 6641.0 6838.1 7095.1 7277.6 6253.0 8109.2 8121.3 8130.0 8136.5 7205.7 7327.2 7394.0 7406.6 7484.8 7055.6 7124.0 7178.6 7280.2 7312.7 6552.3 6687.4 6705.3 6725.7 6727.6 4681.0 4762.5 4788.2 4842.5 4915.5 4802.9 4846.2 4912.7 4917.9 4923.1 15:08:56 INFO - PROCESS | 1634 | 15:08:56 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4503.09 Median:5063.26 stddev:1421.82 (28.1%) stddev-sans-first:1389.94 15:08:56 INFO - PROCESS | 1634 | Values: 275.0 288.3 294.3 306.0 309.6 4777.9 5409.5 5454.9 5532.0 5660.5 5237.9 5340.1 5439.8 5454.3 5472.3 3648.9 4106.2 4128.2 4157.5 4171.4 3791.5 4065.3 4162.1 4172.0 4204.7 3558.9 4036.3 4079.8 4091.4 4093.5 3734.4 4035.6 4043.7 4044.5 4074.8 2774.6 3019.9 3510.0 3524.2 3525.3 4016.0 4265.6 4820.4 5115.9 5317.8 3934.0 4073.0 4230.2 4271.7 4629.1 5446.5 5449.6 5506.5 5707.4 5721.7 3544.5 3794.5 3830.8 3841.6 3856.9 4862.0 5190.5 5296.7 5615.5 5986.9 3282.1 3817.4 3886.9 3917.8 3925.3 3687.4 3987.4 3992.5 3996.4 3999.4 4125.5 4564.7 4635.7 4647.2 4688.3 5737.9 5808.3 5845.4 5870.4 5873.0 1055.7 1110.9 1200.8 1294.8 1319.0 797.8 807.1 903.8 922.7 934.3 4504.4 4722.6 5167.7 5200.8 5213.5 4734.4 5002.7 5621.9 5649.4 5655.3 4502.0 5055.7 5112.3 5126.3 5174.5 2366.1 2648.3 2960.0 2978.2 2981.8 5664.7 5843.9 5880.5 5940.3 5980.0 4724.5 5563.9 5738.0 5770.5 5795.7 5230.0 5355.9 5521.3 5834.6 5903.4 4934.6 5107.9 5331.4 5699.0 5742.7 4677.7 4817.3 5843.3 5912.7 5922.9 5505.9 6226.2 6238.3 6239.2 6276.8 2886.8 3212.7 3421.8 3909.4 4013.5 4642.8 4843.4 4917.9 5070.8 5935.0 5271.0 5300.6 5653.9 5802.9 5839.9 5211.6 5471.6 5647.1 5711.8 5834.3 4982.8 5336.9 5461.7 5622.7 5643.8 4535.8 5288.9 5773.2 5773.8 5791.3 4954.5 5261.7 5601.6 5623.6 5736.4 15:08:56 INFO - PROCESS | 1634 | 15:08:56 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:20267.61 Median:4082.22 stddev:30470.92 (746.4%) stddev-sans-first:30520.75 15:08:56 INFO - PROCESS | 1634 | Values: 638.5 679.3 688.1 693.2 693.5 14014.4 14762.0 14801.4 14814.2 14815.7 13200.1 13347.2 13351.1 13354.4 13371.5 642.7 664.6 798.3 799.2 817.9 815.4 828.2 829.6 830.2 832.3 862.7 871.5 873.2 876.4 876.6 869.7 870.2 872.3 872.8 875.4 635.9 638.9 649.0 651.6 652.1 13218.7 13446.9 13594.1 13595.4 14153.4 13488.1 13525.4 13624.5 13669.2 13954.2 11148.7 11208.0 11280.4 11314.2 11683.1 3133.2 3579.7 3625.9 3638.6 3641.8 64809.0 88008.1 89695.0 90101.5 92532.7 10474.1 10497.7 10575.2 10886.8 10902.9 20247.8 20325.9 20447.5 20463.5 20501.7 7292.4 7307.0 7355.1 7364.9 7445.4 4057.2 4107.2 4109.2 4124.6 4147.6 3320.7 3377.5 3396.9 3406.3 3419.7 614.3 626.9 634.1 637.9 658.1 637.6 652.2 653.4 653.9 654.8 8768.7 8861.0 9030.6 9132.6 9224.7 623.5 645.3 645.5 666.3 680.1 3435.9 4112.4 4205.5 4220.0 4360.7 116671.7 117957.0 118240.4 120361.4 122518.8 104717.0 105165.5 107003.5 107170.9 107468.5 73635.6 74937.9 76393.0 78065.6 79283.2 7295.4 7884.8 8107.6 8350.7 8402.2 41090.0 41095.8 51713.5 52392.7 52948.5 52693.0 53905.0 68533.3 73079.6 74436.6 10661.6 12113.8 12149.9 12251.3 12312.0 13276.2 13820.1 14172.9 14187.2 14332.8 12797.6 12984.2 13003.7 13029.7 13623.7 12929.2 12974.9 13154.0 13158.4 13374.7 11923.8 12574.1 13212.9 13282.8 13453.3 10256.7 10969.8 11162.2 11196.9 11422.0 9167.5 10362.6 11203.4 11417.1 11446.9 15:08:56 INFO - PROCESS | 1634 | -------- Summary: end -------- 15:08:56 INFO - PROCESS | 1634 | 15:08:57 INFO - TEST-INFO | 1634: exit 0 15:08:57 INFO - TEST-OK | dromaeo_css | took 1118100ms 15:08:57 INFO - TEST-START | kraken 15:08:57 INFO - operating with platform_type : mac_ 15:08:57 INFO - Initialising browser for kraken test... 15:08:57 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpQmGcV2/profile http://localhost:49243/getInfo.html) 15:09:00 INFO - PROCESS | 1645 | 2016-11-18 15:09:00.198 plugin-container[1646:9926] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 15:09:00 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:09:00 INFO - PROCESS | 1645 | 2016-11-18 15:09:00.203 plugin-container[1646:9926] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a1b, name = 'com.apple.CFPasteboardClient' 15:09:00 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:09:00 INFO - PROCESS | 1645 | 2016-11-18 15:09:00.203 plugin-container[1646:9926] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:09:00 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 15:09:00 INFO - PROCESS | 1645 | colorDepth:24 15:09:00 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 15:09:00 INFO - PROCESS | 1645 | __metrics 15:09:00 ERROR - PROCESS | 1645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 15:09:01 INFO - TEST-INFO | 1645: exit 0 15:09:01 INFO - Browser initialized. 15:09:01 INFO - Running cycle 1/1 for kraken test... 15:09:01 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpQmGcV2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:09:04 INFO - PROCESS | 1647 | 2016-11-18 15:09:04.102 plugin-container[1648:10041] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x453f, name = 'com.apple.tsm.portname' 15:09:04 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:09:04 INFO - PROCESS | 1647 | 2016-11-18 15:09:04.103 plugin-container[1648:10041] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8847, name = 'com.apple.CFPasteboardClient' 15:09:04 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:09:04 INFO - PROCESS | 1647 | 2016-11-18 15:09:04.103 plugin-container[1648:10041] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:09:13 INFO - PROCESS | 1647 | RSS: Main: 243191808 15:09:13 INFO - PROCESS | 1647 | 15:09:16 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 15:09:17 INFO - PROCESS | 1647 | RSS: Main: 255143936 15:09:17 INFO - PROCESS | 1647 | 15:09:20 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 15:09:21 INFO - PROCESS | 1647 | RSS: Main: 262696960 15:09:21 INFO - PROCESS | 1647 | 15:09:24 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 15:09:25 INFO - PROCESS | 1647 | RSS: Main: 265449472 15:09:25 INFO - PROCESS | 1647 | 15:09:26 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 15:09:27 INFO - PROCESS | 1647 | RSS: Main: 266649600 15:09:27 INFO - PROCESS | 1647 | 15:09:29 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:09:30 INFO - PROCESS | 1647 | RSS: Main: 268234752 15:09:30 INFO - PROCESS | 1647 | 15:09:33 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 15:09:33 INFO - PROCESS | 1647 | RSS: Main: 274313216 15:09:33 INFO - PROCESS | 1647 | 15:09:36 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 15:09:37 INFO - PROCESS | 1647 | RSS: Main: 273207296 15:09:37 INFO - PROCESS | 1647 | 15:09:40 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 15:09:41 INFO - PROCESS | 1647 | RSS: Main: 273596416 15:09:41 INFO - PROCESS | 1647 | 15:09:42 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:09:43 INFO - PROCESS | 1647 | RSS: Main: 272601088 15:09:43 INFO - PROCESS | 1647 | 15:09:45 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:09:46 INFO - PROCESS | 1647 | RSS: Main: 272678912 15:09:46 INFO - PROCESS | 1647 | 15:09:48 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:09:48 INFO - PROCESS | 1647 | RSS: Main: 272625664 15:09:48 INFO - PROCESS | 1647 | 15:09:51 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:09:52 INFO - PROCESS | 1647 | RSS: Main: 272965632 15:09:52 INFO - PROCESS | 1647 | 15:09:55 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:09:56 INFO - PROCESS | 1647 | RSS: Main: 273076224 15:09:56 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 15:09:58 INFO - PROCESS | 1647 | RSS: Main: 274923520 15:09:58 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | __start_tp_report 15:09:58 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 15:09:58 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 15:09:58 INFO - PROCESS | 1647 | |i|pagename|runs| 15:09:58 INFO - PROCESS | 1647 | |0;ai-astar;152;130;121;119;117;120;117;119;118;124 15:09:58 INFO - PROCESS | 1647 | |1;audio-beat-detection;180;149;141;152;121;145;139;120;143;115 15:09:58 INFO - PROCESS | 1647 | |2;audio-dft;207;208;199;197;197;194;198;197;198;196 15:09:58 INFO - PROCESS | 1647 | |3;audio-fft;82;62;61;81;60;59;60;60;81;60 15:09:58 INFO - PROCESS | 1647 | |4;audio-oscillator;111;72;88;57;92;101;119;97;75;89 15:09:58 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;117;88;91;89;92;89;93;87;93;74 15:09:58 INFO - PROCESS | 1647 | |6;imaging-darkroom;96;104;138;150;96;96;98;101;147;95 15:09:58 INFO - PROCESS | 1647 | |7;imaging-desaturate;86;133;139;95;91;92;95;107;143;144 15:09:58 INFO - PROCESS | 1647 | |8;json-parse-financial;55;58;57;58;58;56;58;58;57;57 15:09:58 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;69;70;76;84;71;68;70;72;73;98 15:09:58 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;91;94;89;90;86;90;88;92;89;88 15:09:58 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;155;159;162;168;149;150;149;158;227;187 15:09:58 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;181;204;238;181;179;177;175;158;240;181 15:09:58 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;67;70;67;68;81;92;93;74;71;76 15:09:58 INFO - PROCESS | 1647 | __end_tp_report 15:09:58 INFO - PROCESS | 1647 | __start_cc_report 15:09:58 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,954 15:09:58 INFO - PROCESS | 1647 | __end_cc_report 15:09:58 INFO - PROCESS | 1647 | __startTimestamp1479510598481__endTimestamp 15:09:58 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | ------- Summary: start ------- 15:09:58 INFO - PROCESS | 1647 | Number of tests: 14 15:09:58 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:123.70 Median:120.50 stddev:10.69 (8.9%) stddev-sans-first:4.16 15:09:58 INFO - PROCESS | 1647 | Values: 152.0 130.0 121.0 119.0 117.0 120.0 117.0 119.0 118.0 124.0 15:09:58 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:144.00 stddev:18.99 (13.2%) stddev-sans-first:13.74 15:09:58 INFO - PROCESS | 1647 | Values: 180.0 149.0 141.0 152.0 121.0 145.0 139.0 120.0 143.0 115.0 15:09:58 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:199.10 Median:198.00 stddev:4.63 (2.3%) stddev-sans-first:3.93 15:09:58 INFO - PROCESS | 1647 | Values: 207.0 208.0 199.0 197.0 197.0 194.0 198.0 197.0 198.0 196.0 15:09:58 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:66.60 Median:61.50 stddev:10.20 (16.6%) stddev-sans-first:9.17 15:09:58 INFO - PROCESS | 1647 | Values: 82.0 62.0 61.0 81.0 60.0 59.0 60.0 60.0 81.0 60.0 15:09:58 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:81.50 stddev:18.56 (22.8%) stddev-sans-first:18.07 15:09:58 INFO - PROCESS | 1647 | Values: 111.0 72.0 88.0 57.0 92.0 101.0 119.0 97.0 75.0 89.0 15:09:58 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:90.00 stddev:10.57 (11.7%) stddev-sans-first:5.83 15:09:58 INFO - PROCESS | 1647 | Values: 117.0 88.0 91.0 89.0 92.0 89.0 93.0 87.0 93.0 74.0 15:09:58 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:112.10 Median:95.50 stddev:23.05 (24.1%) stddev-sans-first:23.70 15:09:58 INFO - PROCESS | 1647 | Values: 96.0 104.0 138.0 150.0 96.0 96.0 98.0 101.0 147.0 95.0 15:09:58 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:112.50 Median:88.50 stddev:24.20 (27.3%) stddev-sans-first:23.70 15:09:58 INFO - PROCESS | 1647 | Values: 86.0 133.0 139.0 95.0 91.0 92.0 95.0 107.0 143.0 144.0 15:09:58 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:58.00 stddev:1.03 (1.8%) stddev-sans-first:0.73 15:09:58 INFO - PROCESS | 1647 | Values: 55.0 58.0 57.0 58.0 58.0 56.0 58.0 58.0 57.0 57.0 15:09:58 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:75.10 Median:72.50 stddev:9.28 (12.8%) stddev-sans-first:9.58 15:09:58 INFO - PROCESS | 1647 | Values: 69.0 70.0 76.0 84.0 71.0 68.0 70.0 72.0 73.0 98.0 15:09:58 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:90.00 stddev:2.26 (2.5%) stddev-sans-first:2.35 15:09:58 INFO - PROCESS | 1647 | Values: 91.0 94.0 89.0 90.0 86.0 90.0 88.0 92.0 89.0 88.0 15:09:58 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:166.40 Median:160.50 stddev:24.15 (15.0%) stddev-sans-first:25.26 15:09:58 INFO - PROCESS | 1647 | Values: 155.0 159.0 162.0 168.0 149.0 150.0 149.0 158.0 227.0 187.0 15:09:58 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.40 Median:181.00 stddev:27.41 (15.1%) stddev-sans-first:28.81 15:09:58 INFO - PROCESS | 1647 | Values: 181.0 204.0 238.0 181.0 179.0 177.0 175.0 158.0 240.0 181.0 15:09:58 INFO - PROCESS | 1647 | 15:09:58 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:75.00 stddev:9.78 (13.0%) stddev-sans-first:9.83 15:09:58 INFO - PROCESS | 1647 | Values: 67.0 70.0 67.0 68.0 81.0 92.0 93.0 74.0 71.0 76.0 15:09:58 INFO - PROCESS | 1647 | -------- Summary: end -------- 15:09:58 INFO - PROCESS | 1647 | 15:09:59 INFO - TEST-INFO | 1647: exit 0 15:09:59 INFO - TEST-OK | kraken | took 62325ms 15:09:59 INFO - SUITE-END | took 1180s 15:09:59 INFO - Completed test suite (00:19:40) 15:09:59 INFO - javascript benchmark 15:09:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7028.468804760187, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3215.3569286142765, 3344.347852168828, 3408.0, 3420.640832712567, 3440.191554984578, 5529.281193444856, 5596.888062238758, 5610.69141197234, 5643.46387093226, 5671.7164141792955, 5552.805651802188, 5687.345955215152, 5711.7715291388395, 5737.856553586163, 5845.210896528967, 5101.846944591668, 5129.615278854101, 5197.740112994354, 5251.711155886424, 5300.840974770763, 4116.794160291988, 4572.542745725417, 4636.907261854761, 4940.308356830046, 5198.818041368553, 4758.405199350082, 5099.184130539096, 5237.476252374732, 5274.367075950872, 5332.280142180814, 5085.160948443502, 5120.078385890538, 5162.92255616166, 5183.792648294064, 5234.057869583474, 4290.506591741959, 5083.745812709387, 5153.819616313449, 5173.637845350827, 5191.480851914816, 5435.755391007414, 5515.227868098469, 5687.971560142214, 5703.54371650267, 5709.400512946164, 6104.06507294887, 6121.666376154749, 6142.406692085136, 6157.938420615781, 6211.937880621181, 6242.344553821828, 6252.968735156295, 6256.624602523863, 6259.0, 6286.339934306878, 5203.739813009334, 5660.037793575102, 5793.131030345482, 5809.912851307234, 5822.941770582324, 6145.600535965148, 6171.876562468815, 6197.287311959182, 6207.131001659771, 6208.286047104551, 6117.84705382369, 6138.664296166128, 6167.537434692416, 6174.629522228681, 6180.0, 6081.57428979976, 6148.78479253224, 6236.875262494725, 6255.343188965184, 6261.5616906816995, 6093.512518998469, 6103.337669688931, 6140.4473597376455, 6170.382961703884, 6224.284207316126, 6163.84590385235, 6201.069839524108, 6226.439620434183, 6235.438810507076, 6271.529635277372, 4462.888427789331, 4933.358663373739, 4934.383202099738, 4944.134776414113, 4960.23116416956, 4335.891602709958, 4345.130973805251, 4358.302671572533, 4383.49589797171, 4451.59935605797, 4731.432228132646, 5755.0, 5761.596688231783, 5831.737571809279, 5938.6436813791315, 6159.291681456601, 6212.751489940442, 6225.315215326311, 6230.314665386803, 6248.0, 5668.0, 5883.352831188566, 5894.410558944071, 5919.289685237799, 5928.7332070056955, 5301.734913254322, 5372.113601255749, 5410.864728381744, 5413.891722165535, 5416.133418653076, 6258.249010118815, 6262.436380725757, 6280.874382512416, 6292.182016337847, 6327.683615819098, 6149.907751383644, 6218.409251121137, 6224.657643829632, 6235.594686345373, 6247.0, 6370.140031095742, 6405.551611387158, 6413.262474815269, 6423.325550817097, 6445.806625801233, 6077.392260773887, 6120.051392034242, 6129.724162412613, 6209.037599172136, 6217.564770466024, 4843.740627436821, 6003.279606447254, 6183.350748171377, 6191.876162476815, 6260.812175634738, 5051.924221136613, 6060.030395136933, 6084.0, 6104.34177152232, 6124.448799608057, 6063.484603808725, 6104.38956104386, 6108.6945652716295, 6116.2660480740815, 6135.233095863017, 4814.579698988737, 5201.92197117036, 5853.9121913172185, 5917.881642367042, 5930.703464826827, 6032.517398608188, 6039.78860739872, 6072.362401947732, 6074.42292982166, 6076.483498902643, 4953.801847926043, 4962.900741985212, 5864.589478736448, 5992.64044157352, 6010.579259451796], "value": 5617.229815796323, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.1373308315701, 485.4587135344091, 494.86885975216575, 498.9376327959003, 566.235581964348, 36559.63440365595, 38690.226195476076, 38943.610563894355, 38993.0, 38996.83009509719, 39341.60658393415, 40055.0, 40169.79915100428, 40203.39694904579, 40212.798936005354, 9263.166315031664, 9441.575129119172, 9447.90552094477, 9453.62185512582, 9454.81090378192, 9278.257739380868, 9376.953115234413, 9386.81226375472, 9399.013103624124, 9399.859002114974, 9381.061893810633, 9383.43699378036, 9409.106134917172, 9433.575489103006, 9443.38617989832, 9360.672376466826, 9390.201832844217, 9409.0, 9424.811503769886, 9425.575849086808, 9199.264058875275, 9231.953840230823, 9307.581158847868, 9331.626734930594, 9339.066093390675, 38239.23521529582, 38279.660211892726, 38510.3042787005, 38543.0, 38606.42090368647, 3363.2432702641954, 3417.8974630761118, 3470.670286322795, 3901.726879118463, 4085.3259212229946, 28863.0, 29729.851350743324, 29909.850450747606, 30043.69956300431, 30118.0, 3209.9679003209903, 3258.6904244096772, 3286.227736481949, 3292.884749033796, 3350.0452371074125, 455319.0, 458997.0, 461025.38974610495, 462104.0, 462755.0, 57769.0, 57977.710111449174, 58119.837603247695, 58131.709341453025, 58342.58231594521, 59593.70203149043, 59887.40112598818, 59981.80036399248, 60092.39907600868, 60127.0, 15428.997115187702, 15676.137812420198, 15778.526644200692, 15820.841791582166, 15823.525294241192, 11784.705382365339, 12203.755924881452, 12211.877881221075, 12246.693832654255, 12262.325572093441, 12763.975026101054, 15707.450239241572, 15993.920030399773, 16046.438374656831, 16173.191340432932, 3132.561441398206, 3220.146661134801, 3261.315123823976, 6444.645544495098, 6506.707198176094, 929.7257309093834, 985.8866230383454, 1025.6512785652915, 1040.422565476168, 1059.433203236265, 27833.443331133265, 29366.342939022263, 29409.264768380533, 30058.098257052323, 30084.69915300819, 996.4619105682995, 1019.1235537437798, 1054.5201933120566, 1067.9305845120043, 1084.9566017359218, 15042.473513426978, 15251.23743812805, 15278.923605381902, 15412.229388530528, 15461.96545847753, 582472.0, 582767.0, 585238.0, 587280.0, 590491.0, 56008.0, 56537.0, 56645.43354566402, 56719.0, 56790.43209567934, 1284.8907842833464, 1341.4701193028893, 1354.0, 1357.5859362894412, 1358.8844948179317, 23336.416589584718, 26427.6361164701, 29166.645835729163, 29186.124416267547, 29749.256268593457, 52194.739026306146, 53872.73063634813, 53985.73007134939, 57192.71403642955, 57375.71312143413, 559129.0, 582287.0, 587641.0, 589396.0, 591432.0, 39698.60301396949, 40010.19979600333, 40287.39568906528, 40324.39513407242, 40455.59544404636, 44581.0, 45022.77488612536, 45646.63060108202, 45710.77144614256, 46068.30897536473, 38057.61942380541, 38247.42628860514, 38341.23317533689, 39494.61768838077, 39529.604703953744, 30412.134058550524, 37809.810950945066, 38007.41487043838, 38822.6117738819, 39059.80470097631, 36556.26887462289, 37170.0, 37363.0, 37379.81310093432, 37508.624913750515, 31378.686213137575, 33432.1641958953, 33525.16187095342, 33605.0, 33650.66349336573, 24756.504869902863, 25604.743952560235, 29547.409051818413, 30810.69189308078, 32581.674183258812], "value": 19492.740505725604, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.9344927739091, 374.1226823099832, 379.8176875099951, 385.22569635033574, 401.7248184993278, 19144.234230630776, 19149.617007659857, 19560.0, 19908.0, 20118.195272189132, 19550.608987820237, 19615.607687846234, 19986.70019949702, 20264.18943242272, 20330.39008829734, 4895.241237608177, 4983.103041452537, 5242.397124330712, 5325.893482130355, 5443.265159203516, 5820.534357251431, 6000.309964354112, 6004.819855404323, 6010.789622363196, 6017.819465416044, 5312.521873031426, 5348.973255133719, 5529.921665275273, 5939.287285525743, 5963.194968679238, 5284.0, 5294.788208471657, 5371.973140134294, 5376.435474275184, 5377.354717433914, 4405.867823965286, 4521.208788462006, 5225.294585230983, 5231.843044708665, 5334.146536554172, 12687.365631718378, 12740.235585864877, 12989.740205195938, 13037.282949437777, 13191.010674199473, 2073.8859362735043, 2251.617225071742, 2304.308707387777, 2379.9524009519887, 2388.474535602165, 9509.381890177116, 10038.64864729731, 10207.081362677394, 12256.938715306367, 14292.785608215885, 1792.059168936306, 1844.4651051195137, 1868.4955062133283, 1887.5281179705073, 1889.7527631763107, 63777.681111594145, 75477.0, 77855.0, 120726.0, 129271.0, 9117.626478203107, 9387.953060234655, 9687.41875487473, 9905.20758339331, 9970.551325190383, 12217.633470995885, 12236.449359778831, 12237.877621223852, 12282.692932676577, 12299.446524906401, 7712.460127791113, 7846.254605812439, 7862.0, 7971.641276142587, 8050.5169689818795, 7978.401619878532, 7989.320907722792, 8024.5586492742295, 8142.18578142181, 8235.752927412188, 3291.4075466415798, 3811.19964807388, 3863.864764733221, 3870.3420418528917, 3889.8055097245024, 1903.7525121734086, 1943.319838056697, 1943.87364821289, 1945.5233467800197, 1954.7361106250758, 866.2204016385303, 882.2324577617513, 909.4679612426672, 920.3465539467053, 937.4188003437912, 20318.08568614416, 20756.68864967027, 21021.05405256767, 21157.30741540704, 21584.244551440624, 902.6479672927563, 920.9447433154032, 958.1328897347911, 992.9156021738089, 998.7553049502918, 9732.951335243279, 11131.777364452828, 11203.551857925591, 11204.271722338022, 11243.718907027227, 552398.0, 554442.0, 554915.0, 590289.0, 596519.0, 102787.0, 113769.0, 114411.42794286142, 114777.0, 116152.0, 946.8958414574391, 960.8894977077586, 972.0668158567854, 972.9951350243346, 998.0368943969105, 18389.448316550526, 18532.536686582942, 18916.527086822938, 19037.333693320666, 19168.808311916702, 28860.0, 51931.2210316838, 52483.0, 52633.0, 53156.93686126178, 49095.0, 67522.0, 74859.62570187332, 75412.0, 77422.0, 5806.796762113306, 6604.108445360007, 6867.725290988305, 7291.234420385783, 7656.540607563564, 9820.803583928138, 12021.75956480883, 12345.0, 12423.571289301846, 12495.500179992698, 10397.376157430579, 10485.790284194121, 10756.731081723019, 10852.403117828595, 10997.0, 10284.897151028394, 10381.0, 10635.20235982289, 10715.892841071802, 10836.783264334512, 10026.598936042477, 10727.463626818471, 10951.069159121245, 10975.451227438436, 11055.115590752881, 6699.832504187434, 7223.927760722326, 7234.240404757425, 7394.336274338231, 7466.850662986819, 8142.674293028213, 8309.916900830915, 9908.157806586521, 10186.0, 10537.367757934548], "value": 8816.484872227289, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1252.254908329544, 1472.8748056415204, 1630.2582325042108, 1780.528160037591, 1817.6637322095405, 7224.566526008443, 7630.236976302381, 7863.174366691486, 8171.10117887032, 8649.178328058832, 8109.91890081099, 8403.705870294541, 8411.158884111586, 8542.060373358941, 8542.530160841152, 1956.7358406615067, 2281.646344816556, 2316.4787922717337, 2335.92992210234, 2338.088145623208, 2279.783420575051, 2347.0611755297846, 2362.7400985891536, 2375.7149142102885, 2379.4170428245106, 2312.0, 2319.014418871981, 2322.036354912709, 2335.614623587106, 2341.672165896776, 2266.648669456237, 2286.199830059474, 2316.3282648032136, 2317.154238702878, 2321.1527792355837, 2306.573283942476, 2348.929532114022, 2350.3654013416453, 2352.9647055294186, 2358.2217868103658, 8422.747317580483, 8524.8721269181, 8540.274076703488, 8545.871811922827, 8589.570521473965, 5122.718250496221, 5246.8688282792855, 5251.684898906078, 5288.10102282609, 5312.229726689647, 3254.8047117173046, 3400.1839558506026, 3547.3260080584605, 3595.8741444049333, 3597.4963505109304, 1005.6228914157191, 1035.6685860524635, 1084.8264277715607, 1088.2871719024051, 1101.3887292552631, 9646.228301735844, 11184.993350598405, 11244.0, 11245.493952772227, 11288.548458061668, 4499.4150760400935, 4621.4223222097235, 4718.268668356411, 4725.00774837288, 4731.124741922756, 9524.619015239452, 9600.375975561707, 9620.615175393046, 9622.663206787729, 9632.614695412245, 5230.764615592308, 5232.110541208004, 5239.161734122522, 5251.36983561975, 5267.446918073624, 3820.1213720843807, 4096.067774936035, 4761.833335833229, 4812.628400905725, 4822.807087716452, 3109.891153809651, 3808.2383523294898, 3891.3190191716335, 3898.5321761388814, 3908.4332771747936, 1262.7790136726037, 1268.9428975696117, 1278.7186818899827, 1278.725074109071, 1288.0339745191106, 608.6317777744489, 806.6370133439858, 811.8944537210125, 896.9865452018225, 899.6491368366343, 5186.40356359016, 5593.328800543961, 5719.685417302088, 5764.193012978187, 5774.595778295563, 416.57509340472546, 430.694207112947, 431.4046615670355, 431.9481662200493, 437.03633488158533, 3101.3022070034062, 3477.808720520345, 3777.792221427848, 3789.905252368658, 3894.883153505399, 8624.482531048157, 9414.681944527772, 9780.804383912424, 10189.286749927582, 10325.63860264887, 8735.213830755136, 8884.822303553892, 10053.497325133714, 10237.59049638021, 10411.427371494488, 7785.883211751829, 8060.717874874351, 8074.313683336982, 8082.595870206466, 8097.190280971856, 5773.393793651606, 5810.7094645266725, 5905.055191169392, 5922.763089476372, 5925.111233315038, 9664.390614534177, 9700.805983880142, 9708.466034368177, 9710.70867873965, 9726.416415015121, 7496.700131994659, 8646.0, 9572.66495672676, 9669.468179250209, 9715.36850104741, 5774.913376299275, 6640.966795165993, 6838.076859624086, 7095.077639906779, 7277.59973201479, 6253.0, 8109.215972486044, 8121.309688676529, 8130.0, 8136.511809291462, 7205.71177152908, 7327.230640782855, 7393.963030184815, 7406.629668516445, 7484.812879678052, 7055.576665400093, 7123.964380178066, 7178.641067946686, 7280.162781280221, 7312.744053958086, 6552.312007239171, 6687.431568316748, 6705.262421133574, 6725.730970761115, 6727.629980350932, 4680.976595117003, 4762.523747625349, 4788.186008378514, 4842.4673285937815, 4915.483874193158, 4802.903941921212, 4846.200376937907, 4912.680675756064, 4917.9016419672125, 4923.064617722621], "value": 4316.482816650285, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.9766269867061, 288.3368253018059, 294.2628715068755, 306.03903742249344, 309.58206421331204, 4777.8805529861775, 5409.540189083923, 5454.945450545493, 5531.972340138299, 5660.490555849972, 5237.921431178526, 5340.092184328664, 5439.809606663767, 5454.34547854258, 5472.288602481682, 3648.890533284006, 4106.219818234534, 4128.2042311594405, 4157.544859299236, 4171.416001759756, 3791.4502397152396, 4065.26825171469, 4162.146759914225, 4171.958280417202, 4204.726692764976, 3558.861164427384, 4036.293648611496, 4079.755214687128, 4091.365838295069, 4093.5087789465306, 3734.4024956007042, 4035.636792688672, 4043.737157084795, 4044.4944381952255, 4074.8370065197655, 2774.6392968914115, 3019.8641061152302, 3509.964900351015, 3524.2246705724956, 3525.294941011782, 4016.0205696202356, 4265.616094551505, 4820.445648750404, 5115.923261151086, 5317.8404647860625, 3934.0361611405388, 4072.9592704072875, 4230.238557059728, 4271.743695378287, 4629.120467111238, 5446.509814116748, 5449.56403487724, 5506.504414602665, 5707.400722924075, 5721.742521586497, 3544.4506101554302, 3794.4687743715904, 3830.7893065881367, 3841.615838416164, 3856.903577410559, 4861.951380486185, 5190.4550022247495, 5296.708681022542, 5615.494605485485, 5986.940130598682, 3282.0810173151553, 3817.427385892083, 3886.8833934981994, 3917.7845218513257, 3925.331734013033, 3687.410014397737, 3987.441758153861, 3992.54085780139, 3996.360582306875, 3999.3601023836045, 4125.546189919107, 4564.748938808331, 4635.745034023161, 4647.18674232008, 4688.343631891538, 5737.88524229513, 5808.273965754281, 5845.386234445407, 5870.412958704181, 5872.970635146797, 1055.6569115037644, 1110.9277896936674, 1200.789861774186, 1294.7734146524322, 1318.9975618529795, 797.8005498625344, 807.1403954788132, 903.846346121161, 922.6943874417758, 934.2806039349663, 4504.436945381827, 4722.645801564897, 5167.68993860362, 5200.7919683213, 5213.452587478336, 4734.431868175841, 5002.674826136289, 5621.887562248732, 5649.4350564944, 5655.264815574032, 4501.954980450154, 5055.69665820052, 5112.258722485219, 5126.307948426989, 5174.534291913746, 2366.0598309386137, 2648.25848762343, 2959.9852000739857, 2978.2107741448535, 2981.761459083268, 5664.6601203927075, 5843.912341314884, 5880.470757631833, 5940.31686356066, 5979.970100149471, 4724.456687480915, 5563.860903477445, 5737.967165910176, 5770.538356931435, 5795.710214489259, 5230.0, 5355.866103347447, 5521.337439507285, 5834.5624078194305, 5903.409659034062, 4934.580560652241, 5107.9489205107475, 5331.413544510178, 5698.971505142614, 5742.655440673573, 4677.742724150068, 4817.325574419514, 5843.29880414336, 5912.70436478183, 5922.851928701644, 5505.889882202414, 6226.159468471698, 6238.282597501346, 6239.194091604028, 6276.838784824822, 2886.826790392583, 3212.6947939945667, 3421.8460169291943, 3909.354956432157, 4013.478247827764, 4642.791074401593, 4843.370361852936, 4917.852464426073, 5070.8225212117395, 5935.0, 5271.0, 5300.6024548158275, 5653.915191272216, 5802.883942321046, 5839.941600584109, 5211.557017653542, 5471.616986811045, 5647.124695672177, 5711.771529138788, 5834.27071616048, 4982.829035176803, 5336.866578335573, 5461.726913654381, 5622.690752008679, 5643.827126556223, 4535.818567257273, 5288.920666190087, 5773.191753154478, 5773.797917072882, 5791.305043394819, 4954.529319714621, 5261.657992230493, 5601.579881508822, 5623.606347555632, 5736.397678243724], "value": 4043.5922242846896, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.4955884850968, 679.2562144451825, 688.0711040095869, 693.1855070292405, 693.4902846407889, 14014.439422423104, 14762.040467369641, 14801.407943682267, 14814.185219812905, 14815.703685926288, 13200.141990770593, 13347.199168049923, 13351.065425420224, 13354.399052042658, 13371.531996380128, 642.7043559962423, 664.5945972956492, 798.3373799746197, 799.2287442617873, 817.9141190175035, 815.4047545291941, 828.1635548096436, 829.5810615639094, 830.1822704635958, 832.3216578488513, 862.7109918177387, 871.4988881393192, 873.1922971251566, 876.430320291809, 876.6011464783509, 869.678219058946, 870.2341939093557, 872.3370238618633, 872.8123453457474, 875.448467465499, 635.895077312243, 638.9488840892764, 648.9810996735127, 651.5797310734597, 652.0512654088291, 13218.66953326165, 13446.865531344756, 13594.11638243521, 13595.388207530586, 14153.433862645585, 13488.055836091478, 13525.39135738894, 13624.455021799116, 13669.179849209078, 13954.232517211549, 11148.721281967935, 11208.0, 11280.379579123144, 11314.208005439623, 11683.106200550723, 3133.2480204750923, 3579.659932306453, 3625.854965801365, 3638.6179451157514, 3641.7632853864416, 64809.01033308853, 88008.11991880063, 89695.0, 90101.54949225277, 92532.68668283279, 10474.109700675375, 10497.685069447929, 10575.15398768112, 10886.782264354826, 10902.890971090346, 20247.797522024885, 20325.898370508054, 20447.488812779502, 20463.4884127898, 20501.692474612595, 7292.41660667156, 7307.0, 7355.117385913618, 7364.852702945911, 7445.441591880631, 4057.2494088593116, 4107.196029776675, 4109.239790638741, 4124.587541245852, 4147.6267135957905, 3320.734341252694, 3377.4933759936207, 3396.9490457643155, 3406.250624862576, 3419.709324707378, 614.3181069013392, 626.8526896179394, 634.1470721879065, 637.8947473666885, 658.0524045374646, 637.5951270942892, 652.2043107408954, 653.4282502810041, 653.9247986481615, 654.8068319845657, 8768.712500249198, 8860.955695221612, 9030.593623286968, 9132.634694612141, 9224.677136300197, 623.4980840423502, 645.3417514135556, 645.515863102673, 666.3037126203129, 680.1158493957835, 3435.896923092311, 4112.444819949328, 4205.453291072202, 4220.008298049956, 4360.697990317322, 116671.6665666682, 117957.0, 118240.40879795718, 120361.39819300847, 122518.77481225073, 104716.95283047225, 105165.47417262864, 107003.46498267459, 107170.92829071765, 107468.4626576862, 73635.63182184161, 74937.87593186107, 76393.0, 78065.60967195127, 79283.20716792873, 7295.379892709179, 7884.763457096296, 8107.594620269081, 8350.749477515685, 8402.163638793141, 41090.0, 41095.7945210272, 51713.48286517087, 52392.73803630957, 52948.47051529436, 52693.0, 53905.0, 68533.31466685269, 73079.63460182665, 74436.62781686056, 10661.57353705874, 12113.757724845278, 12149.94784466191, 12251.264924104582, 12312.0, 13276.169563769889, 13820.101693389897, 14172.858271417566, 14187.219702916438, 14332.785008225093, 12797.552085676956, 12984.157129291667, 13003.739925201633, 13029.739405211652, 13623.678942455026, 12929.224246545238, 12974.935125324313, 13154.0, 13158.40787164599, 13374.665633359244, 11923.82114268304, 12574.1198116131, 13212.933935330262, 13282.800757988445, 13453.260070696206, 10256.743581410525, 10969.798840743562, 11162.162837787037, 11196.94401527987, 11422.029127524254, 9167.471354762934, 10362.637307694195, 11203.383813890314, 11417.086633069168, 11446.885531144915], "value": 7153.681138698521, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.6000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 130.0, 121.0, 119.0, 117.0, 120.0, 117.0, 119.0, 118.0, 124.0], "value": 123.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 149.0, 141.0, 152.0, 121.0, 145.0, 139.0, 120.0, 143.0, 115.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 208.0, 199.0, 197.0, 197.0, 194.0, 198.0, 197.0, 198.0, 196.0], "value": 199.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 62.0, 61.0, 81.0, 60.0, 59.0, 60.0, 60.0, 81.0, 60.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 72.0, 88.0, 57.0, 92.0, 101.0, 119.0, 97.0, 75.0, 89.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 88.0, 91.0, 89.0, 92.0, 89.0, 93.0, 87.0, 93.0, 74.0], "value": 91.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 104.0, 138.0, 150.0, 96.0, 96.0, 98.0, 101.0, 147.0, 95.0], "value": 112.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 133.0, 139.0, 95.0, 91.0, 92.0, 95.0, 107.0, 143.0, 144.0], "value": 112.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 57.0, 58.0, 58.0, 56.0, 58.0, 58.0, 57.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 76.0, 84.0, 71.0, 68.0, 70.0, 72.0, 73.0, 98.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 89.0, 90.0, 86.0, 90.0, 88.0, 92.0, 89.0, 88.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 159.0, 162.0, 168.0, 149.0, 150.0, 149.0, 158.0, 227.0, 187.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 204.0, 238.0, 181.0, 179.0, 177.0, 175.0, 158.0, 240.0, 181.0], "value": 191.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 67.0, 68.0, 81.0, 92.0, 93.0, 74.0, 71.0, 76.0], "value": 75.9, "unit": "score"}]}]} 15:09:59 INFO - Return code: 0 15:09:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:09:59 ERROR - # TBPL SUCCESS # 15:09:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:09:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:09:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:09:59 INFO - 2016-11-18 15:09:59.801 screenresolution[1652:10421] starting screenresolution argv=screenresolution get 15:09:59 INFO - 2016-11-18 15:09:59.805 screenresolution[1652:10421] Display 0: 1600x1200x32@60 15:09:59 INFO - 2016-11-18 15:09:59.811 screenresolution[1653:10424] starting screenresolution argv=screenresolution list 15:09:59 INFO - Available Modes on Display 0 15:09:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:09:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:09:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:09:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:10:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:10:00 INFO - Intel Iris: 15:10:00 INFO - Chipset Model: Intel Iris 15:10:00 INFO - Type: GPU 15:10:00 INFO - Bus: Built-In 15:10:00 INFO - VRAM (Dynamic, Max): 1536 MB 15:10:00 INFO - Vendor: Intel (0x8086) 15:10:00 INFO - Device ID: 0x0a2e 15:10:00 INFO - Revision ID: 0x0009 15:10:00 INFO - Displays: 15:10:00 INFO - Display: 15:10:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:10:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:10:00 INFO - Display Serial Number: 1600x1200 60 15:10:00 INFO - Main Display: Yes 15:10:00 INFO - Mirror: Off 15:10:00 INFO - Online: Yes 15:10:00 INFO - Rotation: Supported 15:10:00 INFO - Return code: 0 15:10:00 INFO - Running post-action listener: _resource_record_post_action 15:10:00 INFO - [mozharness: 2016-11-18 23:10:00.054740Z] Finished run-tests step (success) 15:10:00 INFO - Running post-run listener: _resource_record_post_run 15:10:00 INFO - Total resource usage - Wall time: 1214s; CPU: 55.0%; Read bytes: 38509056; Write bytes: 691206656; Read time: 247; Write time: 1954 15:10:00 INFO - TinderboxPrint: CPU usage
54.5% 15:10:00 INFO - TinderboxPrint: I/O read bytes / time
38,509,056 / 247 15:10:00 INFO - TinderboxPrint: I/O write bytes / time
691,206,656 / 1,954 15:10:00 INFO - TinderboxPrint: CPU idle
2,208.7 (45.5%) 15:10:00 INFO - TinderboxPrint: CPU system
978.4 (20.1%) 15:10:00 INFO - TinderboxPrint: CPU user
1,670.6 (34.4%) 15:10:00 INFO - TinderboxPrint: Swap in / out
421,773,312 / 0 15:10:00 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 369938944; Write bytes: 367335424; Read time: 28555; Write time: 757 15:10:00 INFO - run-tests - Wall time: 1182s; CPU: 55.0%; Read bytes: 36674048; Write bytes: 304275968; Read time: 228; Write time: 1153 15:10:00 INFO - Running post-run listener: _upload_blobber_files 15:10:00 INFO - Blob upload gear active. 15:10:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:10:00 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 15:10:00 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'] 15:10:00 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 15:10:00 INFO - (blobuploader) - INFO - Open directory for files ... 15:10:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:10:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:10:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:10:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:10:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:10:02 INFO - (blobuploader) - INFO - Done attempting. 15:10:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:10:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:10:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:10:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:10:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:10:03 INFO - (blobuploader) - INFO - Done attempting. 15:10:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:10:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:10:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:10:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:10:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:10:05 INFO - (blobuploader) - INFO - Done attempting. 15:10:05 INFO - (blobuploader) - INFO - Iteration through files over. 15:10:05 INFO - Return code: 0 15:10:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:10:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:10:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a174df35c7f07206906a2f3d9c8782af8ab6ca932d0e4a2cb52730ef2ce423ef65e4f626081beee925f6030fdf20dd5992e86bba84a463c99fbf24eee2c8b0b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d38b4c9f9957e3dedeb9f07b119d183d2975bf5cddfdca0fb255fd2af2b2b4e52c99121f352bffe90edd786b16f03a8e377e502dc44f2ba47ed711e5a04d73ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e44fac668eb111208af5ea2e095aa0c77c90615dddd6fa99dc72108eb7b36f043be3f2b3b8832b9b4b732ebf8d83ba518bfa3adb4437df38c0bdad2ccf303e7"} 15:10:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:10:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:10:05 INFO - Contents: 15:10:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a174df35c7f07206906a2f3d9c8782af8ab6ca932d0e4a2cb52730ef2ce423ef65e4f626081beee925f6030fdf20dd5992e86bba84a463c99fbf24eee2c8b0b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d38b4c9f9957e3dedeb9f07b119d183d2975bf5cddfdca0fb255fd2af2b2b4e52c99121f352bffe90edd786b16f03a8e377e502dc44f2ba47ed711e5a04d73ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e44fac668eb111208af5ea2e095aa0c77c90615dddd6fa99dc72108eb7b36f043be3f2b3b8832b9b4b732ebf8d83ba518bfa3adb4437df38c0bdad2ccf303e7"} 15:10:05 INFO - Running post-run listener: copy_logs_to_upload_dir 15:10:05 INFO - Copying logs to upload dir... 15:10:05 INFO - mkdir: /builds/slave/test/build/upload/logs 15:10:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.859208 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-18 15:10:05.839738) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 15:10:05.847584) ========= 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.Qitv9KXtvf/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.xzPe8UuYwA/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a174df35c7f07206906a2f3d9c8782af8ab6ca932d0e4a2cb52730ef2ce423ef65e4f626081beee925f6030fdf20dd5992e86bba84a463c99fbf24eee2c8b0b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d38b4c9f9957e3dedeb9f07b119d183d2975bf5cddfdca0fb255fd2af2b2b4e52c99121f352bffe90edd786b16f03a8e377e502dc44f2ba47ed711e5a04d73ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e44fac668eb111208af5ea2e095aa0c77c90615dddd6fa99dc72108eb7b36f043be3f2b3b8832b9b4b732ebf8d83ba518bfa3adb4437df38c0bdad2ccf303e7"} build_url:https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010972 build_url: 'https://queue.taskcluster.net/v1/task/VgCtpcftRpuarwaFBo0apA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a174df35c7f07206906a2f3d9c8782af8ab6ca932d0e4a2cb52730ef2ce423ef65e4f626081beee925f6030fdf20dd5992e86bba84a463c99fbf24eee2c8b0b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d38b4c9f9957e3dedeb9f07b119d183d2975bf5cddfdca0fb255fd2af2b2b4e52c99121f352bffe90edd786b16f03a8e377e502dc44f2ba47ed711e5a04d73ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e44fac668eb111208af5ea2e095aa0c77c90615dddd6fa99dc72108eb7b36f043be3f2b3b8832b9b4b732ebf8d83ba518bfa3adb4437df38c0bdad2ccf303e7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 15:10:05.883120) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 15:10:05.883472) ========= 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.Qitv9KXtvf/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.xzPe8UuYwA/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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.005145 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 15:10:05.931880) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 15:10:05.933398) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 15:10:05.933711) ========= ========= Total master_lag: 0.20 =========