builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0182 starttime: 1478699096.25 results: success (0) buildid: 20161109030210 builduid: 6c477a88a2e343229d7ed71f99fe6d8d revision: 783356f1476eafd8e4d6fa5f3919cf6167e84f8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-09 05:44:56.256188) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-09 05:44:56.256636) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 05:44:56.256923) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 05:44:56.297923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 05:44:56.298303) ========= 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.jcNv1UNtG9/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.2DiziUh8zj/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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-09 05:44:56-- 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% 28.3M=0s 2016-11-09 05:44:56 (28.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.567937 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 05:44:56.889344) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 05:44:56.889710) ========= 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.jcNv1UNtG9/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.2DiziUh8zj/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.026899 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 05:44:56.938879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-09 05:44:56.939255) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 783356f1476eafd8e4d6fa5f3919cf6167e84f8d --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 783356f1476eafd8e4d6fa5f3919cf6167e84f8d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jcNv1UNtG9/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.2DiziUh8zj/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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-09 05:44:57,015 truncating revision to first 12 chars 2016-11-09 05:44:57,015 Setting DEBUG logging. 2016-11-09 05:44:57,015 attempt 1/10 2016-11-09 05:44:57,015 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/783356f1476e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-09 05:44:58,067 unpacking tar archive at: mozilla-central-783356f1476e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.300127 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-09 05:44:58.262101) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 05:44:58.262425) ========= script_repo_revision: 783356f1476eafd8e4d6fa5f3919cf6167e84f8d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 05:44:58.262816) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 05:44:58.263158) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 05:44:58.281982) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-09 05:44:58.282370) ========= /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.jcNv1UNtG9/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.2DiziUh8zj/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:44:58 INFO - MultiFileLogger online at 20161109 05:44:58 in /builds/slave/test 05:44:58 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 05:44:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:44:58 INFO - {'append_to_log': False, 05:44:58 INFO - 'base_work_dir': '/builds/slave/test', 05:44:58 INFO - 'blob_upload_branch': 'Firefox', 05:44:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:44:58 INFO - 'branch': 'Firefox', 05:44:58 INFO - 'buildbot_json_path': 'buildprops.json', 05:44:58 INFO - 'config_files': ('talos/mac_config.py',), 05:44:58 INFO - 'default_actions': ('clobber', 05:44:58 INFO - 'read-buildbot-config', 05:44:58 INFO - 'download-and-extract', 05:44:58 INFO - 'populate-webroot', 05:44:58 INFO - 'create-virtualenv', 05:44:58 INFO - 'install', 05:44:58 INFO - 'run-tests'), 05:44:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:44:58 INFO - 'download_minidump_stackwalk': True, 05:44:58 INFO - 'download_symbols': 'ondemand', 05:44:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:44:58 INFO - 'tooltool.py': '/tools/tooltool.py', 05:44:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:44:58 INFO - '/tools/misc-python/virtualenv.py')}, 05:44:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:44:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:44:58 INFO - 'installer_path': 'installer.exe', 05:44:58 INFO - 'log_level': 'info', 05:44:58 INFO - 'log_name': 'talos', 05:44:58 INFO - 'log_to_console': True, 05:44:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:44:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:44:58 INFO - 'opt_config_files': (), 05:44:58 INFO - 'pip_index': False, 05:44:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:44:58 INFO - 'cmd': ('bash', 05:44:58 INFO - '-c', 05:44:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:44:58 INFO - 'enabled': True, 05:44:58 INFO - 'halt_on_failure': False, 05:44:58 INFO - 'name': 'check_screen_resolution'},), 05:44:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:44:58 INFO - 'cmd': ('bash', 05:44:58 INFO - '-c', 05:44:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:44:58 INFO - 'enabled': True, 05:44:58 INFO - 'halt_on_failure': False, 05:44:58 INFO - 'name': 'check_screen_resolution'},), 05:44:58 INFO - 'run_cmd_checks_enabled': True, 05:44:58 INFO - 'sps_profile': False, 05:44:58 INFO - 'sps_profile_interval': 0, 05:44:58 INFO - 'suite': 'dromaeojs-e10s', 05:44:58 INFO - 'system_bits': '32', 05:44:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:44:58 INFO - 'title': 't-yosemite-r7-0182', 05:44:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:44:58 INFO - 'use_talos_json': True, 05:44:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:44:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:44:58 INFO - 'work_dir': 'build'} 05:44:58 INFO - [mozharness: 2016-11-09 13:44:58.489532Z] Running clobber step. 05:44:58 INFO - Running pre-action listener: _resource_record_pre_action 05:44:58 INFO - Running main action method: clobber 05:44:58 INFO - rmtree: /builds/slave/test/build 05:44:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:45:00 INFO - Running post-action listener: _resource_record_post_action 05:45:00 INFO - [mozharness: 2016-11-09 13:45:00.822566Z] Finished clobber step (success) 05:45:00 INFO - [mozharness: 2016-11-09 13:45:00.822694Z] Running read-buildbot-config step. 05:45:00 INFO - Running pre-action listener: _resource_record_pre_action 05:45:00 INFO - Running main action method: read_buildbot_config 05:45:00 INFO - Using buildbot properties: 05:45:00 INFO - { 05:45:00 INFO - "project": "", 05:45:00 INFO - "product": "firefox", 05:45:00 INFO - "script_repo_revision": "production", 05:45:00 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:45:00 INFO - "repository": "", 05:45:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:45:00 INFO - "buildid": "20161109030210", 05:45:00 INFO - "stage_platform": "macosx64", 05:45:00 INFO - "basedir": "/builds/slave/test", 05:45:00 INFO - "nightly_build": "True", 05:45:00 INFO - "buildnumber": 5, 05:45:00 INFO - "slavename": "t-yosemite-r7-0182", 05:45:00 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:45:00 INFO - "platform": "yosemite_r7", 05:45:00 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:45:00 INFO - "branch": "mozilla-central", 05:45:00 INFO - "repo_path": "mozilla-central", 05:45:00 INFO - "revision": "783356f1476eafd8e4d6fa5f3919cf6167e84f8d", 05:45:00 INFO - "pgo_build": "False", 05:45:00 INFO - "builduid": "6c477a88a2e343229d7ed71f99fe6d8d", 05:45:00 INFO - "slavebuilddir": "test" 05:45:00 INFO - } 05:45:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:45:00 INFO - Running post-action listener: _resource_record_post_action 05:45:00 INFO - [mozharness: 2016-11-09 13:45:00.826318Z] Finished read-buildbot-config step (success) 05:45:00 INFO - [mozharness: 2016-11-09 13:45:00.826417Z] Running download-and-extract step. 05:45:00 INFO - Running pre-action listener: _resource_record_pre_action 05:45:00 INFO - Running main action method: download_and_extract 05:45:00 INFO - mkdir: /builds/slave/test/build/tests 05:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:00 INFO - trying https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:45:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:45:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:45:01 INFO - Downloaded 1199 bytes. 05:45:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:45:01 INFO - Using the following test package requirements: 05:45:01 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:45:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:45:01 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:45:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:45:01 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:45:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:45:01 INFO - u'jsshell-mac.zip'], 05:45:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:45:01 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:45:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:45:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:45:01 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:45:01 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:45:01 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:45:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:45:01 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:45:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:45:01 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:45:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:45:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:45:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:45:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:45:02 INFO - Http code: 200 05:45:02 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 05:45:02 INFO - x-amz-cf-id: YEjOwOmjoREsu6YNbciGIaDRmJ1IZgeyGeDC9gNSqLyb_4TWOoXs2g== 05:45:02 INFO - x-amz-version-id: AQqEmYQxIL.B4DRjBuDhE9sPehK_sEOb 05:45:02 INFO - Expected file size: 16318370 05:45:02 INFO - Obtained file size: 16318370 05:45:09 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:45:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:45:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:45:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:45:09 INFO - Http code: 200 05:45:09 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 05:45:09 INFO - x-amz-cf-id: Lg0-DEwy7RyES8a4K7R0NoSRF6YduF3A8mbxplkqpBnQ3gCPayxPLQ== 05:45:09 INFO - x-amz-version-id: AQqEmYQxIL.B4DRjBuDhE9sPehK_sEOb 05:45:10 INFO - Expected file size: 16318370 05:45:10 INFO - Obtained file size: 16318370 05:45:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:45:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:45:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:45:17 INFO - Http code: 200 05:45:17 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 05:45:17 INFO - x-amz-cf-id: LPtMw6CypPhWSSlgURq8ibkSudYC68LpO5W-8yXtY1lfBQ15vezt_w== 05:45:17 INFO - x-amz-version-id: jeFoZOSSpuDB1P85VrOpEb5.3zNBjDjv 05:45:18 INFO - Expected file size: 14409038 05:45:18 INFO - Obtained file size: 14409038 05:45: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')]} 05:45:18 INFO - trying https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:45:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:45:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:45:21 INFO - Downloaded 111720270 bytes. 05:45:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:45:21 INFO - mkdir: /builds/slave/test/properties 05:45:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:45:21 INFO - Writing to file /builds/slave/test/properties/build_url 05:45:21 INFO - Contents: 05:45:21 INFO - build_url:https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:45:21 INFO - Running post-action listener: _resource_record_post_action 05:45:21 INFO - Running post-action listener: set_extra_try_arguments 05:45:21 INFO - [mozharness: 2016-11-09 13:45:21.995832Z] Finished download-and-extract step (success) 05:45:21 INFO - [mozharness: 2016-11-09 13:45:21.995949Z] Running populate-webroot step. 05:45:21 INFO - Running pre-action listener: _resource_record_pre_action 05:45:21 INFO - Running main action method: populate_webroot 05:45:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:22 INFO - '--tppagecycles', 05:45:22 INFO - '7'], 05:45:22 INFO - 'tests': ['tsvgm']}}, 05:45:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:45:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:45:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:45:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:45:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:45:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:22 INFO - 'talos_options': ['--disable-e10s'], 05:45:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:22 INFO - 'talos_options': ['--disable-e10s'], 05:45:22 INFO - 'tests': ['damp', 'tps']}, 05:45:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:22 INFO - 'tests': ['damp', 'tps']}, 05:45:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:45:22 INFO - 'tests': ['dromaeo_dom']}, 05:45:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:45:22 INFO - 'tests': ['basic_compositor_video']}, 05:45:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:45:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:45:22 INFO - 'tests': ['a11yr', 05:45:22 INFO - 'ts_paint', 05:45:22 INFO - 'tpaint', 05:45:22 INFO - 'sessionrestore', 05:45:22 INFO - 'sessionrestore_no_auto_restore', 05:45:22 INFO - 'tabpaint']}, 05:45:22 INFO - 'other-e10s': {'tests': ['a11yr', 05:45:22 INFO - 'ts_paint', 05:45:22 INFO - 'tpaint', 05:45:22 INFO - 'sessionrestore', 05:45:22 INFO - 'sessionrestore_no_auto_restore', 05:45:22 INFO - 'tabpaint']}, 05:45:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:45:22 INFO - 'ts_paint', 05:45:22 INFO - 'tpaint', 05:45:22 INFO - 'sessionrestore', 05:45:22 INFO - 'sessionrestore_no_auto_restore', 05:45:22 INFO - 'tabpaint']}, 05:45:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:45:22 INFO - 'ts_paint', 05:45:22 INFO - 'tpaint', 05:45:22 INFO - 'sessionrestore', 05:45:22 INFO - 'sessionrestore_no_auto_restore', 05:45:22 INFO - 'tabpaint']}, 05:45:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:45:22 INFO - 'tests': ['a11yr', 05:45:22 INFO - 'ts_paint', 05:45:22 INFO - 'tpaint', 05:45:22 INFO - 'sessionrestore', 05:45:22 INFO - 'sessionrestore_no_auto_restore', 05:45:22 INFO - 'tabpaint']}, 05:45:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:45:22 INFO - 'tests': ['a11yr', 05:45:22 INFO - 'ts_paint', 05:45:22 INFO - 'tpaint', 05:45:22 INFO - 'sessionrestore', 05:45:22 INFO - 'sessionrestore_no_auto_restore', 05:45:22 INFO - 'tabpaint']}, 05:45:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:45:22 INFO - 'tests': ['tsvgx', 05:45:22 INFO - 'tsvgr_opacity', 05:45:22 INFO - 'tart', 05:45:22 INFO - 'tscrollx', 05:45:22 INFO - 'cart']}, 05:45:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:45:22 INFO - 'tsvgr_opacity', 05:45:22 INFO - 'tart', 05:45:22 INFO - 'tscrollx', 05:45:22 INFO - 'cart']}, 05:45:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:22 INFO - 'talos_options': ['--disable-e10s'], 05:45:22 INFO - 'tests': ['tp5o']}, 05:45:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:22 INFO - 'tests': ['tp5o']}, 05:45:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:22 INFO - 'talos_options': ['--disable-e10s', 05:45:22 INFO - '--xperf_path', 05:45:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:22 INFO - 'tests': ['tp5n']}, 05:45:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:22 INFO - 'talos_options': ['--xperf_path', 05:45:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:22 INFO - 'tests': ['tp5n']}}, 05:45:22 INFO - 'talos.zip': {'path': '', 05:45:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:22 INFO - Running post-action listener: _resource_record_post_action 05:45:22 INFO - [mozharness: 2016-11-09 13:45:22.014847Z] Finished populate-webroot step (success) 05:45:22 INFO - [mozharness: 2016-11-09 13:45:22.014982Z] Running create-virtualenv step. 05:45:22 INFO - Running pre-action listener: _resource_record_pre_action 05:45:22 INFO - Running main action method: create_virtualenv 05:45:22 INFO - Creating virtualenv /builds/slave/test/build/venv 05:45:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:45:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:45:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:22 INFO - Using real prefix '/tools/python27' 05:45:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:45:23 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:25 INFO - Installing pip.................done. 05:45:25 INFO - Return code: 0 05:45:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:45:26 INFO - Reading from file tmpfile_stdout 05:45:26 INFO - Output received: 05:45:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:45:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:26 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 0x107c1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0ac87750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a31d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a29b20>, '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.jcNv1UNtG9/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.2DiziUh8zj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:45:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcNv1UNtG9/Render', 05:45:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:26 INFO - 'HOME': '/Users/cltbld', 05:45:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:26 INFO - 'LOGNAME': 'cltbld', 05:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:26 INFO - 'MOZ_NO_REMOTE': '1', 05:45:26 INFO - 'NO_EM_RESTART': '1', 05:45:26 INFO - 'PAGER': '/bin/cat', 05:45:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:26 INFO - 'PWD': '/builds/slave/test', 05:45:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:26 INFO - 'SHELL': '/bin/bash', 05:45:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2DiziUh8zj/Listeners', 05:45:26 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 05:45:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:26 INFO - 'USER': 'cltbld', 05:45:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:26 INFO - 'XPC_FLAGS': '0x0', 05:45:26 INFO - 'XPC_SERVICE_NAME': '0', 05:45:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:45:26 INFO - Cleaning up... 05:45:26 INFO - Return code: 0 05:45:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:26 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 0x107c1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0ac87750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a31d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a29b20>, '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.jcNv1UNtG9/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.2DiziUh8zj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:45:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcNv1UNtG9/Render', 05:45:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:26 INFO - 'HOME': '/Users/cltbld', 05:45:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:26 INFO - 'LOGNAME': 'cltbld', 05:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:26 INFO - 'MOZ_NO_REMOTE': '1', 05:45:26 INFO - 'NO_EM_RESTART': '1', 05:45:26 INFO - 'PAGER': '/bin/cat', 05:45:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:26 INFO - 'PWD': '/builds/slave/test', 05:45:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:26 INFO - 'SHELL': '/bin/bash', 05:45:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2DiziUh8zj/Listeners', 05:45:26 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 05:45:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:26 INFO - 'USER': 'cltbld', 05:45:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:26 INFO - 'XPC_FLAGS': '0x0', 05:45:26 INFO - 'XPC_SERVICE_NAME': '0', 05:45:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:26 INFO - Downloading/unpacking psutil>=3.1.1 05:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:45:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:30 INFO - Installing collected packages: psutil 05:45:30 INFO - Running setup.py install for psutil 05:45:30 INFO - building 'psutil._psutil_osx' extension 05:45:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:45:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:45:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:45:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:45:31 INFO - building 'psutil._psutil_posix' extension 05:45:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:45:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:45:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:45:31 INFO - ^ 05:45:31 INFO - 1 warning generated. 05:45:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:45:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:31 INFO - Successfully installed psutil 05:45:31 INFO - Cleaning up... 05:45:31 INFO - Return code: 0 05:45:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:31 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 0x107c1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0ac87750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a31d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a29b20>, '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.jcNv1UNtG9/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.2DiziUh8zj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:45:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcNv1UNtG9/Render', 05:45:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:31 INFO - 'HOME': '/Users/cltbld', 05:45:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:31 INFO - 'LOGNAME': 'cltbld', 05:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:31 INFO - 'MOZ_NO_REMOTE': '1', 05:45:31 INFO - 'NO_EM_RESTART': '1', 05:45:31 INFO - 'PAGER': '/bin/cat', 05:45:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:31 INFO - 'PWD': '/builds/slave/test', 05:45:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:31 INFO - 'SHELL': '/bin/bash', 05:45:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2DiziUh8zj/Listeners', 05:45:31 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 05:45:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:31 INFO - 'USER': 'cltbld', 05:45:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:31 INFO - 'XPC_FLAGS': '0x0', 05:45:31 INFO - 'XPC_SERVICE_NAME': '0', 05:45:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:45:34 INFO - Installing collected packages: mozsystemmonitor 05:45:34 INFO - Running setup.py install for mozsystemmonitor 05:45:34 INFO - Successfully installed mozsystemmonitor 05:45:34 INFO - Cleaning up... 05:45:34 INFO - Return code: 0 05:45:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107c1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0ac87750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a31d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a29b20>, '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.jcNv1UNtG9/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.2DiziUh8zj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:45:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcNv1UNtG9/Render', 05:45:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:34 INFO - 'HOME': '/Users/cltbld', 05:45:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:34 INFO - 'LOGNAME': 'cltbld', 05:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:34 INFO - 'MOZ_NO_REMOTE': '1', 05:45:34 INFO - 'NO_EM_RESTART': '1', 05:45:34 INFO - 'PAGER': '/bin/cat', 05:45:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:34 INFO - 'PWD': '/builds/slave/test', 05:45:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:34 INFO - 'SHELL': '/bin/bash', 05:45:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2DiziUh8zj/Listeners', 05:45:34 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 05:45:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:34 INFO - 'USER': 'cltbld', 05:45:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:34 INFO - 'XPC_FLAGS': '0x0', 05:45:34 INFO - 'XPC_SERVICE_NAME': '0', 05:45:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:35 INFO - Downloading/unpacking jsonschema==2.5.1 05:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:45:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:38 INFO - Downloading functools32-3.2.3-2.tar.gz 05:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:45:38 INFO - warning: no files found matching '*.txt' 05:45:38 INFO - no previously-included directories found matching 'build' 05:45:38 INFO - no previously-included directories found matching 'dist' 05:45:38 INFO - no previously-included directories found matching '.git*' 05:45:38 INFO - Installing collected packages: jsonschema, functools32 05:45:38 INFO - Running setup.py install for functools32 05:45:38 INFO - warning: no files found matching '*.txt' 05:45:38 INFO - no previously-included directories found matching 'build' 05:45:38 INFO - no previously-included directories found matching 'dist' 05:45:38 INFO - no previously-included directories found matching '.git*' 05:45:38 INFO - Successfully installed jsonschema functools32 05:45:38 INFO - Cleaning up... 05:45:38 INFO - Return code: 0 05:45:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:45: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')]} 05:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107c1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0ac87750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a31d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a29b20>, '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.jcNv1UNtG9/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.2DiziUh8zj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:45:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcNv1UNtG9/Render', 05:45:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:38 INFO - 'HOME': '/Users/cltbld', 05:45:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:38 INFO - 'LOGNAME': 'cltbld', 05:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:38 INFO - 'MOZ_NO_REMOTE': '1', 05:45:38 INFO - 'NO_EM_RESTART': '1', 05:45:38 INFO - 'PAGER': '/bin/cat', 05:45:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:38 INFO - 'PWD': '/builds/slave/test', 05:45:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:38 INFO - 'SHELL': '/bin/bash', 05:45:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2DiziUh8zj/Listeners', 05:45:38 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 05:45:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:38 INFO - 'USER': 'cltbld', 05:45:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:38 INFO - 'XPC_FLAGS': '0x0', 05:45:38 INFO - 'XPC_SERVICE_NAME': '0', 05:45:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:45:38 INFO - Cleaning up... 05:45:38 INFO - Return code: 0 05:45:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:45: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')]} 05:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107c1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0ac87750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a31d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a29b20>, '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.jcNv1UNtG9/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.2DiziUh8zj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:45:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcNv1UNtG9/Render', 05:45:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:38 INFO - 'HOME': '/Users/cltbld', 05:45:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:38 INFO - 'LOGNAME': 'cltbld', 05:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:38 INFO - 'MOZ_NO_REMOTE': '1', 05:45:38 INFO - 'NO_EM_RESTART': '1', 05:45:38 INFO - 'PAGER': '/bin/cat', 05:45:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:38 INFO - 'PWD': '/builds/slave/test', 05:45:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:38 INFO - 'SHELL': '/bin/bash', 05:45:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2DiziUh8zj/Listeners', 05:45:38 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 05:45:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:38 INFO - 'USER': 'cltbld', 05:45:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:38 INFO - 'XPC_FLAGS': '0x0', 05:45:38 INFO - 'XPC_SERVICE_NAME': '0', 05:45:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:38 INFO - Downloading/unpacking blobuploader==1.2.4 05:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:41 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:45:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:42 INFO - Downloading docopt-0.6.1.tar.gz 05:45:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:42 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:42 INFO - Running setup.py install for blobuploader 05:45:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:45:42 INFO - Running setup.py install for requests 05:45:43 INFO - Running setup.py install for docopt 05:45:43 INFO - Successfully installed blobuploader requests docopt 05:45:43 INFO - Cleaning up... 05:45:43 INFO - Return code: 0 05:45:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:43 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 0x107c1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0ac87750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a31d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a29b20>, '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.jcNv1UNtG9/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.2DiziUh8zj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:45:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcNv1UNtG9/Render', 05:45:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:43 INFO - 'HOME': '/Users/cltbld', 05:45:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:43 INFO - 'LOGNAME': 'cltbld', 05:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:43 INFO - 'MOZ_NO_REMOTE': '1', 05:45:43 INFO - 'NO_EM_RESTART': '1', 05:45:43 INFO - 'PAGER': '/bin/cat', 05:45:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:43 INFO - 'PWD': '/builds/slave/test', 05:45:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:43 INFO - 'SHELL': '/bin/bash', 05:45:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2DiziUh8zj/Listeners', 05:45:43 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 05:45:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:43 INFO - 'USER': 'cltbld', 05:45:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:43 INFO - 'XPC_FLAGS': '0x0', 05:45:43 INFO - 'XPC_SERVICE_NAME': '0', 05:45:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:43 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-oGGhFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:44 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-xhrD64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:44 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-SU6IFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:44 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-AuDA4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:44 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-OIEYqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:44 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-HOayXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:44 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-I35mM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:44 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-ZaSIg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:44 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-epyCwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:44 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-D_nw5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:45 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-sKnm6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:45 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-hSq1jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:45 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-gMG3GC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:45 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-1khJRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:45 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-fhShHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:45 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-BxsKsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:45 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-ZqOERV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:45 INFO - Running setup.py install for manifestparser 05:45:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:45:45 INFO - Running setup.py install for mozcrash 05:45:46 INFO - Running setup.py install for mozdebug 05:45:46 INFO - Running setup.py install for mozdevice 05:45:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:45:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:45:46 INFO - Running setup.py install for mozfile 05:45:46 INFO - Running setup.py install for mozhttpd 05:45:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:45:46 INFO - Running setup.py install for mozinfo 05:45:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:45:46 INFO - Running setup.py install for mozInstall 05:45:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:45:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:45:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:45:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:45:46 INFO - Running setup.py install for mozleak 05:45:47 INFO - Running setup.py install for mozlog 05:45:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:45:47 INFO - Running setup.py install for moznetwork 05:45:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:45:47 INFO - Running setup.py install for mozprocess 05:45:47 INFO - Running setup.py install for mozprofile 05:45:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:45:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:45:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:45:47 INFO - Running setup.py install for mozrunner 05:45:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:45:47 INFO - Running setup.py install for mozscreenshot 05:45:48 INFO - Running setup.py install for moztest 05:45:48 INFO - Running setup.py install for mozversion 05:45:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:45:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:48 INFO - Cleaning up... 05:45:48 INFO - Return code: 0 05:45:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:48 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 0x107c1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0ac87750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a31d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a29b20>, '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.jcNv1UNtG9/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.2DiziUh8zj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcNv1UNtG9/Render', 05:45:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:48 INFO - 'HOME': '/Users/cltbld', 05:45:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:48 INFO - 'LOGNAME': 'cltbld', 05:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:48 INFO - 'MOZ_NO_REMOTE': '1', 05:45:48 INFO - 'NO_EM_RESTART': '1', 05:45:48 INFO - 'PAGER': '/bin/cat', 05:45:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:48 INFO - 'PWD': '/builds/slave/test', 05:45:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:48 INFO - 'SHELL': '/bin/bash', 05:45:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2DiziUh8zj/Listeners', 05:45:48 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 05:45:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:48 INFO - 'USER': 'cltbld', 05:45:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:48 INFO - 'XPC_FLAGS': '0x0', 05:45:48 INFO - 'XPC_SERVICE_NAME': '0', 05:45:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:48 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-Qv9i57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:48 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-n50_Gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:48 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)) 05:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:48 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-E6Uhac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:48 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-2gdyAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-gpJ7Iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-GeDMrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-lKeG5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-9zJCKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-zt2dSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-nWQWWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-M7TblS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-QSJ0Np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-lRhJMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:49 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-gzDIc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:50 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)) 05:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:50 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-903eN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:50 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-bLvTWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:50 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-O1AMRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:45:50 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)) 05:45:50 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)) 05:45:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:45:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:52 INFO - Downloading blessings-1.6.tar.gz 05:45:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:45:53 INFO - Installing collected packages: blessings 05:45:53 INFO - Running setup.py install for blessings 05:45:53 INFO - Successfully installed blessings 05:45:53 INFO - Cleaning up... 05:45:53 INFO - Return code: 0 05:45:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:45:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:45:53 INFO - Reading from file tmpfile_stdout 05:45:53 INFO - Current package versions: 05:45:53 INFO - blessings == 1.6 05:45:53 INFO - blobuploader == 1.2.4 05:45:53 INFO - docopt == 0.6.1 05:45:53 INFO - functools32 == 3.2.3-2 05:45:53 INFO - jsonschema == 2.5.1 05:45:53 INFO - manifestparser == 1.1 05:45:53 INFO - mozInstall == 1.12 05:45:53 INFO - mozcrash == 1.0 05:45:53 INFO - mozdebug == 0.1 05:45:53 INFO - mozdevice == 0.48 05:45:53 INFO - mozfile == 1.2 05:45:53 INFO - mozhttpd == 0.7 05:45:53 INFO - mozinfo == 0.9 05:45:53 INFO - mozleak == 0.1 05:45:53 INFO - mozlog == 3.4 05:45:53 INFO - moznetwork == 0.27 05:45:53 INFO - mozprocess == 0.23 05:45:53 INFO - mozprofile == 0.28 05:45:53 INFO - mozrunner == 6.13 05:45:53 INFO - mozscreenshot == 0.1 05:45:53 INFO - mozsystemmonitor == 0.3 05:45:53 INFO - moztest == 0.7 05:45:53 INFO - mozversion == 1.4 05:45:53 INFO - psutil == 3.1.1 05:45:53 INFO - requests == 1.2.3 05:45:53 INFO - wsgiref == 0.1.2 05:45:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:53 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 0x107c1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0ac87750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a31d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a29b20>, '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.jcNv1UNtG9/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.2DiziUh8zj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcNv1UNtG9/Render', 05:45:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:53 INFO - 'HOME': '/Users/cltbld', 05:45:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:53 INFO - 'LOGNAME': 'cltbld', 05:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:53 INFO - 'MOZ_NO_REMOTE': '1', 05:45:53 INFO - 'NO_EM_RESTART': '1', 05:45:53 INFO - 'PAGER': '/bin/cat', 05:45:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:53 INFO - 'PWD': '/builds/slave/test', 05:45:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:53 INFO - 'SHELL': '/bin/bash', 05:45:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2DiziUh8zj/Listeners', 05:45:53 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 05:45:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:53 INFO - 'USER': 'cltbld', 05:45:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:53 INFO - 'XPC_FLAGS': '0x0', 05:45:53 INFO - 'XPC_SERVICE_NAME': '0', 05:45:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:45:53 INFO - Cleaning up... 05:45:53 INFO - Return code: 0 05:45:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:53 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 0x107c1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0ac87750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a31d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a29b20>, '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.jcNv1UNtG9/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.2DiziUh8zj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:45:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcNv1UNtG9/Render', 05:45:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:53 INFO - 'HOME': '/Users/cltbld', 05:45:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:53 INFO - 'LOGNAME': 'cltbld', 05:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:53 INFO - 'MOZ_NO_REMOTE': '1', 05:45:53 INFO - 'NO_EM_RESTART': '1', 05:45:53 INFO - 'PAGER': '/bin/cat', 05:45:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:53 INFO - 'PWD': '/builds/slave/test', 05:45:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:53 INFO - 'SHELL': '/bin/bash', 05:45:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2DiziUh8zj/Listeners', 05:45:53 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 05:45:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:53 INFO - 'USER': 'cltbld', 05:45:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:53 INFO - 'XPC_FLAGS': '0x0', 05:45:53 INFO - 'XPC_SERVICE_NAME': '0', 05:45:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:45:54 INFO - Cleaning up... 05:45:54 INFO - Return code: 0 05:45:54 INFO - Running post-action listener: _resource_record_post_action 05:45:54 INFO - Running post-action listener: _start_resource_monitoring 05:45:54 INFO - Starting resource monitoring. 05:45:54 INFO - [mozharness: 2016-11-09 13:45:54.156994Z] Finished create-virtualenv step (success) 05:45:54 INFO - [mozharness: 2016-11-09 13:45:54.157959Z] Running install step. 05:45:54 INFO - Running pre-action listener: _resource_record_pre_action 05:45:54 INFO - Running main action method: install 05:45:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:45:54 INFO - Reading from file tmpfile_stdout 05:45:54 INFO - Detecting whether we're running mozinstall >=1.0... 05:45:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:45:54 INFO - Reading from file tmpfile_stdout 05:45:54 INFO - Output received: 05:45:54 INFO - Usage: mozinstall [options] installer 05:45:54 INFO - Options: 05:45:54 INFO - -h, --help show this help message and exit 05:45:54 INFO - -d DEST, --destination=DEST 05:45:54 INFO - Directory to install application into. [default: 05:45:54 INFO - "/builds/slave/test"] 05:45:54 INFO - --app=APP Application being installed. [default: firefox] 05:45:54 INFO - mkdir: /builds/slave/test/build/application 05:45:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:46:28 INFO - Reading from file tmpfile_stdout 05:46:28 INFO - Output received: 05:46:28 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:46:28 INFO - Running post-action listener: _resource_record_post_action 05:46:28 INFO - [mozharness: 2016-11-09 13:46:28.063773Z] Finished install step (success) 05:46:28 INFO - [mozharness: 2016-11-09 13:46:28.063918Z] Running run-tests step. 05:46:28 INFO - Running pre-action listener: _resource_record_pre_action 05:46:28 INFO - Running main action method: run_tests 05:46:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:46:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:46:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:46:28 INFO - 2016-11-09 05:46:28.078 screenresolution[1643:7911] starting screenresolution argv=screenresolution get 05:46:28 INFO - 2016-11-09 05:46:28.081 screenresolution[1643:7911] Display 0: 1600x1200x32@60 05:46:28 INFO - 2016-11-09 05:46:28.086 screenresolution[1644:7913] starting screenresolution argv=screenresolution list 05:46:28 INFO - Available Modes on Display 0 05:46:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:46:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:46:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:46:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:46:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:46:28 INFO - Intel Iris: 05:46:28 INFO - Chipset Model: Intel Iris 05:46:28 INFO - Type: GPU 05:46:28 INFO - Bus: Built-In 05:46:28 INFO - VRAM (Dynamic, Max): 1536 MB 05:46:28 INFO - Vendor: Intel (0x8086) 05:46:28 INFO - Device ID: 0x0a2e 05:46:28 INFO - Revision ID: 0x0009 05:46:28 INFO - Displays: 05:46:28 INFO - Display: 05:46:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:46:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:46:28 INFO - Display Serial Number: 1600x1200 60 05:46:28 INFO - Main Display: Yes 05:46:28 INFO - Mirror: Off 05:46:28 INFO - Online: Yes 05:46:28 INFO - Rotation: Supported 05:46:28 INFO - Return code: 0 05:46:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:46:28 INFO - Python 2.7.3 05:46:28 INFO - Return code: 0 05:46:28 INFO - grabbing minidump binary from tooltool 05:46: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')]} 05:46:28 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 0x107a31d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a29b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:46:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:46:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:46:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:46:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:28 INFO - Return code: 0 05:46:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:46:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:46:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:46:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:46:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:46:28 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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 05:46:28 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0182 --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 05:46:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jcNv1UNtG9/Render', 05:46:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:28 INFO - 'HOME': '/Users/cltbld', 05:46:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:28 INFO - 'LOGNAME': 'cltbld', 05:46:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:46:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:28 INFO - 'MOZ_NO_REMOTE': '1', 05:46:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:46:28 INFO - 'NO_EM_RESTART': '1', 05:46:28 INFO - 'PAGER': '/bin/cat', 05:46:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:28 INFO - 'PWD': '/builds/slave/test', 05:46:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:46:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:28 INFO - 'SHELL': '/bin/bash', 05:46:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2DiziUh8zj/Listeners', 05:46:28 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 05:46:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:28 INFO - 'USER': 'cltbld', 05:46:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:28 INFO - 'XPC_FLAGS': '0x0', 05:46:28 INFO - 'XPC_SERVICE_NAME': '0', 05:46:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:28 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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 05:46:28 INFO - mozversion application_buildid: 20161109030210 05:46:28 INFO - mozversion application_changeset: 783356f1476eafd8e4d6fa5f3919cf6167e84f8d 05:46:28 INFO - mozversion application_display_name: Nightly 05:46:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:28 INFO - mozversion application_name: Firefox 05:46:28 INFO - mozversion application_remotingname: firefox 05:46:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:46:28 INFO - mozversion application_vendor: Mozilla 05:46:28 INFO - mozversion application_version: 52.0a1 05:46:28 INFO - mozversion platform_buildid: 20161109030210 05:46:28 INFO - mozversion platform_changeset: 783356f1476eafd8e4d6fa5f3919cf6167e84f8d 05:46:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:46:28 INFO - mozversion platform_version: 52.0a1 05:46:28 INFO - using testdate: 1478699188 05:46:28 INFO - actual date: 1478699188 05:46:28 INFO - starting webserver on 'localhost:49267' 05:46:28 INFO - SUITE-START | Running 2 tests 05:46:28 INFO - TEST-START | dromaeo_css 05:46:28 INFO - operating with platform_type : mac_ 05:46:28 INFO - Initialising browser for dromaeo_css test... 05:46:28 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpLhwqH5/profile http://localhost:49267/getInfo.html) 05:46:31 INFO - PROCESS | 1654 | 2016-11-09 05:46:31.804 plugin-container[1657:8089] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 05:46:31 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:46:31 INFO - PROCESS | 1654 | 2016-11-09 05:46:31.804 plugin-container[1657:8089] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c1b, name = 'com.apple.CFPasteboardClient' 05:46:31 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:46:31 INFO - PROCESS | 1654 | 2016-11-09 05:46:31.804 plugin-container[1657:8089] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:46:31 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 05:46:31 INFO - PROCESS | 1654 | colorDepth:24 05:46:31 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 05:46:31 INFO - PROCESS | 1654 | __metrics 05:46:31 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 05:46:32 INFO - TEST-INFO | 1654: exit 0 05:46:32 INFO - Browser initialized. 05:46:32 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:32 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpLhwqH5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:35 INFO - PROCESS | 1659 | 2016-11-09 05:46:35.294 plugin-container[1660:8210] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 05:46:35 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:46:35 INFO - PROCESS | 1659 | 2016-11-09 05:46:35.295 plugin-container[1660:8210] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 05:46:35 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:46:35 INFO - PROCESS | 1659 | 2016-11-09 05:46:35.295 plugin-container[1660:8210] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:46:44 INFO - PROCESS | 1659 | RSS: Main: 238452736 05:46:44 INFO - PROCESS | 1659 | 05:47:34 INFO - PROCESS | 1659 | 1478699254666 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:49:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 05:49:49 INFO - PROCESS | 1659 | RSS: Main: 253132800 05:49:49 INFO - PROCESS | 1659 | 05:52:51 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 05:52:52 INFO - PROCESS | 1659 | RSS: Main: 265396224 05:52:52 INFO - PROCESS | 1659 | 05:55:54 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 05:55:55 INFO - PROCESS | 1659 | RSS: Main: 269725696 05:55:55 INFO - PROCESS | 1659 | 05:58:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 05:58:57 INFO - PROCESS | 1659 | RSS: Main: 268345344 05:58:57 INFO - PROCESS | 1659 | 06:02:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 06:02:01 INFO - PROCESS | 1659 | RSS: Main: 272863232 06:02:01 INFO - PROCESS | 1659 | 06:05:03 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 06:05:04 INFO - PROCESS | 1659 | RSS: Main: 275349504 06:05:04 INFO - PROCESS | 1659 | 06:05:04 INFO - PROCESS | 1659 | __start_tp_report 06:05:04 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 06:05:04 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 06:05:04 INFO - PROCESS | 1659 | |i|pagename|runs| 06:05:04 INFO - PROCESS | 1659 | |0;dojo.html;2811.2831228036853;3307.2889328794304;3344.08037789608;3363.310521343125;3366.057503898909;5192.273081768555;5557.5831812614015;5564.721763911808;5565.415631358705;5600.131979543167;5523.558115350772;5617.269754931864;5651.802186923458;5655.886882262353;5713.542916566675;4030.717849750519;4210.2842516772225;5056.266841308017;5169.586433085344;5174.534291913727;4374.387585737999;4851.708897466146;5218.8695282617855;5232.529072383485;5274.868128296785;4216.388623649554;5125.179971204608;5191.402988656315;5211.895762084775;5290.629655924087;4221.957780422187;5081.441041485434;5089.185730283137;5131.846044618667;5138.743062846843;5063.3417655704525;5088.618353623456;5093.134167191549;5112.437631860493;5116.976604679042;4097.713160078795;5459.535939445152;5489.204065410533;5520.751566179531;5589;6002.189704389895;6063.18147050147;6105.186826067751;6108.1143234230785;6169.876602467971;6148.907766383508;6161.784337548164;6163.537734669918;6182.474489668383;6187.474064704461;5603.551715862721;5724.255846739898;5737.08206686928;5789.04480760674;5798.362180160179;6158.969205153946;6196.907046394308;6200.348963358872;6225.315215326311;6230.501559875199;6081.452669259699;6094.75620975156;6122.387761223931;6134.171886795226;6144.5084393248435;4741.95258047422;6120.66336351496;6129.785457508966;6132.936844521141;6221.96889015552;5012;6092.664903430354;6109.920916985209;6131.50947924165;6219.502439804804;6195.380461953859;6198.876022479525;6211.9689401552705;6222.439980401786;6245.219347581552;4819.277108433693;4831.516848315211;4938.456769755324;4940.061388336205;4977.129002424561;4317.287647538121;4327.2643650579475;4339.110482351173;4375.321825117112;4429.579189976947;5619.662820230799;5742.712864356766;5748.913766293509;5755.424457554295;5807.448292412214;6194.690265486708;6208.286047104551;6228.657423841732;6241.719122639402;6258.249010118815;5585.245991791137;5627.155926610959;5679.148127780866;5738.971305143447;5741;5314.840554783363;5349.117395629678;5359.3032905722785;5389.380221274525;5422.996745602076;6145.279321789906;6164.568480206342;6251.187345645037;6255.093011513214;6281.120643109968;5725.627834190765;6159.82186542058;6190.845228869314;6220.035894436189;6271.090691849565;6170.50635949132;6247.625142491465;6285.937140628535;6305.621662700252;6320.304766475776;5970.552208584287;6094.573379863367;6144.539159562962;6167.938320616916;6232.501399888089;5974.253218347707;6115.1794953435965;6127.830981140761;6130.969345153246;6182.103594978793;6106.603070800384;6111.755529778759;6121.788327166137;6122.215193971364;6140.3552626975315;6085.939140608714;6093.329733729198;6093.786717464867;6111.877762444815;6127.417895299939;4896;5170.6380553360905;5479.205515200353;5847.590668653153;5925.200097986716;4982.227754698028;5127.794888204579;6044.123602077586;6095.299040610209;6137.539684523589;5863.882722345444;5881.794137205177;5883.2057672215415;5889;5905.557083218861 06:05:04 INFO - PROCESS | 1659 | |1;ext.html;511.35313828007577;514.7992283009625;532.5632980955615;553.7950958145484;555.3086407422758;30486.695133048663;35867.28265434693;38203.42694859579;38246.80876595613;39368.80315598421;38729;39126;39151.41272880909;39160.04199790013;39193.21613567727;9110.31672624554;9253.167214950654;9346.158845703885;9354.485503297316;9357.766055848624;9246.44521328719;9249.398789078721;9258.120478554527;9337.71986840396;9372.437653740762;9305.25557955362;9305.95347023264;9315.72052838416;9343.486108264076;9366.859497107549;9161.404508706946;9185.035571265054;9243.815123697523;9264.58309376073;9352.018038106036;9141.862872056925;9162.404443711137;9192.35653504255;9251.6299348026;9261.861072083924;36909.07727306839;37328.066798329986;37385;37483.625163748286;37563;3241.8379081045855;3262.3149138680906;3443.810590417551;3444.2422667013216;3694.7228957828;26498.73501264982;29239.68421421041;29287.560686589717;29293.26766830825;29306.41387172266;3124.3787029305367;3234.450143475615;3248.30161515273;3283.0479161043268;3369.6124945631323;487460;489674.1032589664;493076;494459.9999999964;495783;51625.225621615704;52037;53267.668308291824;57575.71212143912;61676.69161654163;53372.73313633407;55686.607834804454;62257.37742622606;63756.68121659362;66798;15885.364585416684;16142.515724528283;16161.868669193278;16209;16245.268962896462;12192.634220973385;12362.01103911685;12366.505339786489;12385.876141238652;12544.310062946626;19162.13770380336;19349.61300774005;19417.32039378615;19476.610467790848;19504.829710217433;6811.761588344483;7866.960665196638;8042.597870106471;8064.435489515795;8072.636731347104;855.1064137975831;866.8093019535692;930.297625292913;1049.6746008737316;1054.7257712994676;28093.157205283875;28579.999700010816;28685.995990140244;28884.98902538401;29225.561616575767;898.0525545549377;899.105390136805;979.3193730357476;1046.8953104689622;1057.767291195951;11939;12388.876111238773;12484.563040293728;14168.362423690958;15056.397744090333;634440;640134;668149.6592517006;668710;673022;39912.60087399089;44571.777141114086;52210;54194.91610167774;54235;1204.644629834201;1337.0774165825549;1339.4106593099004;1363.2910886339048;1375.9243241621807;21231.256906008217;26703.732962670125;28112.29719257035;28287.15138545847;28768;44629.76851157364;45646.858828529555;45651.54348456606;46353;46639.76680116577;541563;607308;615810;616409;619434;26301.4739705201;26324.078657246904;26512.072077477194;26616.33459163459;26656.06703765359;42450.78774606107;42692.78653606712;43650.34524482199;43665;45771.31343029791;36384.63615363812;36687.26625467422;37059;37415.81292093522;37424;36351.27297454089;36454;36709.26581468409;37502.62497374992;37655.81172094122;30632;31454.685453145175;35957;36583.45124823183;36791.2171417714;31339.373212535167;31426.68573314329;31527.054188374386;32427.946506686665;32550;23576.6463503051;24245.636315455635;24460.6330905033;24591.877040614683;25134.874325628254 06:05:04 INFO - PROCESS | 1659 | |2;jquery.html;302.01091425581217;371.65621799835145;378.70839453620715;394.30011729180717;411.5123578559407;15010.474633387834;17941.192646330914;18021.819781802176;18598;19540.31608893689;16538.42115525957;17543.035133067675;18238.908805455987;19719.40841774749;19899.403017909484;5020.849374518771;5306.522412982831;5307.018201632691;5312.389075256357;5325.946740532584;5095.6178286628465;5166.354205724285;5226.216067589873;5263.1578947368425;5263.868403289929;5181.989512045153;5257.789688412459;5276.076686579852;5279.656822306557;5281.498257665516;5117.744112794364;5210.895782084356;5224.346956630421;5279;5283.709395983219;4656.720596764205;4865.7349089236695;5136.126858434075;5142.434332223453;5154.948450515484;12780.10539262252;25887.482250355075;26609.201723948117;27159.45681086387;27655.861720691468;2559.8720063996725;2581.1998280532907;2719.7552220300267;2749.982506472598;2926.7123663832585;16197.908413880494;17267.65464690699;17299.13504324779;17320.393786217548;17413.738793918103;1995.3814317561603;2069.048237810594;2070.7618623858298;2149.0758973641327;2202.3392982105306;126045.36977315055;126649;128986.35506822499;130926.6907330924;133173.3365332688;20252.59494810125;20931.8953405232;20991;21275.042623081998;21681.783182168292;33877.98366049022;33960.83019584886;34030.65969340275;34109;34118.97643070712;8847.42491738035;10368.274220804471;10397.948010259901;10519.474026298654;10574.048335649675;8533;8552.828943421096;8576.485410875368;8724.258438032712;8744.213020828029;9403.905960940303;9434.386764860263;9541.809163816684;9586.808263834684;10030.498475076218;3459.308138372285;3708.851645934132;3818.427235914635;3822.7324087314178;3826.7895265760094;844.2444012608681;903.3089686389917;909.7543663210896;941.8540126280437;976.5654283843763;19413.4175974721;20223.19107235694;20275.898620507098;20318;20773.169073236902;906.3972458315278;914.2320450821342;934.4486752815872;946.1153821177221;991.8065977134534;10160.745981350377;10574.682759517073;10584.947075264574;10616.522256498476;10617.73455663599;434039;504674;505323;590425;595327;84187.57906210552;133738;137928.31035844958;143776;144966;968.2060710217695;984.13396211335;1022.7801022780138;1022.9335093218917;1025.564135242519;18299.993500357075;18467;18755.90622046881;18841.057947102316;18996.620067598295;42632;49600.751996239786;54068.64828379165;55247.618809528474;56236.43763562476;57966;66533.33666658372;77505;77957.37362324266;79645.60177199077;7799.922000780147;7920.326772224195;8007.279344858991;8139.14538973423;8143.063547692092;11248.212625116163;12597.874021260037;12652.304123273309;12834.229946203257;12882.484700612245;11024.228304018641;11063.889361106609;11102.500387482422;11187.049100826522;11254.662360129209;10584.100351470212;10717.410542420243;10875.184361172785;10888.67333979982;10893.019628233496;10715.624953126604;10753.569857205937;11045.944770276097;11052.778944421227;11229.775404492028;7821.687132514863;7957.363410927228;7963.323117535075;8181.836363272821;8191.713290034821;10225.539850706587;10781.676549703521;11014.173936954921;11077.612283570037;11119.888801111885 06:05:04 INFO - PROCESS | 1659 | |3;mootools.html;1475.0854470228458;1511.2594828534018;1725.284007137038;1821.61746033333;1861.3764388929717;7596.354309883653;7893.960530197355;8131.519886434635;8583.227509524133;8602.268807151391;8067.515949043047;8361.954755655543;8389.496630202177;8464.23821856033;8488.151184881508;2281.7147856517977;2319.1535089692225;2327.6392159215347;2329.3244958961964;2337.240396871015;2331.3821837213154;2348.9412764680933;2364.243442098529;2376.2633583589054;2385.057902128658;2092.49780052787;2248.9325320240337;2312.838101332907;2336.3575016870413;2346.190564255338;2296.5636529059425;2308.734495533002;2326.09282379872;2327.080803082781;2327.487952650423;2333.7316208636053;2358.327876555191;2359.929202123939;2363.2319496163645;2366.6331718583474;8433.831323373499;8463.576821158978;8502.06477287498;8517;8519.574021298973;5087.186050231982;5219.5041471060185;5223.660462069954;5225.16397376418;5239.633225674204;3117.953230701541;3193.1857376369107;3410.5395771571016;3424.3151369725906;3438.535797667308;973.9805203895953;1009.3489699144085;1022.9539670714836;1032.891546387626;1034.3948789957883;10448.425336606484;10715;10809.83785243222;10832.891671083345;10975.780484390347;3760.3231418344963;4280.422143010716;4369.6722745794195;4480.641548676098;4488.640908727294;8245.587720613945;8725.520096394632;8736.213740763362;8740.825183496294;8749.125087491328;5034.144195486703;5108.412532558803;5112.054269960069;5135.178371460548;5137.972405518836;4313.180495705806;4459.175052615212;4610.101030299126;4755.857324280277;4814.6870453420415;2877.3669792645583;3118.9239712299222;3633.6729694327637;3679.7056235501095;3711.3319602471274;1159.7796418680593;1172.4430895324824;1172.5427083437467;1178.393127539318;1179.598936361641;805.7260531419346;884.3102380143498;910.5840418149709;925.4354843545432;937.3409065953225;4300.61294483498;4457.375967364572;4754.738489383048;5615.522680572197;5821.621594596338;364.5661662621472;437.18028696194636;445.2053085242891;450.39871771185835;451.23515640988865;3672.265546890633;3812.7401072083526;3876.573576906538;3887.1448281378052;3927.3323534999117;9860.06329398706;10130.797384052425;10283.331583447052;10287.177025837915;10289.022542858416;9353.01793311706;9777.41335519871;10220.233482488844;10266;10271;7474.177840437547;7729.5748733819055;7787.104482984416;7956.283934445812;7968;5646.027156461684;5725.627834190765;5755.683437410815;5800.56495762811;5830.329512106162;9038.683646072355;9356.345055846026;9365.719028429157;9387.765305867135;9405.576749046173;9491.66779162726;9512.714618561455;9563.330566860253;9601.279904007088;9664.951675241578;6620.90068648961;6857.5199736018;7016.543924644881;7158.319959603829;7312.049433573601;7918.445708800559;8002.799930001796;8004.399670024655;8055.436119471581;8088;7034.437245020488;7148.785536433916;7278.599677017603;7325.890111648223;7401.5189012714;6154.723037463415;6907.89638155418;6972.616506092214;7060.470464715064;7193.784186474205;6701.731930722716;6706.396424321834;6790.5925644461495;6796.626185559841;6812.591244525344;4907.288443175648;4919.385076865392;4933.925991110064;4961.82633607822;5022.3219865317715;4251.256030194765;4930.186519224288;4961.355023846877;5010.574101201439;5033.295338652519 06:05:04 INFO - PROCESS | 1659 | |4;prototype.html;304.82472578267505;316.1006935269159;316.26941764523946;320.8684439379855;321.17618309037334;5392.703401312926;5397.784088636455;5437.6465529740535;5583.664980101197;5760.971195144029;4286.256795650778;5280.313559237304;5305.761240744167;5513.4210907854595;5654.928451514913;4256.616904478597;4260.808263628144;4261.509926358477;4267.509236437811;4277.165952639237;3555.8577656893694;4105.2815757242515;4247.384129301249;4273.675160700177;4277.700560960734;4185.937210941838;4202.70581059326;4203.726757760735;4207.263728847454;4211.410402543646;4180.686448516373;4198.748075115487;4219.038147261507;4229.492460904696;4229.610270197329;3243.7405007599573;3695.6489133532273;3707.925841483182;3727.7576957497677;3729.1050147964565;4984.526469985346;5151.124308867502;5378.757955891955;5420.593455490854;5441.15000899696;4085.4688890444054;4235.618794308527;4658.790354434059;4855.635827312965;4894.192458244385;5307.548858347045;5664;5691.402402747734;5880.029795083806;5935.367773862179;3973.324534829086;3977.1846771411792;4032.6169013943627;4044.8876558946527;4062.2890994076215;5083.262926875619;5591.120572904957;5712.172104926425;6062.181605483247;6232.444697673932;3848.84534639607;3919.92160156801;4093.385992101149;4114.465119534441;4139.77231252284;4000.3399439092805;4116.650084742771;4117.3206420940205;4147.232761939051;4161.938705630106;4247.660187185018;4848.9757551212015;4851.393575803025;4863.586595139453;4865.5620994109995;5309.33633295838;5930.487725630023;5938.673372964442;5995.370486098984;6010.248718910137;1264.6982491864717;1331.5206525650758;1344.4487760018346;1348.9730205395838;1354.0453979944314;836.3058661311097;905.9139381758722;920.5305294299956;923.6951805904035;931.6087243357806;4307.763073031013;4393.6704747144095;5113.130767769489;5267.552258058108;5271.683698977997;5027.366106015559;5043.571296439771;5630.690312032878;5809.767609295665;5817.476427121579;4681.95318046822;4892.486288939681;5270.868228294246;5305.973470132624;5407.70257635826;2612.595047767599;2898.941751356518;3038.2708150044273;3044.893428729984;3051.725344718986;5347.625666203328;5970.641761494324;6015.939840601625;6055.212822333068;6079.513638908877;4790.880227994328;5033.030511997938;5113.8721531962;5474.507294343449;5859.44335288147;4828.7102773833685;5311.362636483646;5670.489655930986;5800.564957628195;6011.849703757266;4773.809047638195;5056.761093532108;5283.682979021271;5761.551340680278;5793.304803423448;4964.131277026434;5124.154514505065;5262.578993680419;5276.841694749163;5609.120944483644;5387.434319396407;5629.971850140723;5765.596408251382;5776.9133462998925;6011.789587364421;3449.396030845669;3641.5448068991377;3662.414013757786;3813.8558432469595;3923.313420151519;4956.3804524434445;5806.458060582957;6057.787977420945;6058.666773327509;6089.908651370144;5118.539331460186;5367.731613419235;5764.164196191613;5890.617109887844;6012.579119461596;5857.531397488276;5995.490383317467;5997.520198384206;6002.159697642246;6018.284788835161;5343.973280133574;5399.8390346075785;5596.384397716167;5679.119736440858;5811.907713223151;5489.231507588861;5504.990678402434;5568.415316391721;5664.065429204135;6005.249343832021;4810.4467986182035;5061.848144555669;5727.5417966561745;5834.658028653349;5843.130198336661 06:05:04 INFO - PROCESS | 1659 | |5;yui.html;669.6819010969789;706.2443185791205;710.4032612605411;743.5167141358116;801.2268161224417;13926.721465570696;14674.926625366885;14681;14722.926385368084;14750.041247318917;11631.302121872672;13012.544560940369;13524.05331626784;13586.388612512435;13621.318934053283;844.8690452979782;858.8926384201975;859.0936561927165;863.8358711844761;864.148813418782;678.4911316512615;700.5551474813504;839.093778718982;843.1989609870648;848.2238751542362;866.4541338956449;877.1447838357614;902;904.5251243097393;904.9864252036225;850.1371108325025;894.4409743910056;895.3508706188027;897.4032268541412;897.4660077254024;650.5641220382355;659.1431139518606;669.223700507409;670.51722759613;673.5083389125965;14041.396947174926;14285.857141428556;14330.49843255481;14481.637959051002;14486.855131448656;13677.31613419335;13856.237906915116;13893.58319250424;13936.024478286525;13970.371333290026;11081.390523521202;11333.886661133365;11365.147613928988;11367.374794386305;11443.198976071679;3660.5790334111653;3672.4248878867875;3717.8512859485586;3760.5487341519192;3777.8866634001024;61625;91582.99999999933;91959;93790.59314110295;94088.05911940862;10639.787204255872;10731.83902241467;10855.837162442569;10918.672439826818;11091.83535728753;20981.790182098288;21368.893155534122;21413.464663383227;21466.463338416663;21627.78372216289;7536.171021187665;7630.427717921067;7638.618069096523;7736.419768517384;7839.45123841337;3654.3056819204267;4246.851360202378;4284.700070995001;4297.72064815786;4381.3208952612395;3436.8281585920604;3553.1650062235353;3555.0756803231347;3557.1462848916076;3569.39320315547;635.6789821140295;639.3223183425583;639.5555089213045;642.7782415066795;658.3942772649174;556.9582281328917;621.0125899819309;641.1472741254121;654.1659384285075;656.9685593618069;8744.016820005136;8866.157715017063;8973.551322433852;8985.101489850962;9156.130167634064;528.7409169506914;531.9148936170169;592.3049875447541;608.1880689279773;658.2397331082607;4385;4421;4453.198424283595;4462.620677242471;4527.207738645724;112136;119048;121408.46619571127;122296;123623;69068;87773;103603;105059.89880202353;106187.46906265419;67088;89018.55490722634;91248;91682.0831791687;92095.07904920865;8324.334053275845;8577.742667719978;8596.054434012378;8612.48325100496;8885.555722213992;58428.707856460445;58595.82808343724;58629.120563190736;58822.82354352804;58910.70544647249;51034.74482627563;67326.99009514763;69329.65335173292;83405.58297208475;85861.7120743177;9861.704148875546;12424.503019879103;12482.812757808822;12560.246385216551;12733.936330318289;12965.805512917503;14027.929860350632;14032.438702451787;14275.571732848031;14284.357203926056;11010.889891100986;11296.60461883863;11355.205135640426;11658.358790266617;13344.599662010156;11590.362530060927;11658.6502404928;12045.51817927273;12491.93754031224;13020.8046879295;12568;12807.551735689207;13060.333060332909;13270.33648317561;13693.863061369259;10106.949465252626;10460.68617941463;10607.363558186533;10647.680569582924;11108.666739997812;10763.677089687322;10813.24307298513;11088.5564577416;11198.104151667683;11380.317180969168 06:05:04 INFO - PROCESS | 1659 | __end_tp_report 06:05:04 INFO - PROCESS | 1659 | __start_cc_report 06:05:04 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,359 06:05:04 INFO - PROCESS | 1659 | __end_cc_report 06:05:04 INFO - PROCESS | 1659 | __startTimestamp1478700304195__endTimestamp 06:05:04 INFO - PROCESS | 1659 | 06:05:04 INFO - PROCESS | 1659 | ------- Summary: start ------- 06:05:04 INFO - PROCESS | 1659 | Number of tests: 6 06:05:04 INFO - PROCESS | 1659 | 06:05:04 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5605.85 Median:5807.45 stddev:709.02 (12.2%) stddev-sans-first:676.45 06:05:04 INFO - PROCESS | 1659 | Values: 2811.3 3307.3 3344.1 3363.3 3366.1 5192.3 5557.6 5564.7 5565.4 5600.1 5523.6 5617.3 5651.8 5655.9 5713.5 4030.7 4210.3 5056.3 5169.6 5174.5 4374.4 4851.7 5218.9 5232.5 5274.9 4216.4 5125.2 5191.4 5211.9 5290.6 4222.0 5081.4 5089.2 5131.8 5138.7 5063.3 5088.6 5093.1 5112.4 5117.0 4097.7 5459.5 5489.2 5520.8 5589.0 6002.2 6063.2 6105.2 6108.1 6169.9 6148.9 6161.8 6163.5 6182.5 6187.5 5603.6 5724.3 5737.1 5789.0 5798.4 6159.0 6196.9 6200.3 6225.3 6230.5 6081.5 6094.8 6122.4 6134.2 6144.5 4742.0 6120.7 6129.8 6132.9 6222.0 5012.0 6092.7 6109.9 6131.5 6219.5 6195.4 6198.9 6212.0 6222.4 6245.2 4819.3 4831.5 4938.5 4940.1 4977.1 4317.3 4327.3 4339.1 4375.3 4429.6 5619.7 5742.7 5748.9 5755.4 5807.4 6194.7 6208.3 6228.7 6241.7 6258.2 5585.2 5627.2 5679.1 5739.0 5741.0 5314.8 5349.1 5359.3 5389.4 5423.0 6145.3 6164.6 6251.2 6255.1 6281.1 5725.6 6159.8 6190.8 6220.0 6271.1 6170.5 6247.6 6285.9 6305.6 6320.3 5970.6 6094.6 6144.5 6167.9 6232.5 5974.3 6115.2 6127.8 6131.0 6182.1 6106.6 6111.8 6121.8 6122.2 6140.4 6085.9 6093.3 6093.8 6111.9 6127.4 4896.0 5170.6 5479.2 5847.6 5925.2 4982.2 5127.8 6044.1 6095.3 6137.5 5863.9 5881.8 5883.2 5889.0 5905.6 06:05:04 INFO - PROCESS | 1659 | 06:05:04 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:69906.82 Median:37929.62 stddev:157362.03 (414.9%) stddev-sans-first:157717.21 06:05:04 INFO - PROCESS | 1659 | Values: 511.4 514.8 532.6 553.8 555.3 30486.7 35867.3 38203.4 38246.8 39368.8 38729.0 39126.0 39151.4 39160.0 39193.2 9110.3 9253.2 9346.2 9354.5 9357.8 9246.4 9249.4 9258.1 9337.7 9372.4 9305.3 9306.0 9315.7 9343.5 9366.9 9161.4 9185.0 9243.8 9264.6 9352.0 9141.9 9162.4 9192.4 9251.6 9261.9 36909.1 37328.1 37385.0 37483.6 37563.0 3241.8 3262.3 3443.8 3444.2 3694.7 26498.7 29239.7 29287.6 29293.3 29306.4 3124.4 3234.5 3248.3 3283.0 3369.6 487460.0 489674.1 493076.0 494460.0 495783.0 51625.2 52037.0 53267.7 57575.7 61676.7 53372.7 55686.6 62257.4 63756.7 66798.0 15885.4 16142.5 16161.9 16209.0 16245.3 12192.6 12362.0 12366.5 12385.9 12544.3 19162.1 19349.6 19417.3 19476.6 19504.8 6811.8 7867.0 8042.6 8064.4 8072.6 855.1 866.8 930.3 1049.7 1054.7 28093.2 28580.0 28686.0 28885.0 29225.6 898.1 899.1 979.3 1046.9 1057.8 11939.0 12388.9 12484.6 14168.4 15056.4 634440.0 640134.0 668149.7 668710.0 673022.0 39912.6 44571.8 52210.0 54194.9 54235.0 1204.6 1337.1 1339.4 1363.3 1375.9 21231.3 26703.7 28112.3 28287.2 28768.0 44629.8 45646.9 45651.5 46353.0 46639.8 541563.0 607308.0 615810.0 616409.0 619434.0 26301.5 26324.1 26512.1 26616.3 26656.1 42450.8 42692.8 43650.3 43665.0 45771.3 36384.6 36687.3 37059.0 37415.8 37424.0 36351.3 36454.0 36709.3 37502.6 37655.8 30632.0 31454.7 35957.0 36583.5 36791.2 31339.4 31426.7 31527.1 32427.9 32550.0 23576.6 24245.6 24460.6 24591.9 25134.9 06:05:04 INFO - PROCESS | 1659 | 06:05:04 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:34097.66 Median:15291.29 stddev:89287.92 (583.9%) stddev-sans-first:89502.34 06:05:04 INFO - PROCESS | 1659 | Values: 302.0 371.7 378.7 394.3 411.5 15010.5 17941.2 18021.8 18598.0 19540.3 16538.4 17543.0 18238.9 19719.4 19899.4 5020.8 5306.5 5307.0 5312.4 5325.9 5095.6 5166.4 5226.2 5263.2 5263.9 5182.0 5257.8 5276.1 5279.7 5281.5 5117.7 5210.9 5224.3 5279.0 5283.7 4656.7 4865.7 5136.1 5142.4 5154.9 12780.1 25887.5 26609.2 27159.5 27655.9 2559.9 2581.2 2719.8 2750.0 2926.7 16197.9 17267.7 17299.1 17320.4 17413.7 1995.4 2069.0 2070.8 2149.1 2202.3 126045.4 126649.0 128986.4 130926.7 133173.3 20252.6 20931.9 20991.0 21275.0 21681.8 33878.0 33960.8 34030.7 34109.0 34119.0 8847.4 10368.3 10397.9 10519.5 10574.0 8533.0 8552.8 8576.5 8724.3 8744.2 9403.9 9434.4 9541.8 9586.8 10030.5 3459.3 3708.9 3818.4 3822.7 3826.8 844.2 903.3 909.8 941.9 976.6 19413.4 20223.2 20275.9 20318.0 20773.2 906.4 914.2 934.4 946.1 991.8 10160.7 10574.7 10584.9 10616.5 10617.7 434039.0 504674.0 505323.0 590425.0 595327.0 84187.6 133738.0 137928.3 143776.0 144966.0 968.2 984.1 1022.8 1022.9 1025.6 18300.0 18467.0 18755.9 18841.1 18996.6 42632.0 49600.8 54068.6 55247.6 56236.4 57966.0 66533.3 77505.0 77957.4 79645.6 7799.9 7920.3 8007.3 8139.1 8143.1 11248.2 12597.9 12652.3 12834.2 12882.5 11024.2 11063.9 11102.5 11187.0 11254.7 10584.1 10717.4 10875.2 10888.7 10893.0 10715.6 10753.6 11045.9 11052.8 11229.8 7821.7 7957.4 7963.3 8181.8 8191.7 10225.5 10781.7 11014.2 11077.6 11119.9 06:05:04 INFO - PROCESS | 1659 | 06:05:04 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5392.67 Median:4986.20 stddev:2999.91 (60.2%) stddev-sans-first:2993.88 06:05:04 INFO - PROCESS | 1659 | Values: 1475.1 1511.3 1725.3 1821.6 1861.4 7596.4 7894.0 8131.5 8583.2 8602.3 8067.5 8362.0 8389.5 8464.2 8488.2 2281.7 2319.2 2327.6 2329.3 2337.2 2331.4 2348.9 2364.2 2376.3 2385.1 2092.5 2248.9 2312.8 2336.4 2346.2 2296.6 2308.7 2326.1 2327.1 2327.5 2333.7 2358.3 2359.9 2363.2 2366.6 8433.8 8463.6 8502.1 8517.0 8519.6 5087.2 5219.5 5223.7 5225.2 5239.6 3118.0 3193.2 3410.5 3424.3 3438.5 974.0 1009.3 1023.0 1032.9 1034.4 10448.4 10715.0 10809.8 10832.9 10975.8 3760.3 4280.4 4369.7 4480.6 4488.6 8245.6 8725.5 8736.2 8740.8 8749.1 5034.1 5108.4 5112.1 5135.2 5138.0 4313.2 4459.2 4610.1 4755.9 4814.7 2877.4 3118.9 3633.7 3679.7 3711.3 1159.8 1172.4 1172.5 1178.4 1179.6 805.7 884.3 910.6 925.4 937.3 4300.6 4457.4 4754.7 5615.5 5821.6 364.6 437.2 445.2 450.4 451.2 3672.3 3812.7 3876.6 3887.1 3927.3 9860.1 10130.8 10283.3 10287.2 10289.0 9353.0 9777.4 10220.2 10266.0 10271.0 7474.2 7729.6 7787.1 7956.3 7968.0 5646.0 5725.6 5755.7 5800.6 5830.3 9038.7 9356.3 9365.7 9387.8 9405.6 9491.7 9512.7 9563.3 9601.3 9665.0 6620.9 6857.5 7016.5 7158.3 7312.0 7918.4 8002.8 8004.4 8055.4 8088.0 7034.4 7148.8 7278.6 7325.9 7401.5 6154.7 6907.9 6972.6 7060.5 7193.8 6701.7 6706.4 6790.6 6796.6 6812.6 4907.3 4919.4 4933.9 4961.8 5022.3 4251.3 4930.2 4961.4 5010.6 5033.3 06:05:04 INFO - PROCESS | 1659 | 06:05:04 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4631.90 Median:5121.35 stddev:1402.46 (27.4%) stddev-sans-first:1368.27 06:05:04 INFO - PROCESS | 1659 | Values: 304.8 316.1 316.3 320.9 321.2 5392.7 5397.8 5437.6 5583.7 5761.0 4286.3 5280.3 5305.8 5513.4 5654.9 4256.6 4260.8 4261.5 4267.5 4277.2 3555.9 4105.3 4247.4 4273.7 4277.7 4185.9 4202.7 4203.7 4207.3 4211.4 4180.7 4198.7 4219.0 4229.5 4229.6 3243.7 3695.6 3707.9 3727.8 3729.1 4984.5 5151.1 5378.8 5420.6 5441.2 4085.5 4235.6 4658.8 4855.6 4894.2 5307.5 5664.0 5691.4 5880.0 5935.4 3973.3 3977.2 4032.6 4044.9 4062.3 5083.3 5591.1 5712.2 6062.2 6232.4 3848.8 3919.9 4093.4 4114.5 4139.8 4000.3 4116.7 4117.3 4147.2 4161.9 4247.7 4849.0 4851.4 4863.6 4865.6 5309.3 5930.5 5938.7 5995.4 6010.2 1264.7 1331.5 1344.4 1349.0 1354.0 836.3 905.9 920.5 923.7 931.6 4307.8 4393.7 5113.1 5267.6 5271.7 5027.4 5043.6 5630.7 5809.8 5817.5 4682.0 4892.5 5270.9 5306.0 5407.7 2612.6 2898.9 3038.3 3044.9 3051.7 5347.6 5970.6 6015.9 6055.2 6079.5 4790.9 5033.0 5113.9 5474.5 5859.4 4828.7 5311.4 5670.5 5800.6 6011.8 4773.8 5056.8 5283.7 5761.6 5793.3 4964.1 5124.2 5262.6 5276.8 5609.1 5387.4 5630.0 5765.6 5776.9 6011.8 3449.4 3641.5 3662.4 3813.9 3923.3 4956.4 5806.5 6057.8 6058.7 6089.9 5118.5 5367.7 5764.2 5890.6 6012.6 5857.5 5995.5 5997.5 6002.2 6018.3 5344.0 5399.8 5596.4 5679.1 5811.9 5489.2 5505.0 5568.4 5664.1 6005.2 4810.4 5061.8 5727.5 5834.7 5843.1 06:05:04 INFO - PROCESS | 1659 | 06:05:04 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:20794.38 Median:4339.52 stddev:31071.60 (716.0%) stddev-sans-first:31122.02 06:05:04 INFO - PROCESS | 1659 | Values: 669.7 706.2 710.4 743.5 801.2 13926.7 14674.9 14681.0 14722.9 14750.0 11631.3 13012.5 13524.1 13586.4 13621.3 844.9 858.9 859.1 863.8 864.1 678.5 700.6 839.1 843.2 848.2 866.5 877.1 902.0 904.5 905.0 850.1 894.4 895.4 897.4 897.5 650.6 659.1 669.2 670.5 673.5 14041.4 14285.9 14330.5 14481.6 14486.9 13677.3 13856.2 13893.6 13936.0 13970.4 11081.4 11333.9 11365.1 11367.4 11443.2 3660.6 3672.4 3717.9 3760.5 3777.9 61625.0 91583.0 91959.0 93790.6 94088.1 10639.8 10731.8 10855.8 10918.7 11091.8 20981.8 21368.9 21413.5 21466.5 21627.8 7536.2 7630.4 7638.6 7736.4 7839.5 3654.3 4246.9 4284.7 4297.7 4381.3 3436.8 3553.2 3555.1 3557.1 3569.4 635.7 639.3 639.6 642.8 658.4 557.0 621.0 641.1 654.2 657.0 8744.0 8866.2 8973.6 8985.1 9156.1 528.7 531.9 592.3 608.2 658.2 4385.0 4421.0 4453.2 4462.6 4527.2 112136.0 119048.0 121408.5 122296.0 123623.0 69068.0 87773.0 103603.0 105059.9 106187.5 67088.0 89018.6 91248.0 91682.1 92095.1 8324.3 8577.7 8596.1 8612.5 8885.6 58428.7 58595.8 58629.1 58822.8 58910.7 51034.7 67327.0 69329.7 83405.6 85861.7 9861.7 12424.5 12482.8 12560.2 12733.9 12965.8 14027.9 14032.4 14275.6 14284.4 11010.9 11296.6 11355.2 11658.4 13344.6 11590.4 11658.7 12045.5 12491.9 13020.8 12568.0 12807.6 13060.3 13270.3 13693.9 10106.9 10460.7 10607.4 10647.7 11108.7 10763.7 10813.2 11088.6 11198.1 11380.3 06:05:04 INFO - PROCESS | 1659 | -------- Summary: end -------- 06:05:04 INFO - PROCESS | 1659 | 06:05:04 INFO - TEST-INFO | 1659: exit 0 06:05:04 INFO - TEST-OK | dromaeo_css | took 1116145ms 06:05:04 INFO - TEST-START | kraken 06:05:04 INFO - operating with platform_type : mac_ 06:05:04 INFO - Initialising browser for kraken test... 06:05:04 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpwmM8ss/profile http://localhost:49267/getInfo.html) 06:05:07 INFO - PROCESS | 1666 | 2016-11-09 06:05:07.646 plugin-container[1668:10459] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 06:05:07 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:05:07 INFO - PROCESS | 1666 | 2016-11-09 06:05:07.647 plugin-container[1668:10459] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 06:05:07 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:05:07 INFO - PROCESS | 1666 | 2016-11-09 06:05:07.647 plugin-container[1668:10459] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:05:07 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 06:05:07 INFO - PROCESS | 1666 | colorDepth:24 06:05:07 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 06:05:07 INFO - PROCESS | 1666 | __metrics 06:05:07 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 06:05:08 INFO - TEST-INFO | 1666: exit 0 06:05:08 INFO - Browser initialized. 06:05:08 INFO - Running cycle 1/1 for kraken test... 06:05:08 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpwmM8ss/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:10 INFO - PROCESS | 1669 | 2016-11-09 06:05:10.933 plugin-container[1670:10569] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x892f, name = 'com.apple.tsm.portname' 06:05:10 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:05:10 INFO - PROCESS | 1669 | 2016-11-09 06:05:10.934 plugin-container[1670:10569] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4817, name = 'com.apple.CFPasteboardClient' 06:05:10 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:05:10 INFO - PROCESS | 1669 | 2016-11-09 06:05:10.934 plugin-container[1670:10569] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:05:20 INFO - PROCESS | 1669 | RSS: Main: 238686208 06:05:20 INFO - PROCESS | 1669 | 06:05:23 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:24 INFO - PROCESS | 1669 | RSS: Main: 251191296 06:05:24 INFO - PROCESS | 1669 | 06:05:27 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 06:05:27 INFO - PROCESS | 1669 | RSS: Main: 258756608 06:05:27 INFO - PROCESS | 1669 | 06:05:31 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 06:05:31 INFO - PROCESS | 1669 | RSS: Main: 260173824 06:05:31 INFO - PROCESS | 1669 | 06:05:33 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 06:05:34 INFO - PROCESS | 1669 | RSS: Main: 261353472 06:05:34 INFO - PROCESS | 1669 | 06:05:36 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:37 INFO - PROCESS | 1669 | RSS: Main: 262963200 06:05:37 INFO - PROCESS | 1669 | 06:05:39 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:40 INFO - PROCESS | 1669 | RSS: Main: 263864320 06:05:40 INFO - PROCESS | 1669 | 06:05:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 06:05:44 INFO - PROCESS | 1669 | RSS: Main: 264044544 06:05:44 INFO - PROCESS | 1669 | 06:05:46 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 06:05:47 INFO - PROCESS | 1669 | RSS: Main: 264347648 06:05:47 INFO - PROCESS | 1669 | 06:05:48 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:05:49 INFO - PROCESS | 1669 | RSS: Main: 264192000 06:05:49 INFO - PROCESS | 1669 | 06:05:51 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:05:52 INFO - PROCESS | 1669 | RSS: Main: 264544256 06:05:52 INFO - PROCESS | 1669 | 06:05:54 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:05:55 INFO - PROCESS | 1669 | RSS: Main: 264298496 06:05:55 INFO - PROCESS | 1669 | 06:05:58 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:05:58 INFO - PROCESS | 1669 | RSS: Main: 264241152 06:05:58 INFO - PROCESS | 1669 | 06:06:01 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:06:02 INFO - PROCESS | 1669 | RSS: Main: 264560640 06:06:02 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 06:06:04 INFO - PROCESS | 1669 | RSS: Main: 266309632 06:06:04 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | __start_tp_report 06:06:04 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 06:06:04 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 06:06:04 INFO - PROCESS | 1669 | |i|pagename|runs| 06:06:04 INFO - PROCESS | 1669 | |0;ai-astar;106;118;118;117;113;135;98;112;122;171 06:06:04 INFO - PROCESS | 1669 | |1;audio-beat-detection;151;120;116;154;119;116;118;116;142;114 06:06:04 INFO - PROCESS | 1669 | |2;audio-dft;199;212;266;205;195;196;199;196;194;208 06:06:04 INFO - PROCESS | 1669 | |3;audio-fft;82;58;59;86;62;85;83;83;89;61 06:06:04 INFO - PROCESS | 1669 | |4;audio-oscillator;88;70;87;72;70;72;86;70;73;89 06:06:04 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;88;102;136;85;90;91;122;86;90;87 06:06:04 INFO - PROCESS | 1669 | |6;imaging-darkroom;95;97;95;95;126;117;95;94;100;95 06:06:04 INFO - PROCESS | 1669 | |7;imaging-desaturate;88;94;86;86;91;87;91;89;90;116 06:06:04 INFO - PROCESS | 1669 | |8;json-parse-financial;52;53;52;55;58;56;58;58;56;57 06:06:04 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;68;72;77;103;81;73;66;98;69;69 06:06:04 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;87;93;89;82;91;88;91;92;80;106 06:06:04 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;151;177;132;164;165;167;152;149;237;150 06:06:04 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;179;177;175;174;178;178;177;180;174;177 06:06:04 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;70;68;69;69;70;67;68;67;69;70 06:06:04 INFO - PROCESS | 1669 | __end_tp_report 06:06:04 INFO - PROCESS | 1669 | __start_cc_report 06:06:04 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,945 06:06:04 INFO - PROCESS | 1669 | __end_cc_report 06:06:04 INFO - PROCESS | 1669 | __startTimestamp1478700364282__endTimestamp 06:06:04 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | ------- Summary: start ------- 06:06:04 INFO - PROCESS | 1669 | Number of tests: 14 06:06:04 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:121.00 Median:120.00 stddev:20.08 (16.7%) stddev-sans-first:20.55 06:06:04 INFO - PROCESS | 1669 | Values: 106.0 118.0 118.0 117.0 113.0 135.0 98.0 112.0 122.0 171.0 06:06:04 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:119.50 stddev:15.83 (13.2%) stddev-sans-first:14.11 06:06:04 INFO - PROCESS | 1669 | Values: 151.0 120.0 116.0 154.0 119.0 116.0 118.0 116.0 142.0 114.0 06:06:04 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:207.00 Median:202.00 stddev:21.59 (10.7%) stddev-sans-first:22.70 06:06:04 INFO - PROCESS | 1669 | Values: 199.0 212.0 266.0 205.0 195.0 196.0 199.0 196.0 194.0 208.0 06:06:04 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:74.80 Median:83.00 stddev:12.93 (15.6%) stddev-sans-first:13.44 06:06:04 INFO - PROCESS | 1669 | Values: 82.0 58.0 59.0 86.0 62.0 85.0 83.0 83.0 89.0 61.0 06:06:04 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:79.50 stddev:8.53 (10.7%) stddev-sans-first:8.19 06:06:04 INFO - PROCESS | 1669 | Values: 88.0 70.0 87.0 72.0 70.0 72.0 86.0 70.0 73.0 89.0 06:06:04 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:97.70 Median:87.50 stddev:17.47 (20.0%) stddev-sans-first:18.17 06:06:04 INFO - PROCESS | 1669 | Values: 88.0 102.0 136.0 85.0 90.0 91.0 122.0 86.0 90.0 87.0 06:06:04 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:100.90 Median:95.00 stddev:11.19 (11.8%) stddev-sans-first:11.66 06:06:04 INFO - PROCESS | 1669 | Values: 95.0 97.0 95.0 95.0 126.0 117.0 95.0 94.0 100.0 95.0 06:06:04 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:91.80 Median:89.50 stddev:8.87 (9.9%) stddev-sans-first:9.30 06:06:04 INFO - PROCESS | 1669 | Values: 88.0 94.0 86.0 86.0 91.0 87.0 91.0 89.0 90.0 116.0 06:06:04 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.50 stddev:2.42 (4.3%) stddev-sans-first:2.20 06:06:04 INFO - PROCESS | 1669 | Values: 52.0 53.0 52.0 55.0 58.0 56.0 58.0 58.0 56.0 57.0 06:06:04 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:77.60 Median:72.50 stddev:12.91 (17.8%) stddev-sans-first:13.22 06:06:04 INFO - PROCESS | 1669 | Values: 68.0 72.0 77.0 103.0 81.0 73.0 66.0 98.0 69.0 69.0 06:06:04 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:90.00 stddev:7.06 (7.8%) stddev-sans-first:7.41 06:06:04 INFO - PROCESS | 1669 | Values: 87.0 93.0 89.0 82.0 91.0 88.0 91.0 92.0 80.0 106.0 06:06:04 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:164.40 Median:164.50 stddev:28.41 (17.3%) stddev-sans-first:29.72 06:06:04 INFO - PROCESS | 1669 | Values: 151.0 177.0 132.0 164.0 165.0 167.0 152.0 149.0 237.0 150.0 06:06:04 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:177.50 stddev:2.02 (1.1%) stddev-sans-first:2.00 06:06:04 INFO - PROCESS | 1669 | Values: 179.0 177.0 175.0 174.0 178.0 178.0 177.0 180.0 174.0 177.0 06:06:04 INFO - PROCESS | 1669 | 06:06:04 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.16 (1.7%) stddev-sans-first:1.13 06:06:04 INFO - PROCESS | 1669 | Values: 70.0 68.0 69.0 69.0 70.0 67.0 68.0 67.0 69.0 70.0 06:06:04 INFO - PROCESS | 1669 | -------- Summary: end -------- 06:06:04 INFO - PROCESS | 1669 | 06:06:05 INFO - TEST-INFO | 1669: exit 0 06:06:05 INFO - TEST-OK | kraken | took 60315ms 06:06:05 INFO - SUITE-END | took 1176s 06:06:05 INFO - Completed test suite (00:19:36) 06:06:05 INFO - javascript benchmark 06:06:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7235.248231603656, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2811.2831228036853, 3307.2889328794304, 3344.08037789608, 3363.310521343125, 3366.057503898909, 5192.273081768555, 5557.5831812614015, 5564.721763911808, 5565.415631358705, 5600.131979543167, 5523.558115350772, 5617.269754931864, 5651.802186923458, 5655.886882262353, 5713.542916566675, 4030.717849750519, 4210.2842516772225, 5056.266841308017, 5169.586433085344, 5174.534291913727, 4374.387585737999, 4851.708897466146, 5218.8695282617855, 5232.529072383485, 5274.868128296785, 4216.388623649554, 5125.179971204608, 5191.402988656315, 5211.895762084775, 5290.629655924087, 4221.957780422187, 5081.441041485434, 5089.185730283137, 5131.846044618667, 5138.743062846843, 5063.3417655704525, 5088.618353623456, 5093.134167191549, 5112.437631860493, 5116.976604679042, 4097.713160078795, 5459.535939445152, 5489.204065410533, 5520.751566179531, 5589.0, 6002.189704389895, 6063.18147050147, 6105.186826067751, 6108.1143234230785, 6169.876602467971, 6148.907766383508, 6161.784337548164, 6163.537734669918, 6182.474489668383, 6187.474064704461, 5603.551715862721, 5724.255846739898, 5737.08206686928, 5789.04480760674, 5798.362180160179, 6158.969205153946, 6196.907046394308, 6200.348963358872, 6225.315215326311, 6230.501559875199, 6081.452669259699, 6094.75620975156, 6122.387761223931, 6134.171886795226, 6144.5084393248435, 4741.95258047422, 6120.66336351496, 6129.785457508966, 6132.936844521141, 6221.96889015552, 5012.0, 6092.664903430354, 6109.920916985209, 6131.50947924165, 6219.502439804804, 6195.380461953859, 6198.876022479525, 6211.9689401552705, 6222.439980401786, 6245.219347581552, 4819.277108433693, 4831.516848315211, 4938.456769755324, 4940.061388336205, 4977.129002424561, 4317.287647538121, 4327.2643650579475, 4339.110482351173, 4375.321825117112, 4429.579189976947, 5619.662820230799, 5742.712864356766, 5748.913766293509, 5755.424457554295, 5807.448292412214, 6194.690265486708, 6208.286047104551, 6228.657423841732, 6241.719122639402, 6258.249010118815, 5585.245991791137, 5627.155926610959, 5679.148127780866, 5738.971305143447, 5741.0, 5314.840554783363, 5349.117395629678, 5359.3032905722785, 5389.380221274525, 5422.996745602076, 6145.279321789906, 6164.568480206342, 6251.187345645037, 6255.093011513214, 6281.120643109968, 5725.627834190765, 6159.82186542058, 6190.845228869314, 6220.035894436189, 6271.090691849565, 6170.50635949132, 6247.625142491465, 6285.937140628535, 6305.621662700252, 6320.304766475776, 5970.552208584287, 6094.573379863367, 6144.539159562962, 6167.938320616916, 6232.501399888089, 5974.253218347707, 6115.1794953435965, 6127.830981140761, 6130.969345153246, 6182.103594978793, 6106.603070800384, 6111.755529778759, 6121.788327166137, 6122.215193971364, 6140.3552626975315, 6085.939140608714, 6093.329733729198, 6093.786717464867, 6111.877762444815, 6127.417895299939, 4896.0, 5170.6380553360905, 5479.205515200353, 5847.590668653153, 5925.200097986716, 4982.227754698028, 5127.794888204579, 6044.123602077586, 6095.299040610209, 6137.539684523589, 5863.882722345444, 5881.794137205177, 5883.2057672215415, 5889.0, 5905.557083218861], "value": 5560.008295037435, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.35313828007577, 514.7992283009625, 532.5632980955615, 553.7950958145484, 555.3086407422758, 30486.695133048663, 35867.28265434693, 38203.42694859579, 38246.80876595613, 39368.80315598421, 38729.0, 39126.0, 39151.41272880909, 39160.04199790013, 39193.21613567727, 9110.31672624554, 9253.167214950654, 9346.158845703885, 9354.485503297316, 9357.766055848624, 9246.44521328719, 9249.398789078721, 9258.120478554527, 9337.71986840396, 9372.437653740762, 9305.25557955362, 9305.95347023264, 9315.72052838416, 9343.486108264076, 9366.859497107549, 9161.404508706946, 9185.035571265054, 9243.815123697523, 9264.58309376073, 9352.018038106036, 9141.862872056925, 9162.404443711137, 9192.35653504255, 9251.6299348026, 9261.861072083924, 36909.07727306839, 37328.066798329986, 37385.0, 37483.625163748286, 37563.0, 3241.8379081045855, 3262.3149138680906, 3443.810590417551, 3444.2422667013216, 3694.7228957828, 26498.73501264982, 29239.68421421041, 29287.560686589717, 29293.26766830825, 29306.41387172266, 3124.3787029305367, 3234.450143475615, 3248.30161515273, 3283.0479161043268, 3369.6124945631323, 487460.0, 489674.1032589664, 493076.0, 494459.9999999964, 495783.0, 51625.225621615704, 52037.0, 53267.668308291824, 57575.71212143912, 61676.69161654163, 53372.73313633407, 55686.607834804454, 62257.37742622606, 63756.68121659362, 66798.0, 15885.364585416684, 16142.515724528283, 16161.868669193278, 16209.0, 16245.268962896462, 12192.634220973385, 12362.01103911685, 12366.505339786489, 12385.876141238652, 12544.310062946626, 19162.13770380336, 19349.61300774005, 19417.32039378615, 19476.610467790848, 19504.829710217433, 6811.761588344483, 7866.960665196638, 8042.597870106471, 8064.435489515795, 8072.636731347104, 855.1064137975831, 866.8093019535692, 930.297625292913, 1049.6746008737316, 1054.7257712994676, 28093.157205283875, 28579.999700010816, 28685.995990140244, 28884.98902538401, 29225.561616575767, 898.0525545549377, 899.105390136805, 979.3193730357476, 1046.8953104689622, 1057.767291195951, 11939.0, 12388.876111238773, 12484.563040293728, 14168.362423690958, 15056.397744090333, 634440.0, 640134.0, 668149.6592517006, 668710.0, 673022.0, 39912.60087399089, 44571.777141114086, 52210.0, 54194.91610167774, 54235.0, 1204.644629834201, 1337.0774165825549, 1339.4106593099004, 1363.2910886339048, 1375.9243241621807, 21231.256906008217, 26703.732962670125, 28112.29719257035, 28287.15138545847, 28768.0, 44629.76851157364, 45646.858828529555, 45651.54348456606, 46353.0, 46639.76680116577, 541563.0, 607308.0, 615810.0, 616409.0, 619434.0, 26301.4739705201, 26324.078657246904, 26512.072077477194, 26616.33459163459, 26656.06703765359, 42450.78774606107, 42692.78653606712, 43650.34524482199, 43665.0, 45771.31343029791, 36384.63615363812, 36687.26625467422, 37059.0, 37415.81292093522, 37424.0, 36351.27297454089, 36454.0, 36709.26581468409, 37502.62497374992, 37655.81172094122, 30632.0, 31454.685453145175, 35957.0, 36583.45124823183, 36791.2171417714, 31339.373212535167, 31426.68573314329, 31527.054188374386, 32427.946506686665, 32550.0, 23576.6463503051, 24245.636315455635, 24460.6330905033, 24591.877040614683, 25134.874325628254], "value": 19142.29374648373, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.01091425581217, 371.65621799835145, 378.70839453620715, 394.30011729180717, 411.5123578559407, 15010.474633387834, 17941.192646330914, 18021.819781802176, 18598.0, 19540.31608893689, 16538.42115525957, 17543.035133067675, 18238.908805455987, 19719.40841774749, 19899.403017909484, 5020.849374518771, 5306.522412982831, 5307.018201632691, 5312.389075256357, 5325.946740532584, 5095.6178286628465, 5166.354205724285, 5226.216067589873, 5263.1578947368425, 5263.868403289929, 5181.989512045153, 5257.789688412459, 5276.076686579852, 5279.656822306557, 5281.498257665516, 5117.744112794364, 5210.895782084356, 5224.346956630421, 5279.0, 5283.709395983219, 4656.720596764205, 4865.7349089236695, 5136.126858434075, 5142.434332223453, 5154.948450515484, 12780.10539262252, 25887.482250355075, 26609.201723948117, 27159.45681086387, 27655.861720691468, 2559.8720063996725, 2581.1998280532907, 2719.7552220300267, 2749.982506472598, 2926.7123663832585, 16197.908413880494, 17267.65464690699, 17299.13504324779, 17320.393786217548, 17413.738793918103, 1995.3814317561603, 2069.048237810594, 2070.7618623858298, 2149.0758973641327, 2202.3392982105306, 126045.36977315055, 126649.0, 128986.35506822499, 130926.6907330924, 133173.3365332688, 20252.59494810125, 20931.8953405232, 20991.0, 21275.042623081998, 21681.783182168292, 33877.98366049022, 33960.83019584886, 34030.65969340275, 34109.0, 34118.97643070712, 8847.42491738035, 10368.274220804471, 10397.948010259901, 10519.474026298654, 10574.048335649675, 8533.0, 8552.828943421096, 8576.485410875368, 8724.258438032712, 8744.213020828029, 9403.905960940303, 9434.386764860263, 9541.809163816684, 9586.808263834684, 10030.498475076218, 3459.308138372285, 3708.851645934132, 3818.427235914635, 3822.7324087314178, 3826.7895265760094, 844.2444012608681, 903.3089686389917, 909.7543663210896, 941.8540126280437, 976.5654283843763, 19413.4175974721, 20223.19107235694, 20275.898620507098, 20318.0, 20773.169073236902, 906.3972458315278, 914.2320450821342, 934.4486752815872, 946.1153821177221, 991.8065977134534, 10160.745981350377, 10574.682759517073, 10584.947075264574, 10616.522256498476, 10617.73455663599, 434039.0, 504674.0, 505323.0, 590425.0, 595327.0, 84187.57906210552, 133738.0, 137928.31035844958, 143776.0, 144966.0, 968.2060710217695, 984.13396211335, 1022.7801022780138, 1022.9335093218917, 1025.564135242519, 18299.993500357075, 18467.0, 18755.90622046881, 18841.057947102316, 18996.620067598295, 42632.0, 49600.751996239786, 54068.64828379165, 55247.618809528474, 56236.43763562476, 57966.0, 66533.33666658372, 77505.0, 77957.37362324266, 79645.60177199077, 7799.922000780147, 7920.326772224195, 8007.279344858991, 8139.14538973423, 8143.063547692092, 11248.212625116163, 12597.874021260037, 12652.304123273309, 12834.229946203257, 12882.484700612245, 11024.228304018641, 11063.889361106609, 11102.500387482422, 11187.049100826522, 11254.662360129209, 10584.100351470212, 10717.410542420243, 10875.184361172785, 10888.67333979982, 10893.019628233496, 10715.624953126604, 10753.569857205937, 11045.944770276097, 11052.778944421227, 11229.775404492028, 7821.687132514863, 7957.363410927228, 7963.323117535075, 8181.836363272821, 8191.713290034821, 10225.539850706587, 10781.676549703521, 11014.173936954921, 11077.612283570037, 11119.888801111885], "value": 10313.220874023755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1475.0854470228458, 1511.2594828534018, 1725.284007137038, 1821.61746033333, 1861.3764388929717, 7596.354309883653, 7893.960530197355, 8131.519886434635, 8583.227509524133, 8602.268807151391, 8067.515949043047, 8361.954755655543, 8389.496630202177, 8464.23821856033, 8488.151184881508, 2281.7147856517977, 2319.1535089692225, 2327.6392159215347, 2329.3244958961964, 2337.240396871015, 2331.3821837213154, 2348.9412764680933, 2364.243442098529, 2376.2633583589054, 2385.057902128658, 2092.49780052787, 2248.9325320240337, 2312.838101332907, 2336.3575016870413, 2346.190564255338, 2296.5636529059425, 2308.734495533002, 2326.09282379872, 2327.080803082781, 2327.487952650423, 2333.7316208636053, 2358.327876555191, 2359.929202123939, 2363.2319496163645, 2366.6331718583474, 8433.831323373499, 8463.576821158978, 8502.06477287498, 8517.0, 8519.574021298973, 5087.186050231982, 5219.5041471060185, 5223.660462069954, 5225.16397376418, 5239.633225674204, 3117.953230701541, 3193.1857376369107, 3410.5395771571016, 3424.3151369725906, 3438.535797667308, 973.9805203895953, 1009.3489699144085, 1022.9539670714836, 1032.891546387626, 1034.3948789957883, 10448.425336606484, 10715.0, 10809.83785243222, 10832.891671083345, 10975.780484390347, 3760.3231418344963, 4280.422143010716, 4369.6722745794195, 4480.641548676098, 4488.640908727294, 8245.587720613945, 8725.520096394632, 8736.213740763362, 8740.825183496294, 8749.125087491328, 5034.144195486703, 5108.412532558803, 5112.054269960069, 5135.178371460548, 5137.972405518836, 4313.180495705806, 4459.175052615212, 4610.101030299126, 4755.857324280277, 4814.6870453420415, 2877.3669792645583, 3118.9239712299222, 3633.6729694327637, 3679.7056235501095, 3711.3319602471274, 1159.7796418680593, 1172.4430895324824, 1172.5427083437467, 1178.393127539318, 1179.598936361641, 805.7260531419346, 884.3102380143498, 910.5840418149709, 925.4354843545432, 937.3409065953225, 4300.61294483498, 4457.375967364572, 4754.738489383048, 5615.522680572197, 5821.621594596338, 364.5661662621472, 437.18028696194636, 445.2053085242891, 450.39871771185835, 451.23515640988865, 3672.265546890633, 3812.7401072083526, 3876.573576906538, 3887.1448281378052, 3927.3323534999117, 9860.06329398706, 10130.797384052425, 10283.331583447052, 10287.177025837915, 10289.022542858416, 9353.01793311706, 9777.41335519871, 10220.233482488844, 10266.0, 10271.0, 7474.177840437547, 7729.5748733819055, 7787.104482984416, 7956.283934445812, 7968.0, 5646.027156461684, 5725.627834190765, 5755.683437410815, 5800.56495762811, 5830.329512106162, 9038.683646072355, 9356.345055846026, 9365.719028429157, 9387.765305867135, 9405.576749046173, 9491.66779162726, 9512.714618561455, 9563.330566860253, 9601.279904007088, 9664.951675241578, 6620.90068648961, 6857.5199736018, 7016.543924644881, 7158.319959603829, 7312.049433573601, 7918.445708800559, 8002.799930001796, 8004.399670024655, 8055.436119471581, 8088.0, 7034.437245020488, 7148.785536433916, 7278.599677017603, 7325.890111648223, 7401.5189012714, 6154.723037463415, 6907.89638155418, 6972.616506092214, 7060.470464715064, 7193.784186474205, 6701.731930722716, 6706.396424321834, 6790.5925644461495, 6796.626185559841, 6812.591244525344, 4907.288443175648, 4919.385076865392, 4933.925991110064, 4961.82633607822, 5022.3219865317715, 4251.256030194765, 4930.186519224288, 4961.355023846877, 5010.574101201439, 5033.295338652519], "value": 4287.640073592856, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.82472578267505, 316.1006935269159, 316.26941764523946, 320.8684439379855, 321.17618309037334, 5392.703401312926, 5397.784088636455, 5437.6465529740535, 5583.664980101197, 5760.971195144029, 4286.256795650778, 5280.313559237304, 5305.761240744167, 5513.4210907854595, 5654.928451514913, 4256.616904478597, 4260.808263628144, 4261.509926358477, 4267.509236437811, 4277.165952639237, 3555.8577656893694, 4105.2815757242515, 4247.384129301249, 4273.675160700177, 4277.700560960734, 4185.937210941838, 4202.70581059326, 4203.726757760735, 4207.263728847454, 4211.410402543646, 4180.686448516373, 4198.748075115487, 4219.038147261507, 4229.492460904696, 4229.610270197329, 3243.7405007599573, 3695.6489133532273, 3707.925841483182, 3727.7576957497677, 3729.1050147964565, 4984.526469985346, 5151.124308867502, 5378.757955891955, 5420.593455490854, 5441.15000899696, 4085.4688890444054, 4235.618794308527, 4658.790354434059, 4855.635827312965, 4894.192458244385, 5307.548858347045, 5664.0, 5691.402402747734, 5880.029795083806, 5935.367773862179, 3973.324534829086, 3977.1846771411792, 4032.6169013943627, 4044.8876558946527, 4062.2890994076215, 5083.262926875619, 5591.120572904957, 5712.172104926425, 6062.181605483247, 6232.444697673932, 3848.84534639607, 3919.92160156801, 4093.385992101149, 4114.465119534441, 4139.77231252284, 4000.3399439092805, 4116.650084742771, 4117.3206420940205, 4147.232761939051, 4161.938705630106, 4247.660187185018, 4848.9757551212015, 4851.393575803025, 4863.586595139453, 4865.5620994109995, 5309.33633295838, 5930.487725630023, 5938.673372964442, 5995.370486098984, 6010.248718910137, 1264.6982491864717, 1331.5206525650758, 1344.4487760018346, 1348.9730205395838, 1354.0453979944314, 836.3058661311097, 905.9139381758722, 920.5305294299956, 923.6951805904035, 931.6087243357806, 4307.763073031013, 4393.6704747144095, 5113.130767769489, 5267.552258058108, 5271.683698977997, 5027.366106015559, 5043.571296439771, 5630.690312032878, 5809.767609295665, 5817.476427121579, 4681.95318046822, 4892.486288939681, 5270.868228294246, 5305.973470132624, 5407.70257635826, 2612.595047767599, 2898.941751356518, 3038.2708150044273, 3044.893428729984, 3051.725344718986, 5347.625666203328, 5970.641761494324, 6015.939840601625, 6055.212822333068, 6079.513638908877, 4790.880227994328, 5033.030511997938, 5113.8721531962, 5474.507294343449, 5859.44335288147, 4828.7102773833685, 5311.362636483646, 5670.489655930986, 5800.564957628195, 6011.849703757266, 4773.809047638195, 5056.761093532108, 5283.682979021271, 5761.551340680278, 5793.304803423448, 4964.131277026434, 5124.154514505065, 5262.578993680419, 5276.841694749163, 5609.120944483644, 5387.434319396407, 5629.971850140723, 5765.596408251382, 5776.9133462998925, 6011.789587364421, 3449.396030845669, 3641.5448068991377, 3662.414013757786, 3813.8558432469595, 3923.313420151519, 4956.3804524434445, 5806.458060582957, 6057.787977420945, 6058.666773327509, 6089.908651370144, 5118.539331460186, 5367.731613419235, 5764.164196191613, 5890.617109887844, 6012.579119461596, 5857.531397488276, 5995.490383317467, 5997.520198384206, 6002.159697642246, 6018.284788835161, 5343.973280133574, 5399.8390346075785, 5596.384397716167, 5679.119736440858, 5811.907713223151, 5489.231507588861, 5504.990678402434, 5568.415316391721, 5664.065429204135, 6005.249343832021, 4810.4467986182035, 5061.848144555669, 5727.5417966561745, 5834.658028653349, 5843.130198336661], "value": 4183.284857204448, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.6819010969789, 706.2443185791205, 710.4032612605411, 743.5167141358116, 801.2268161224417, 13926.721465570696, 14674.926625366885, 14681.0, 14722.926385368084, 14750.041247318917, 11631.302121872672, 13012.544560940369, 13524.05331626784, 13586.388612512435, 13621.318934053283, 844.8690452979782, 858.8926384201975, 859.0936561927165, 863.8358711844761, 864.148813418782, 678.4911316512615, 700.5551474813504, 839.093778718982, 843.1989609870648, 848.2238751542362, 866.4541338956449, 877.1447838357614, 902.0, 904.5251243097393, 904.9864252036225, 850.1371108325025, 894.4409743910056, 895.3508706188027, 897.4032268541412, 897.4660077254024, 650.5641220382355, 659.1431139518606, 669.223700507409, 670.51722759613, 673.5083389125965, 14041.396947174926, 14285.857141428556, 14330.49843255481, 14481.637959051002, 14486.855131448656, 13677.31613419335, 13856.237906915116, 13893.58319250424, 13936.024478286525, 13970.371333290026, 11081.390523521202, 11333.886661133365, 11365.147613928988, 11367.374794386305, 11443.198976071679, 3660.5790334111653, 3672.4248878867875, 3717.8512859485586, 3760.5487341519192, 3777.8866634001024, 61625.0, 91582.99999999933, 91959.0, 93790.59314110295, 94088.05911940862, 10639.787204255872, 10731.83902241467, 10855.837162442569, 10918.672439826818, 11091.83535728753, 20981.790182098288, 21368.893155534122, 21413.464663383227, 21466.463338416663, 21627.78372216289, 7536.171021187665, 7630.427717921067, 7638.618069096523, 7736.419768517384, 7839.45123841337, 3654.3056819204267, 4246.851360202378, 4284.700070995001, 4297.72064815786, 4381.3208952612395, 3436.8281585920604, 3553.1650062235353, 3555.0756803231347, 3557.1462848916076, 3569.39320315547, 635.6789821140295, 639.3223183425583, 639.5555089213045, 642.7782415066795, 658.3942772649174, 556.9582281328917, 621.0125899819309, 641.1472741254121, 654.1659384285075, 656.9685593618069, 8744.016820005136, 8866.157715017063, 8973.551322433852, 8985.101489850962, 9156.130167634064, 528.7409169506914, 531.9148936170169, 592.3049875447541, 608.1880689279773, 658.2397331082607, 4385.0, 4421.0, 4453.198424283595, 4462.620677242471, 4527.207738645724, 112136.0, 119048.0, 121408.46619571127, 122296.0, 123623.0, 69068.0, 87773.0, 103603.0, 105059.89880202353, 106187.46906265419, 67088.0, 89018.55490722634, 91248.0, 91682.0831791687, 92095.07904920865, 8324.334053275845, 8577.742667719978, 8596.054434012378, 8612.48325100496, 8885.555722213992, 58428.707856460445, 58595.82808343724, 58629.120563190736, 58822.82354352804, 58910.70544647249, 51034.74482627563, 67326.99009514763, 69329.65335173292, 83405.58297208475, 85861.7120743177, 9861.704148875546, 12424.503019879103, 12482.812757808822, 12560.246385216551, 12733.936330318289, 12965.805512917503, 14027.929860350632, 14032.438702451787, 14275.571732848031, 14284.357203926056, 11010.889891100986, 11296.60461883863, 11355.205135640426, 11658.358790266617, 13344.599662010156, 11590.362530060927, 11658.6502404928, 12045.51817927273, 12491.93754031224, 13020.8046879295, 12568.0, 12807.551735689207, 13060.333060332909, 13270.33648317561, 13693.863061369259, 10106.949465252626, 10460.68617941463, 10607.363558186533, 10647.680569582924, 11108.666739997812, 10763.677089687322, 10813.24307298513, 11088.5564577416, 11198.104151667683, 11380.317180969168], "value": 7285.739818773723, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 118.0, 117.0, 113.0, 135.0, 98.0, 112.0, 122.0, 171.0], "value": 121.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 120.0, 116.0, 154.0, 119.0, 116.0, 118.0, 116.0, 142.0, 114.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 212.0, 266.0, 205.0, 195.0, 196.0, 199.0, 196.0, 194.0, 208.0], "value": 207.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 86.0, 62.0, 85.0, 83.0, 83.0, 89.0, 61.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 87.0, 72.0, 70.0, 72.0, 86.0, 70.0, 73.0, 89.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 102.0, 136.0, 85.0, 90.0, 91.0, 122.0, 86.0, 90.0, 87.0], "value": 97.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 126.0, 117.0, 95.0, 94.0, 100.0, 95.0], "value": 100.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 94.0, 86.0, 86.0, 91.0, 87.0, 91.0, 89.0, 90.0, 116.0], "value": 91.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 55.0, 58.0, 56.0, 58.0, 58.0, 56.0, 57.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 77.0, 103.0, 81.0, 73.0, 66.0, 98.0, 69.0, 69.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 93.0, 89.0, 82.0, 91.0, 88.0, 91.0, 92.0, 80.0, 106.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 177.0, 132.0, 164.0, 165.0, 167.0, 152.0, 149.0, 237.0, 150.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 177.0, 175.0, 174.0, 178.0, 178.0, 177.0, 180.0, 174.0, 177.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 69.0, 70.0, 67.0, 68.0, 67.0, 69.0, 70.0], "value": 68.7, "unit": "score"}]}]} 06:06:05 INFO - Return code: 0 06:06:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:06:05 ERROR - # TBPL SUCCESS # 06:06:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:06:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:06:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:06:05 INFO - 2016-11-09 06:06:05.620 screenresolution[1674:10949] starting screenresolution argv=screenresolution get 06:06:05 INFO - 2016-11-09 06:06:05.622 screenresolution[1674:10949] Display 0: 1600x1200x32@60 06:06:05 INFO - 2016-11-09 06:06:05.628 screenresolution[1675:10952] starting screenresolution argv=screenresolution list 06:06:05 INFO - Available Modes on Display 0 06:06:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:06:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:06:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:06:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:06:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:06:05 INFO - Intel Iris: 06:06:05 INFO - Chipset Model: Intel Iris 06:06:05 INFO - Type: GPU 06:06:05 INFO - Bus: Built-In 06:06:05 INFO - VRAM (Dynamic, Max): 1536 MB 06:06:05 INFO - Vendor: Intel (0x8086) 06:06:05 INFO - Device ID: 0x0a2e 06:06:05 INFO - Revision ID: 0x0009 06:06:05 INFO - Displays: 06:06:05 INFO - Display: 06:06:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:06:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:06:05 INFO - Display Serial Number: 1600x1200 60 06:06:05 INFO - Main Display: Yes 06:06:05 INFO - Mirror: Off 06:06:05 INFO - Online: Yes 06:06:05 INFO - Rotation: Supported 06:06:05 INFO - Return code: 0 06:06:05 INFO - Running post-action listener: _resource_record_post_action 06:06:05 INFO - [mozharness: 2016-11-09 14:06:05.862713Z] Finished run-tests step (success) 06:06:05 INFO - Running post-run listener: _resource_record_post_run 06:06:05 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 34476032; Write bytes: 708596224; Read time: 322; Write time: 1948 06:06:05 INFO - TinderboxPrint: CPU usage
54.9% 06:06:05 INFO - TinderboxPrint: I/O read bytes / time
34,476,032 / 322 06:06:05 INFO - TinderboxPrint: I/O write bytes / time
708,596,224 / 1,948 06:06:05 INFO - TinderboxPrint: CPU idle
2,186.4 (45.1%) 06:06:05 INFO - TinderboxPrint: CPU system
984.4 (20.3%) 06:06:05 INFO - TinderboxPrint: CPU user
1,674.8 (34.6%) 06:06:05 INFO - TinderboxPrint: Swap in / out
434,237,440 / 0 06:06:05 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384338432; Write bytes: 378976256; Read time: 28128; Write time: 719 06:06:05 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 33538048; Write bytes: 301906432; Read time: 308; Write time: 1173 06:06:06 INFO - Running post-run listener: _upload_blobber_files 06:06:06 INFO - Blob upload gear active. 06:06:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:06:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:06:06 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:06:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:06:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:08 INFO - (blobuploader) - INFO - Done attempting. 06:06:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:06:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:06:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:09 INFO - (blobuploader) - INFO - Done attempting. 06:06:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:06:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:06:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:11 INFO - (blobuploader) - INFO - Done attempting. 06:06:11 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:11 INFO - Return code: 0 06:06:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:06:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ff90716679f8ee072b5be5e67ff0d98ddd0dccb5a2556569df7088547e19f46fde60a9a9590041d9de7bee514b15ee0e0e016d563bcf8fa41aec504d831dff0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2c984080806f6687538bb41544241108c8d497da7c260397621d811dd1cba5c25a2f9f4c6df37ac14df19dc5debce22ece2007a3eb40c254999813d276101de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2612a0b7e284f19fa9083a44723d661c3bf1afa218c412a401a87c7619fff133ca66066ecb12e3d8b66dec8594ed5d4b285dc15afe9459e9f4623ee9f60f8d06"} 06:06:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:06:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:06:11 INFO - Contents: 06:06:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ff90716679f8ee072b5be5e67ff0d98ddd0dccb5a2556569df7088547e19f46fde60a9a9590041d9de7bee514b15ee0e0e016d563bcf8fa41aec504d831dff0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2c984080806f6687538bb41544241108c8d497da7c260397621d811dd1cba5c25a2f9f4c6df37ac14df19dc5debce22ece2007a3eb40c254999813d276101de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2612a0b7e284f19fa9083a44723d661c3bf1afa218c412a401a87c7619fff133ca66066ecb12e3d8b66dec8594ed5d4b285dc15afe9459e9f4623ee9f60f8d06"} 06:06:11 INFO - Running post-run listener: copy_logs_to_upload_dir 06:06:11 INFO - Copying logs to upload dir... 06:06:11 INFO - mkdir: /builds/slave/test/build/upload/logs 06:06:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.135430 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-09 06:06:11.464625) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 06:06:11.468367) ========= 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.jcNv1UNtG9/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.2DiziUh8zj/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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/5ff90716679f8ee072b5be5e67ff0d98ddd0dccb5a2556569df7088547e19f46fde60a9a9590041d9de7bee514b15ee0e0e016d563bcf8fa41aec504d831dff0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2c984080806f6687538bb41544241108c8d497da7c260397621d811dd1cba5c25a2f9f4c6df37ac14df19dc5debce22ece2007a3eb40c254999813d276101de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2612a0b7e284f19fa9083a44723d661c3bf1afa218c412a401a87c7619fff133ca66066ecb12e3d8b66dec8594ed5d4b285dc15afe9459e9f4623ee9f60f8d06"} build_url:https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010947 build_url: 'https://queue.taskcluster.net/v1/task/Bicm2FvRQdmqjNoHSRRSEQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ff90716679f8ee072b5be5e67ff0d98ddd0dccb5a2556569df7088547e19f46fde60a9a9590041d9de7bee514b15ee0e0e016d563bcf8fa41aec504d831dff0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2c984080806f6687538bb41544241108c8d497da7c260397621d811dd1cba5c25a2f9f4c6df37ac14df19dc5debce22ece2007a3eb40c254999813d276101de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2612a0b7e284f19fa9083a44723d661c3bf1afa218c412a401a87c7619fff133ca66066ecb12e3d8b66dec8594ed5d4b285dc15afe9459e9f4623ee9f60f8d06"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 06:06:11.500942) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 06:06:11.501275) ========= 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.jcNv1UNtG9/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.2DiziUh8zj/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.004638 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 06:06:11.550680) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-09 06:06:11.551417) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-09 06:06:11.552162) ========= ========= Total master_lag: 0.18 =========