builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0011 starttime: 1479224086.19 results: success (0) buildid: 20161115060313 builduid: 849d8dca843243caa0d5767b9fc26ccf revision: bfaa16ab61ee71dd05d27e2b07244032207b5dad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:46.191782) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:46.192276) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:46.192555) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:46.220240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:46.220695) ========= 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.9ADDzah3LA/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.3vM1IRqVmS/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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-15 07:34:46-- 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% 10.0M=0.001s 2016-11-15 07:34:46 (10.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084256 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:46.327778) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:46.328108) ========= 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.9ADDzah3LA/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.3vM1IRqVmS/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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.027385 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:46.376825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-15 07:34:46.377176) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bfaa16ab61ee71dd05d27e2b07244032207b5dad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bfaa16ab61ee71dd05d27e2b07244032207b5dad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9ADDzah3LA/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.3vM1IRqVmS/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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-15 07:34:46,471 truncating revision to first 12 chars 2016-11-15 07:34:46,472 Setting DEBUG logging. 2016-11-15 07:34:46,472 attempt 1/10 2016-11-15 07:34:46,472 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bfaa16ab61ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-15 07:34:48,358 unpacking tar archive at: mozilla-aurora-bfaa16ab61ee/testing/mozharness/ program finished with exit code 0 elapsedTime=2.160102 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-15 07:34:48.559369) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:48.559690) ========= script_repo_revision: bfaa16ab61ee71dd05d27e2b07244032207b5dad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:48.560129) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:48.560419) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 07:34:48.579988) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-15 07:34:48.580546) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9ADDzah3LA/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.3vM1IRqVmS/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 07:34:48 INFO - MultiFileLogger online at 20161115 07:34:48 in /builds/slave/test 07:34:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:34:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:34:48 INFO - {'append_to_log': False, 07:34:48 INFO - 'base_work_dir': '/builds/slave/test', 07:34:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:34:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:34:48 INFO - 'branch': 'Mozilla-Aurora', 07:34:48 INFO - 'buildbot_json_path': 'buildprops.json', 07:34:48 INFO - 'config_files': ('talos/mac_config.py',), 07:34:48 INFO - 'default_actions': ('clobber', 07:34:48 INFO - 'read-buildbot-config', 07:34:48 INFO - 'download-and-extract', 07:34:48 INFO - 'populate-webroot', 07:34:48 INFO - 'create-virtualenv', 07:34:48 INFO - 'install', 07:34:48 INFO - 'run-tests'), 07:34:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:34:48 INFO - 'download_minidump_stackwalk': True, 07:34:48 INFO - 'download_symbols': 'ondemand', 07:34:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:34:48 INFO - 'tooltool.py': '/tools/tooltool.py', 07:34:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:34:48 INFO - '/tools/misc-python/virtualenv.py')}, 07:34:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:34:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:34:48 INFO - 'installer_path': 'installer.exe', 07:34:48 INFO - 'log_level': 'info', 07:34:48 INFO - 'log_name': 'talos', 07:34:48 INFO - 'log_to_console': True, 07:34:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:34:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:34:48 INFO - 'opt_config_files': (), 07:34:48 INFO - 'pip_index': False, 07:34:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:34:48 INFO - 'cmd': ('bash', 07:34:48 INFO - '-c', 07:34:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:34:48 INFO - 'enabled': True, 07:34:48 INFO - 'halt_on_failure': False, 07:34:48 INFO - 'name': 'check_screen_resolution'},), 07:34:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:34:48 INFO - 'cmd': ('bash', 07:34:48 INFO - '-c', 07:34:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:34:48 INFO - 'enabled': True, 07:34:48 INFO - 'halt_on_failure': False, 07:34:48 INFO - 'name': 'check_screen_resolution'},), 07:34:48 INFO - 'run_cmd_checks_enabled': True, 07:34:48 INFO - 'sps_profile': False, 07:34:48 INFO - 'sps_profile_interval': 0, 07:34:48 INFO - 'suite': 'dromaeojs-e10s', 07:34:48 INFO - 'system_bits': '32', 07:34:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:34:48 INFO - 'title': 't-yosemite-r7-0011', 07:34:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:34:48 INFO - 'use_talos_json': True, 07:34:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:34:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:34:48 INFO - 'work_dir': 'build'} 07:34:48 INFO - [mozharness: 2016-11-15 15:34:48.785544Z] Running clobber step. 07:34:48 INFO - Running pre-action listener: _resource_record_pre_action 07:34:48 INFO - Running main action method: clobber 07:34:48 INFO - rmtree: /builds/slave/test/build 07:34:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:34:51 INFO - Running post-action listener: _resource_record_post_action 07:34:51 INFO - [mozharness: 2016-11-15 15:34:51.138717Z] Finished clobber step (success) 07:34:51 INFO - [mozharness: 2016-11-15 15:34:51.138851Z] Running read-buildbot-config step. 07:34:51 INFO - Running pre-action listener: _resource_record_pre_action 07:34:51 INFO - Running main action method: read_buildbot_config 07:34:51 INFO - Using buildbot properties: 07:34:51 INFO - { 07:34:51 INFO - "project": "", 07:34:51 INFO - "product": "firefox", 07:34:51 INFO - "script_repo_revision": "production", 07:34:51 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 07:34:51 INFO - "repository": "", 07:34:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 07:34:51 INFO - "buildid": "20161115060313", 07:34:51 INFO - "pgo_build": "False", 07:34:51 INFO - "basedir": "/builds/slave/test", 07:34:51 INFO - "buildnumber": 455, 07:34:51 INFO - "slavename": "t-yosemite-r7-0011", 07:34:51 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:34:51 INFO - "platform": "yosemite_r7", 07:34:51 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:34:51 INFO - "branch": "mozilla-aurora", 07:34:51 INFO - "repo_path": "releases/mozilla-aurora", 07:34:51 INFO - "revision": "bfaa16ab61ee71dd05d27e2b07244032207b5dad", 07:34:51 INFO - "stage_platform": "macosx64", 07:34:51 INFO - "builduid": "849d8dca843243caa0d5767b9fc26ccf", 07:34:51 INFO - "slavebuilddir": "test" 07:34:51 INFO - } 07:34:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 07:34:51 INFO - Running post-action listener: _resource_record_post_action 07:34:51 INFO - [mozharness: 2016-11-15 15:34:51.142699Z] Finished read-buildbot-config step (success) 07:34:51 INFO - [mozharness: 2016-11-15 15:34:51.142817Z] Running download-and-extract step. 07:34:51 INFO - Running pre-action listener: _resource_record_pre_action 07:34:51 INFO - Running main action method: download_and_extract 07:34:51 INFO - mkdir: /builds/slave/test/build/tests 07:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:51 INFO - trying https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 07:34:51 INFO - Downloading https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:34:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 07:34:52 INFO - Downloaded 1199 bytes. 07:34:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:34:52 INFO - Using the following test package requirements: 07:34:52 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:34:52 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:34:52 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 07:34:52 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:34:52 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 07:34:52 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:34:52 INFO - u'jsshell-mac.zip'], 07:34:52 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:34:52 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 07:34:52 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:34:52 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:34:52 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 07:34:52 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:34:52 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 07:34:52 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:34:52 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 07:34:52 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:34:52 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 07:34:52 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:34:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:34:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:34:52 INFO - Fetch https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:34:53 INFO - Http code: 200 07:34:53 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 07:34:53 INFO - x-amz-cf-id: Nfc6w3GG-55Ew8wm8WtF0pOM7VTFOG2cafpZp0AbgSI9l5RieV4njw== 07:34:53 INFO - x-amz-version-id: _LfC4jQ8MhQSCUNer9mGEhmcxvumGCI0 07:34:53 INFO - Expected file size: 16327393 07:34:53 INFO - Obtained file size: 16327393 07:35:00 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:35:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:35:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:35:00 INFO - Fetch https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:35:00 INFO - Http code: 200 07:35:00 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 07:35:00 INFO - x-amz-cf-id: saBTbCziTuX5kr453-JMbX57U3jMuxAdxsGkWceUtYLuPLJ-Dn7PDA== 07:35:00 INFO - x-amz-version-id: _LfC4jQ8MhQSCUNer9mGEhmcxvumGCI0 07:35:01 INFO - Expected file size: 16327393 07:35:01 INFO - Obtained file size: 16327393 07:35:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 07:35:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:35:07 INFO - Fetch https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 07:35:08 INFO - Http code: 200 07:35:08 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 07:35:08 INFO - x-amz-cf-id: Sqhzy6uR4B3DO7zTEDqpk_Ryr7tWLp9nSz-g_1TycNNSj2YP6-FYyw== 07:35:08 INFO - x-amz-version-id: q5H6DwfA1PUKplTHCgJxJugsrLD2oB3b 07:35:08 INFO - Expected file size: 14409038 07:35:08 INFO - Obtained file size: 14409038 07:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:09 INFO - trying https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:35:09 INFO - Downloading https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 07:35:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 07:35:12 INFO - Downloaded 114362300 bytes. 07:35:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:35:12 INFO - mkdir: /builds/slave/test/properties 07:35:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:35:12 INFO - Writing to file /builds/slave/test/properties/build_url 07:35:12 INFO - Contents: 07:35:12 INFO - build_url:https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:35:12 INFO - Running post-action listener: _resource_record_post_action 07:35:12 INFO - Running post-action listener: set_extra_try_arguments 07:35:12 INFO - [mozharness: 2016-11-15 15:35:12.764954Z] Finished download-and-extract step (success) 07:35:12 INFO - [mozharness: 2016-11-15 15:35:12.765075Z] Running populate-webroot step. 07:35:12 INFO - Running pre-action listener: _resource_record_pre_action 07:35:12 INFO - Running main action method: populate_webroot 07:35:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:35:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:35:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:35:12 INFO - '--tppagecycles', 07:35:12 INFO - '7'], 07:35:12 INFO - 'tests': ['tsvgm']}}, 07:35:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:35:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:35:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:35:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:35:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:35:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:35:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:12 INFO - 'talos_options': ['--disable-e10s'], 07:35:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:12 INFO - 'talos_options': ['--disable-e10s'], 07:35:12 INFO - 'tests': ['damp', 'tps']}, 07:35:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:12 INFO - 'tests': ['damp', 'tps']}, 07:35:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:35:12 INFO - 'tests': ['dromaeo_dom']}, 07:35:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:35:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:35:12 INFO - 'tests': ['basic_compositor_video']}, 07:35:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:35:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:35:12 INFO - 'tests': ['a11yr', 07:35:12 INFO - 'ts_paint', 07:35:12 INFO - 'tpaint', 07:35:12 INFO - 'sessionrestore', 07:35:12 INFO - 'sessionrestore_no_auto_restore', 07:35:12 INFO - 'tabpaint']}, 07:35:12 INFO - 'other-e10s': {'tests': ['a11yr', 07:35:12 INFO - 'ts_paint', 07:35:12 INFO - 'tpaint', 07:35:12 INFO - 'sessionrestore', 07:35:12 INFO - 'sessionrestore_no_auto_restore', 07:35:12 INFO - 'tabpaint']}, 07:35:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:35:12 INFO - 'ts_paint', 07:35:12 INFO - 'tpaint', 07:35:12 INFO - 'sessionrestore', 07:35:12 INFO - 'sessionrestore_no_auto_restore', 07:35:12 INFO - 'tabpaint']}, 07:35:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:35:12 INFO - 'ts_paint', 07:35:12 INFO - 'tpaint', 07:35:12 INFO - 'sessionrestore', 07:35:12 INFO - 'sessionrestore_no_auto_restore', 07:35:12 INFO - 'tabpaint']}, 07:35:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:35:12 INFO - 'tests': ['a11yr', 07:35:12 INFO - 'ts_paint', 07:35:12 INFO - 'tpaint', 07:35:12 INFO - 'sessionrestore', 07:35:12 INFO - 'sessionrestore_no_auto_restore', 07:35:12 INFO - 'tabpaint']}, 07:35:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:35:12 INFO - 'tests': ['a11yr', 07:35:12 INFO - 'ts_paint', 07:35:12 INFO - 'tpaint', 07:35:12 INFO - 'sessionrestore', 07:35:12 INFO - 'sessionrestore_no_auto_restore', 07:35:12 INFO - 'tabpaint']}, 07:35:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:35:12 INFO - 'tests': ['tsvgx', 07:35:12 INFO - 'tsvgr_opacity', 07:35:12 INFO - 'tart', 07:35:12 INFO - 'tscrollx', 07:35:12 INFO - 'cart']}, 07:35:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:35:12 INFO - 'tsvgr_opacity', 07:35:12 INFO - 'tart', 07:35:12 INFO - 'tscrollx', 07:35:12 INFO - 'cart']}, 07:35:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:12 INFO - 'talos_options': ['--disable-e10s'], 07:35:12 INFO - 'tests': ['tp5o']}, 07:35:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:12 INFO - 'tests': ['tp5o']}, 07:35:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:12 INFO - 'talos_options': ['--disable-e10s', 07:35:12 INFO - '--xperf_path', 07:35:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:12 INFO - 'tests': ['tp5n']}, 07:35:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:12 INFO - 'talos_options': ['--xperf_path', 07:35:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:12 INFO - 'tests': ['tp5n']}}, 07:35:12 INFO - 'talos.zip': {'path': '', 07:35:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:35:12 INFO - Running post-action listener: _resource_record_post_action 07:35:12 INFO - [mozharness: 2016-11-15 15:35:12.784121Z] Finished populate-webroot step (success) 07:35:12 INFO - [mozharness: 2016-11-15 15:35:12.784261Z] Running create-virtualenv step. 07:35:12 INFO - Running pre-action listener: _resource_record_pre_action 07:35:12 INFO - Running main action method: create_virtualenv 07:35:12 INFO - Creating virtualenv /builds/slave/test/build/venv 07:35:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:35:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:35:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:35:12 INFO - Using real prefix '/tools/python27' 07:35:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:35:13 INFO - Installing distribute.............................................................................................................................................................................................done. 07:35:16 INFO - Installing pip.................done. 07:35:16 INFO - Return code: 0 07:35:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:35:16 INFO - Reading from file tmpfile_stdout 07:35:16 INFO - Output received: 07:35:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:35:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff32a59d1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e617d30>, '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 0x10e47ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e60fb20>, '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.9ADDzah3LA/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.3vM1IRqVmS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 07:35:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:35:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ADDzah3LA/Render', 07:35:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:16 INFO - 'HOME': '/Users/cltbld', 07:35:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:16 INFO - 'LOGNAME': 'cltbld', 07:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:16 INFO - 'MOZ_NO_REMOTE': '1', 07:35:16 INFO - 'NO_EM_RESTART': '1', 07:35:16 INFO - 'PAGER': '/bin/cat', 07:35:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:16 INFO - 'PWD': '/builds/slave/test', 07:35:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:16 INFO - 'SHELL': '/bin/bash', 07:35:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vM1IRqVmS/Listeners', 07:35:16 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 07:35:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:16 INFO - 'USER': 'cltbld', 07:35:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:16 INFO - 'XPC_FLAGS': '0x0', 07:35:16 INFO - 'XPC_SERVICE_NAME': '0', 07:35:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:17 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 07:35:17 INFO - Cleaning up... 07:35:17 INFO - Return code: 0 07:35:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:35:17 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')]} 07:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:17 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')]} 07:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:17 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 0x10e803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff32a59d1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e617d30>, '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 0x10e47ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e60fb20>, '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.9ADDzah3LA/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.3vM1IRqVmS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 07:35:17 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 07:35:17 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 07:35:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ADDzah3LA/Render', 07:35:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:17 INFO - 'HOME': '/Users/cltbld', 07:35:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:17 INFO - 'LOGNAME': 'cltbld', 07:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:17 INFO - 'MOZ_NO_REMOTE': '1', 07:35:17 INFO - 'NO_EM_RESTART': '1', 07:35:17 INFO - 'PAGER': '/bin/cat', 07:35:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:17 INFO - 'PWD': '/builds/slave/test', 07:35:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:17 INFO - 'SHELL': '/bin/bash', 07:35:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vM1IRqVmS/Listeners', 07:35:17 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 07:35:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:17 INFO - 'USER': 'cltbld', 07:35:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:17 INFO - 'XPC_FLAGS': '0x0', 07:35:17 INFO - 'XPC_SERVICE_NAME': '0', 07:35:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:17 INFO - Downloading/unpacking psutil>=3.1.1 07:35:17 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 07:35:17 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 07:35:17 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 07:35:17 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 07:35:17 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 07:35:17 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 07:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:35:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:20 INFO - Installing collected packages: psutil 07:35:20 INFO - Running setup.py install for psutil 07:35:20 INFO - building 'psutil._psutil_osx' extension 07:35:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:35:21 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 07:35:21 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 07:35:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:35:21 INFO - building 'psutil._psutil_posix' extension 07:35:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:35:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:35:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:35:21 INFO - ^ 07:35:21 INFO - 1 warning generated. 07:35:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:35:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:21 INFO - Successfully installed psutil 07:35:21 INFO - Cleaning up... 07:35:22 INFO - Return code: 0 07:35:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:35:22 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')]} 07:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:22 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')]} 07:35:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:22 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 0x10e803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff32a59d1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e617d30>, '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 0x10e47ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e60fb20>, '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.9ADDzah3LA/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.3vM1IRqVmS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 07:35:22 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 07:35:22 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 07:35:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ADDzah3LA/Render', 07:35:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:22 INFO - 'HOME': '/Users/cltbld', 07:35:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:22 INFO - 'LOGNAME': 'cltbld', 07:35:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:22 INFO - 'MOZ_NO_REMOTE': '1', 07:35:22 INFO - 'NO_EM_RESTART': '1', 07:35:22 INFO - 'PAGER': '/bin/cat', 07:35:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:22 INFO - 'PWD': '/builds/slave/test', 07:35:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:22 INFO - 'SHELL': '/bin/bash', 07:35:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vM1IRqVmS/Listeners', 07:35:22 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 07:35:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:22 INFO - 'USER': 'cltbld', 07:35:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:22 INFO - 'XPC_FLAGS': '0x0', 07:35:22 INFO - 'XPC_SERVICE_NAME': '0', 07:35:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:35:22 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 07:35:22 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 07:35:22 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 07:35:22 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 07:35:22 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 07:35:22 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 07:35:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:35:24 INFO - Installing collected packages: mozsystemmonitor 07:35:24 INFO - Running setup.py install for mozsystemmonitor 07:35:25 INFO - Successfully installed mozsystemmonitor 07:35:25 INFO - Cleaning up... 07:35:25 INFO - Return code: 0 07:35:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:25 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 0x10e803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff32a59d1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e617d30>, '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 0x10e47ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e60fb20>, '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.9ADDzah3LA/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.3vM1IRqVmS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 07:35:25 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 07:35:25 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 07:35:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ADDzah3LA/Render', 07:35:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:25 INFO - 'HOME': '/Users/cltbld', 07:35:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:25 INFO - 'LOGNAME': 'cltbld', 07:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:25 INFO - 'MOZ_NO_REMOTE': '1', 07:35:25 INFO - 'NO_EM_RESTART': '1', 07:35:25 INFO - 'PAGER': '/bin/cat', 07:35:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:25 INFO - 'PWD': '/builds/slave/test', 07:35:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:25 INFO - 'SHELL': '/bin/bash', 07:35:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vM1IRqVmS/Listeners', 07:35:25 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 07:35:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:25 INFO - 'USER': 'cltbld', 07:35:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:25 INFO - 'XPC_FLAGS': '0x0', 07:35:25 INFO - 'XPC_SERVICE_NAME': '0', 07:35:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:25 INFO - Downloading/unpacking jsonschema==2.5.1 07:35:25 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 07:35:25 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 07:35:25 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 07:35:25 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 07:35:25 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 07:35:25 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 07:35:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:35:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:28 INFO - Downloading functools32-3.2.3-2.tar.gz 07:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:35:28 INFO - warning: no files found matching '*.txt' 07:35:28 INFO - no previously-included directories found matching 'build' 07:35:28 INFO - no previously-included directories found matching 'dist' 07:35:28 INFO - no previously-included directories found matching '.git*' 07:35:28 INFO - Installing collected packages: jsonschema, functools32 07:35:28 INFO - Running setup.py install for functools32 07:35:28 INFO - warning: no files found matching '*.txt' 07:35:28 INFO - no previously-included directories found matching 'build' 07:35:28 INFO - no previously-included directories found matching 'dist' 07:35:28 INFO - no previously-included directories found matching '.git*' 07:35:28 INFO - Successfully installed jsonschema functools32 07:35:28 INFO - Cleaning up... 07:35:28 INFO - Return code: 0 07:35:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff32a59d1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e617d30>, '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 0x10e47ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e60fb20>, '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.9ADDzah3LA/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.3vM1IRqVmS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 07:35:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:35:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:35:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ADDzah3LA/Render', 07:35:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:28 INFO - 'HOME': '/Users/cltbld', 07:35:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:28 INFO - 'LOGNAME': 'cltbld', 07:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:28 INFO - 'MOZ_NO_REMOTE': '1', 07:35:28 INFO - 'NO_EM_RESTART': '1', 07:35:28 INFO - 'PAGER': '/bin/cat', 07:35:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:28 INFO - 'PWD': '/builds/slave/test', 07:35:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:28 INFO - 'SHELL': '/bin/bash', 07:35:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vM1IRqVmS/Listeners', 07:35:28 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 07:35:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:28 INFO - 'USER': 'cltbld', 07:35:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:28 INFO - 'XPC_FLAGS': '0x0', 07:35:28 INFO - 'XPC_SERVICE_NAME': '0', 07:35:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:35:28 INFO - Cleaning up... 07:35:28 INFO - Return code: 0 07:35:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff32a59d1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e617d30>, '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 0x10e47ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e60fb20>, '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.9ADDzah3LA/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.3vM1IRqVmS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 07:35:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:35:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:35:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ADDzah3LA/Render', 07:35:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:28 INFO - 'HOME': '/Users/cltbld', 07:35:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:28 INFO - 'LOGNAME': 'cltbld', 07:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:28 INFO - 'MOZ_NO_REMOTE': '1', 07:35:28 INFO - 'NO_EM_RESTART': '1', 07:35:28 INFO - 'PAGER': '/bin/cat', 07:35:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:28 INFO - 'PWD': '/builds/slave/test', 07:35:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:28 INFO - 'SHELL': '/bin/bash', 07:35:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vM1IRqVmS/Listeners', 07:35:28 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 07:35:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:28 INFO - 'USER': 'cltbld', 07:35:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:28 INFO - 'XPC_FLAGS': '0x0', 07:35:28 INFO - 'XPC_SERVICE_NAME': '0', 07:35:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:29 INFO - Downloading/unpacking blobuploader==1.2.4 07:35:29 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 07:35:29 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 07:35:29 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 07:35:29 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 07:35:29 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 07:35:29 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 07:35:31 INFO - Downloading blobuploader-1.2.4.tar.gz 07:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:35:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:35:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35: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 07:35:32 INFO - Downloading docopt-0.6.1.tar.gz 07:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:35:32 INFO - Installing collected packages: blobuploader, requests, docopt 07:35:32 INFO - Running setup.py install for blobuploader 07:35:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:35:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:35:33 INFO - Running setup.py install for requests 07:35:33 INFO - Running setup.py install for docopt 07:35:33 INFO - Successfully installed blobuploader requests docopt 07:35:33 INFO - Cleaning up... 07:35:33 INFO - Return code: 0 07:35:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff32a59d1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e617d30>, '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 0x10e47ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e60fb20>, '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.9ADDzah3LA/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.3vM1IRqVmS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 07:35:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:35:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ADDzah3LA/Render', 07:35:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:33 INFO - 'HOME': '/Users/cltbld', 07:35:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:33 INFO - 'LOGNAME': 'cltbld', 07:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:33 INFO - 'MOZ_NO_REMOTE': '1', 07:35:33 INFO - 'NO_EM_RESTART': '1', 07:35:33 INFO - 'PAGER': '/bin/cat', 07:35:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:33 INFO - 'PWD': '/builds/slave/test', 07:35:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:33 INFO - 'SHELL': '/bin/bash', 07:35:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vM1IRqVmS/Listeners', 07:35:33 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 07:35:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:33 INFO - 'USER': 'cltbld', 07:35:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:33 INFO - 'XPC_FLAGS': '0x0', 07:35:33 INFO - 'XPC_SERVICE_NAME': '0', 07:35:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:34 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-sjI164-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:34 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-MEwKn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:34 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-3MmKKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:34 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-kYgIdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:34 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-vzos6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:34 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-SRx5fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:34 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-4GyI8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:34 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-aVWdn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:34 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-CUSqkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:35 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-wfoeA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:35 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-VD0TfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:35 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-A83yJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:35 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-YhSLr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:35 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-QCUBQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:35 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-Ugim3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:35 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-ChfKfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:35 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-IMb757-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:35:35 INFO - Running setup.py install for manifestparser 07:35:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:35:36 INFO - Running setup.py install for mozcrash 07:35:36 INFO - Running setup.py install for mozdebug 07:35:36 INFO - Running setup.py install for mozdevice 07:35:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:35:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:35:36 INFO - Running setup.py install for mozfile 07:35:36 INFO - Running setup.py install for mozhttpd 07:35:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:35:36 INFO - Running setup.py install for mozinfo 07:35:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:35:36 INFO - Running setup.py install for mozInstall 07:35:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:35:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:35:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:35:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:35:37 INFO - Running setup.py install for mozleak 07:35:37 INFO - Running setup.py install for mozlog 07:35:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:35:37 INFO - Running setup.py install for moznetwork 07:35:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:35:37 INFO - Running setup.py install for mozprocess 07:35:37 INFO - Running setup.py install for mozprofile 07:35:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:35:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:35:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:35:37 INFO - Running setup.py install for mozrunner 07:35:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:35:38 INFO - Running setup.py install for mozscreenshot 07:35:38 INFO - Running setup.py install for moztest 07:35:38 INFO - Running setup.py install for mozversion 07:35:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:35:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:35:38 INFO - Cleaning up... 07:35:38 INFO - Return code: 0 07:35:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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')]} 07:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff32a59d1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e617d30>, '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 0x10e47ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e60fb20>, '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.9ADDzah3LA/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.3vM1IRqVmS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 07:35:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:35:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ADDzah3LA/Render', 07:35:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:38 INFO - 'HOME': '/Users/cltbld', 07:35:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:38 INFO - 'LOGNAME': 'cltbld', 07:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:38 INFO - 'MOZ_NO_REMOTE': '1', 07:35:38 INFO - 'NO_EM_RESTART': '1', 07:35:38 INFO - 'PAGER': '/bin/cat', 07:35:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:38 INFO - 'PWD': '/builds/slave/test', 07:35:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:38 INFO - 'SHELL': '/bin/bash', 07:35:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vM1IRqVmS/Listeners', 07:35:38 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 07:35:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:38 INFO - 'USER': 'cltbld', 07:35:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:38 INFO - 'XPC_FLAGS': '0x0', 07:35:38 INFO - 'XPC_SERVICE_NAME': '0', 07:35:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:38 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-GQRa2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:38 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)) 07:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:38 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-AHTZaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:39 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-bO3QOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:39 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-xVUDyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:39 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)) 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:39 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-Tx5Bt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:39 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-NpbhV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:39 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-wE6Fhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:39 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-7pWVy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:39 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-LvSvNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:39 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-w_rqvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:39 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)) 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:39 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-hFzJ99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:39 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)) 07:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:39 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-o0fgkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:40 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-2SKfBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:40 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-HOj9uV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:40 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-DX3gr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:40 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-jDkQTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:40 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-uFGh8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:35:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:35:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:43 INFO - Downloading blessings-1.6.tar.gz 07:35:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:35:43 INFO - Installing collected packages: blessings 07:35:43 INFO - Running setup.py install for blessings 07:35:43 INFO - Successfully installed blessings 07:35:43 INFO - Cleaning up... 07:35:43 INFO - Return code: 0 07:35:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:35:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:43 INFO - Reading from file tmpfile_stdout 07:35:43 INFO - Current package versions: 07:35:43 INFO - blessings == 1.6 07:35:43 INFO - blobuploader == 1.2.4 07:35:43 INFO - docopt == 0.6.1 07:35:43 INFO - functools32 == 3.2.3-2 07:35:43 INFO - jsonschema == 2.5.1 07:35:43 INFO - manifestparser == 1.1 07:35:43 INFO - mozInstall == 1.12 07:35:43 INFO - mozcrash == 1.0 07:35:43 INFO - mozdebug == 0.1 07:35:43 INFO - mozdevice == 0.48 07:35:43 INFO - mozfile == 1.2 07:35:43 INFO - mozhttpd == 0.7 07:35:43 INFO - mozinfo == 0.9 07:35:43 INFO - mozleak == 0.1 07:35:43 INFO - mozlog == 3.4 07:35:43 INFO - moznetwork == 0.27 07:35:43 INFO - mozprocess == 0.23 07:35:43 INFO - mozprofile == 0.28 07:35:43 INFO - mozrunner == 6.13 07:35:43 INFO - mozscreenshot == 0.1 07:35:43 INFO - mozsystemmonitor == 0.3 07:35:43 INFO - moztest == 0.7 07:35:43 INFO - mozversion == 1.4 07:35:43 INFO - psutil == 3.1.1 07:35:43 INFO - requests == 1.2.3 07:35:43 INFO - wsgiref == 0.1.2 07:35:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35: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')]} 07:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff32a59d1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e617d30>, '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 0x10e47ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e60fb20>, '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.9ADDzah3LA/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.3vM1IRqVmS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 07:35:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:35:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:35:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ADDzah3LA/Render', 07:35:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:44 INFO - 'HOME': '/Users/cltbld', 07:35:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:44 INFO - 'LOGNAME': 'cltbld', 07:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:44 INFO - 'MOZ_NO_REMOTE': '1', 07:35:44 INFO - 'NO_EM_RESTART': '1', 07:35:44 INFO - 'PAGER': '/bin/cat', 07:35:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:44 INFO - 'PWD': '/builds/slave/test', 07:35:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:44 INFO - 'SHELL': '/bin/bash', 07:35:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vM1IRqVmS/Listeners', 07:35:44 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 07:35:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:44 INFO - 'USER': 'cltbld', 07:35:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:44 INFO - 'XPC_FLAGS': '0x0', 07:35:44 INFO - 'XPC_SERVICE_NAME': '0', 07:35:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:35:44 INFO - Cleaning up... 07:35:44 INFO - Return code: 0 07:35:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e803490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e779570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff32a59d1a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e617d30>, '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 0x10e47ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e60fb20>, '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.9ADDzah3LA/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.3vM1IRqVmS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 07:35:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:35:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ADDzah3LA/Render', 07:35:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:45 INFO - 'HOME': '/Users/cltbld', 07:35:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:45 INFO - 'LOGNAME': 'cltbld', 07:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:45 INFO - 'MOZ_NO_REMOTE': '1', 07:35:45 INFO - 'NO_EM_RESTART': '1', 07:35:45 INFO - 'PAGER': '/bin/cat', 07:35:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:45 INFO - 'PWD': '/builds/slave/test', 07:35:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:45 INFO - 'SHELL': '/bin/bash', 07:35:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vM1IRqVmS/Listeners', 07:35:45 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 07:35:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:45 INFO - 'USER': 'cltbld', 07:35:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:45 INFO - 'XPC_FLAGS': '0x0', 07:35:45 INFO - 'XPC_SERVICE_NAME': '0', 07:35:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:35:45 INFO - Cleaning up... 07:35:45 INFO - Return code: 0 07:35:45 INFO - Running post-action listener: _resource_record_post_action 07:35:45 INFO - Running post-action listener: _start_resource_monitoring 07:35:45 INFO - Starting resource monitoring. 07:35:45 INFO - [mozharness: 2016-11-15 15:35:45.610663Z] Finished create-virtualenv step (success) 07:35:45 INFO - [mozharness: 2016-11-15 15:35:45.611613Z] Running install step. 07:35:45 INFO - Running pre-action listener: _resource_record_pre_action 07:35:45 INFO - Running main action method: install 07:35:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:45 INFO - Reading from file tmpfile_stdout 07:35:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:35:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:35:45 INFO - Reading from file tmpfile_stdout 07:35:45 INFO - Output received: 07:35:45 INFO - Usage: mozinstall [options] installer 07:35:45 INFO - Options: 07:35:45 INFO - -h, --help show this help message and exit 07:35:45 INFO - -d DEST, --destination=DEST 07:35:45 INFO - Directory to install application into. [default: 07:35:45 INFO - "/builds/slave/test"] 07:35:45 INFO - --app=APP Application being installed. [default: firefox] 07:35:45 INFO - mkdir: /builds/slave/test/build/application 07:35:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:36:18 INFO - Reading from file tmpfile_stdout 07:36:18 INFO - Output received: 07:36:18 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:36:18 INFO - Running post-action listener: _resource_record_post_action 07:36:18 INFO - [mozharness: 2016-11-15 15:36:18.067316Z] Finished install step (success) 07:36:18 INFO - [mozharness: 2016-11-15 15:36:18.067451Z] Running run-tests step. 07:36:18 INFO - Running pre-action listener: _resource_record_pre_action 07:36:18 INFO - Running main action method: run_tests 07:36:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:36:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:36:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:36:18 INFO - 2016-11-15 07:36:18.082 screenresolution[1629:7499] starting screenresolution argv=screenresolution get 07:36:18 INFO - 2016-11-15 07:36:18.084 screenresolution[1629:7499] Display 0: 1600x1200x32@50 07:36:18 INFO - 2016-11-15 07:36:18.090 screenresolution[1630:7501] starting screenresolution argv=screenresolution list 07:36:18 INFO - Available Modes on Display 0 07:36:18 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 07:36:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:36:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:36:18 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 07:36:18 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 07:36:18 INFO - Graphics/Displays: 07:36:18 INFO - Intel Iris: 07:36:18 INFO - Chipset Model: Intel Iris 07:36:18 INFO - Type: GPU 07:36:18 INFO - Bus: Built-In 07:36:18 INFO - VRAM (Dynamic, Max): 1536 MB 07:36:18 INFO - Vendor: Intel (0x8086) 07:36:18 INFO - Device ID: 0x0a2e 07:36:18 INFO - Revision ID: 0x0009 07:36:18 INFO - Displays: 07:36:18 INFO - Display: 07:36:18 INFO - Resolution: 1600 x 1200 @ 50 Hz 07:36:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:36:18 INFO - Display Serial Number: 1600x1200 50 07:36:18 INFO - Main Display: Yes 07:36:18 INFO - Mirror: Off 07:36:18 INFO - Online: Yes 07:36:18 INFO - Rotation: Supported 07:36:18 INFO - Return code: 0 07:36:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:36:18 INFO - Python 2.7.3 07:36:18 INFO - Return code: 0 07:36:18 INFO - grabbing minidump binary from tooltool 07:36: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')]} 07:36:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e617d30>, '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 0x10e47ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e60fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:36:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:36:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:36:18 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:36:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:36:18 INFO - Return code: 0 07:36:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:36:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:36:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:36:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:36:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:36:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0011', '--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 07:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0011 --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 07:36:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ADDzah3LA/Render', 07:36:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:18 INFO - 'HOME': '/Users/cltbld', 07:36:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:18 INFO - 'LOGNAME': 'cltbld', 07:36:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:36:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:18 INFO - 'MOZ_NO_REMOTE': '1', 07:36:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:36:18 INFO - 'NO_EM_RESTART': '1', 07:36:18 INFO - 'PAGER': '/bin/cat', 07:36:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:18 INFO - 'PWD': '/builds/slave/test', 07:36:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:36:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:18 INFO - 'SHELL': '/bin/bash', 07:36:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3vM1IRqVmS/Listeners', 07:36:18 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 07:36:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:18 INFO - 'USER': 'cltbld', 07:36:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:18 INFO - 'XPC_FLAGS': '0x0', 07:36:18 INFO - 'XPC_SERVICE_NAME': '0', 07:36:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0011', '--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 07:36:18 INFO - mozversion application_buildid: 20161115060313 07:36:18 INFO - mozversion application_changeset: bfaa16ab61ee71dd05d27e2b07244032207b5dad 07:36:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:36:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:36:18 INFO - mozversion application_name: Firefox 07:36:18 INFO - mozversion application_remotingname: firefox-dev 07:36:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:36:18 INFO - mozversion application_vendor: Mozilla 07:36:18 INFO - mozversion application_version: 52.0a2 07:36:18 INFO - mozversion platform_buildid: 20161115060313 07:36:18 INFO - mozversion platform_changeset: bfaa16ab61ee71dd05d27e2b07244032207b5dad 07:36:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:36:18 INFO - mozversion platform_version: 52.0a2 07:36:18 INFO - using testdate: 1479224178 07:36:18 INFO - actual date: 1479224178 07:36:18 INFO - starting webserver on 'localhost:49244' 07:36:18 INFO - SUITE-START | Running 2 tests 07:36:18 INFO - TEST-START | dromaeo_css 07:36:18 INFO - operating with platform_type : mac_ 07:36:18 INFO - Initialising browser for dromaeo_css test... 07:36:18 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmpuF4PCm/profile http://localhost:49244/getInfo.html) 07:36:20 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 07:36:21 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 07:36:21 INFO - PROCESS | 1640 | colorDepth:24 07:36:21 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 07:36:21 INFO - PROCESS | 1640 | __metrics 07:36:21 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 07:36:22 INFO - TEST-INFO | 1640: exit 0 07:36:22 INFO - Browser initialized. 07:36:22 INFO - Running cycle 1/1 for dromaeo_css test... 07:36:22 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmpuF4PCm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:36:34 INFO - PROCESS | 1643 | RSS: Main: 224432128 07:36:34 INFO - PROCESS | 1643 | 07:37:23 INFO - PROCESS | 1643 | 1479224243908 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] 07:39:37 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 07:39:39 INFO - PROCESS | 1643 | RSS: Main: 235331584 07:39:39 INFO - PROCESS | 1643 | 07:42:41 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 07:42:42 INFO - PROCESS | 1643 | RSS: Main: 248381440 07:42:42 INFO - PROCESS | 1643 | 07:45:44 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 07:45:45 INFO - PROCESS | 1643 | RSS: Main: 251273216 07:45:45 INFO - PROCESS | 1643 | 07:48:47 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 07:48:47 INFO - PROCESS | 1643 | RSS: Main: 251080704 07:48:47 INFO - PROCESS | 1643 | 07:51:50 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 07:51:51 INFO - PROCESS | 1643 | RSS: Main: 254545920 07:51:51 INFO - PROCESS | 1643 | 07:54:53 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 07:54:53 INFO - PROCESS | 1643 | RSS: Main: 255803392 07:54:53 INFO - PROCESS | 1643 | 07:54:53 INFO - PROCESS | 1643 | __start_tp_report 07:54:53 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 07:54:53 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 07:54:53 INFO - PROCESS | 1643 | |i|pagename|runs| 07:54:53 INFO - PROCESS | 1643 | |0;dojo.html;3377.1557110722306;3396.796192228465;3397.7791443556166;3404.063882432331;3408.7273018158544;4153.958460415402;4578.9771051144735;5053.848384548465;5329.786808527664;5787.450192231742;5932.436418540243;5948.910766338508;5989.730462129204;6006.549508786848;6025.216721826157;4490.618297444721;5285.788568457277;5321.88669628268;5376.865578360533;5401.459854014606;5389.137737961927;5392.865178370533;5432.022235997519;5437.809676661318;5437.945620543804;4415.889602759925;5349.7057661828585;5358;5432.076546987002;5465.07093794056;5346.518813306821;5353.544948679387;5359.9732001340135;5374.817540141163;5387.24578559002;5192.766325515323;5253.185756207794;5278.498542638443;5304.867378315535;5402.216678581583;5060.5951523878;5938.168656388109;5990.730417131196;5995.760169593211;6010.939890601082;5818.476337129637;6194.783182588588;6243.344448832852;6265.310815810257;6265.686715664198;6189.907151392733;6296.496280297565;6318.715657795365;6319.178506794087;6338.429541341256;6029.065494848305;6037.335893051761;6046.697665116727;6051.757929682807;6076.118962750376;6207.131001659771;6263.96868015657;6335.144755458046;6387.233531976192;6404.263509696351;6223.719932603044;6271.905921411182;6280.057991301342;6289.96855015722;6301.873962520815;6288.182536270256;6308.116863639094;6309.14826498426;6317.810465686037;6319.96840015797;6166.445019948226;6178;6251.937480625135;6312.52656050798;6333.461655759312;5629.761452480448;5652.689102099342;6241.937580624136;6266;6298.149749783721;4765.7140571565815;4987.850364488999;4991.800327986913;4999.375078115236;5015.924761128586;4170.687198460128;4406.515283318832;4456.844010459618;4505.234110201273;4630.166570017429;5886.381929897385;5936.821895343147;5968.46283834457;5977.402259774075;6013.278406591237;6171.7531298748445;6183.165272688129;6229.3770622937345;6257.124002639634;6264.248290205113;6006.279246490449;6009.9617584148555;6013.128096426081;6078.088286757022;6086.995645718495;5526.143447765603;5559.33288005442;5580.162975553618;5582.302212223472;5608.411116832755;6307.810765677037;6521.5108866834225;6525.282218955911;6547.017947307847;6549.803505894831;6182.443580077815;6189.81430557084;6231.2522497300615;6280.309165991828;6372.617642941438;5473.343198816167;6418.743250269937;6441;6462.063000864942;6501.349865013461;6284.654344011124;6298.779542715983;6301.779437719658;6303.747850085945;6317.936820631919;4835.637327200404;6177.722002509808;6184.938150618436;6245.28179259391;6248.718807653576;6251.156093927261;6262.718177682106;6281.52888533371;6284.591501552384;6312.842178945563;6168.303716478004;6241.500679945684;6245.750169993149;6301.842453938688;6310.842228944313;5183.948160518346;5965.6718880461995;5987.251593550806;6019.849503762441;6058.182145410313;6153.815385538441;6187.690615469119;6198.876022479615;6278.654673992792;6324.241091068917;4967.677100988424;5530.281063461724;5785.784985153165;6205.503559715122;6216.658083805434 07:54:53 INFO - PROCESS | 1643 | |1;ext.html;451.7379919646605;490.2988726121646;506.9493050694931;532.5420138680736;557.1420013179703;29507.40985180298;31163.84418077909;31234.375312493765;38976;40273.7986310068;40015;40136.19727605446;40714;40786.38820417696;40790.18419631613;9173.908260917373;9331.72004839856;9343.2525397968;9376.437413755197;9490;9262.907370926305;9360.970293267736;9361;9372.437653740762;9403.106704863027;9358.672446464376;9383.624655013791;9392.107749763796;9392.906070939305;9402.7687540607;8352.582370881431;9270.72187834366;9332.906670933271;9335.019822918564;9360.391574547666;9242.399244049115;9302.302327325478;9317.440953542742;9327.253819694408;9356.157945784911;39344.819655410385;39581.80209098936;39636.80181599074;39648.20703585912;39725.40411893824;2873.951007882108;3375.4093033719246;3474.409350410411;3685.0971511979737;3867.0139114525614;28471.572926405912;29318.560221596694;29642.25894352637;30291;30429.695703042908;3092.608665289959;3155.3058327167987;3207.470767323389;3217.1635374802718;3245.6429792722784;502859.37132829113;505274;507842.99999999633;509642;509683;60175.39824601785;60283.49291267753;60521.78956420935;60544.69727651333;60631.393686062576;59679.70160149258;59687.70156149278;59968.70015649894;60068.39931600628;60181.09728354078;12430.813537796941;13852.16886986784;16223.594410139842;16282.185890705417;16306.75539866903;12387.380630968595;12469.875301247053;12476.313802740755;12486.375681215903;12502.687432814071;12882.80675789864;17351.566210844576;17487.912560437115;17622.118894055504;17666.470005899588;2933.735963763229;3225.8870939517005;5349.518543331119;5420.861619059962;6062.939370606237;876.9166929141721;951.5622813505864;990.2474119668959;1006.2591716330788;1026.9435181064964;29481.115566533037;30278.54582181269;30364;30420.93526726598;30613.540796888065;858.9226969572768;985.6008316631776;1032.4115254304975;1041.958041958042;1054.2146101154535;14860.182689952157;15636.4527241546;15890.60273493172;16079.517614471584;16253.918730406509;695507;695806;699693;700797;703860;57411.564710882565;57861.71069144627;58068.41931580714;58191.836163277345;58261;1220.8718084601167;1322.7222283320611;1326.2506683723666;1359.0690377091723;1365.112676760094;28890.566641500816;29570.260743481584;29969.850150749106;29987.550186747652;30476.69523304827;51351.743241283555;52119;52172.47827521828;52283.73858130685;52337;638056;642932;643239;643285;644903;22665.773342267024;26500.602490963036;26512.072077477194;26784.062557810383;26825.731742682325;45500.772496138634;45529.54470455253;46391.768041160925;46549.53450465587;46820.82947926193;37121.628783711814;38393.80803095967;39066.414003789396;39555.80222098871;41560;33837.15407114743;37817.48730050767;38416.6158338413;39295.80352098221;39589.40615890821;35994;37957.05107372338;38721.80639096787;38847.41728874126;38853.805730971166;32851.34297314088;34045.48931766075;34243.4863477053;34579;34869.825650871586;25805.483890322463;25860;25990.48019039571;26104.477910442063;26413 07:54:53 INFO - PROCESS | 1643 | |2;jquery.html;353.3445458674158;372.5566575774828;375.19520628252417;385.86880460643386;403.2660557784831;14987.47543835966;18517.907410462947;19261.903690481562;19726.309579164714;19951.60096798063;11283.37941413222;11705.824412633818;11708.946194842463;11739.00218481428;11741.354225517593;4820.903581928359;5667.178259152421;5954.612950158225;6023.638581685091;6083.817485475421;3832.099456627704;4029.81865816039;5749.942500574983;6012.218411606507;6054.091886217081;6011.158437818709;6085.574009819315;6089.756409743627;6091.238595175603;6099.085137229429;5823.970880145594;6021.819345419644;6069.332373438918;6080.361562035967;6084.939150608481;5633.40849210831;5895.675737834417;5905.055191169436;5911.674857882815;5939.316978547436;12726.300053497054;12809.743805123939;22333;23560.764392356028;24348.634770478457;2025.3316405586122;2259.618243444125;2282.1213832674375;2379.6073647848084;2553.9361515962064;7643.847123057563;9728.027197280215;10138.442385668784;10242.7439314017;14548.097120046208;1619.6922584708868;1744.7819022622173;1840.815918408162;1871.6069625378686;1918.6834172361544;127284.60050646994;127698.36150819187;133184.33407832898;134912.32543837218;135667.999999999;11626.709332266591;11642.01042911362;11738.647840564796;11738.94130529342;11894.405279735978;14275.286235688174;14619.26903654813;14634.268286585628;14640.414383424757;14644.853551464563;8431.789205269917;8482.279006284412;8505.617247223767;8655.264302534355;8683.088275731083;7465.432259225515;7964.1637628049375;8314.792130196673;8446.915530844613;8565.229129378262;4399.296112621965;4521.480029796549;4533.569310915458;4587.944772702297;4629.189891768927;1190.9341139679939;1575.6218507558103;1881.3227238194238;1903.5526651236949;1996.8901710405776;699.2133849419403;894.7271082319825;934.3646320501988;967.9642782222954;1031.28841099641;18632.72050919237;21007.579848402947;21081.472963176042;21112.155513779584;21117.8385188813;904.4437670832391;925.121134921827;976.4580657734883;979.294907666479;1005.9497025148713;8076.636551355203;9864.556094975744;10369.066783989327;10561.735956601147;11097.946879827257;565886;566702;572156;628814;634643;127473;132907.33546332206;133758.33120834528;135153.3242333782;139349;928.6331898899897;959.3620242538634;964;969.1181025266973;969.4667932637162;18276.908615456836;18506.44480665582;18579.349722759638;18839.434816955512;19114.617707646048;52380.16669416552;53080.46919530755;53482.73258633682;53569;54044.72977635087;71687.64156179185;77646.61176694307;78277.60861195657;79523.60238198772;80555;6976.4767642426;7326.157491888501;7651.961740191264;8088.474249173785;8285.757136429584;11545;12728.68178295513;12856;12899.548515801902;12974.286414247306;10926.235163538477;10980.286281391684;11019.669409917715;11428.542858285575;11484.483198256266;10881.455927203766;11013.2841365311;11084.44577771092;11098.334099954029;11203.71990700239;11154.442277885912;11273.830892536454;11317.377544235145;11389.031932285849;11564.190506664452;5814.970925145516;7294.635268236673;7384;7532.548047116971;7628.160902300631;8476.576171191538;11076.280041797258;11156.163287753614;11255.04332131778;11277.71805704864 07:54:53 INFO - PROCESS | 1643 | |3;mootools.html;1361.1016728958887;1445.2556933179412;1608.0833924662938;1720.1915099903042;1780.2878848460614;7554.81112972176;7840.13758486566;8099.797505062369;8576.142385761428;8600.096989816066;6574.901376479344;7875.173106823787;8334.666613335474;8357.16428357164;8454.154584541542;2313.7223533176;2328.790408863202;2330.533893221354;2332.8600283982933;2344.003798385679;2316.2587971849016;2350.8354415190943;2375.524895020994;2375.8930848111877;2390.713114426271;1941.4563922101834;2332.4751930815514;2345.636426353918;2348.365941195876;2352.023910077316;2285.897134628946;2287.2795069553204;2301.80434663053;2312.791848733605;2323.8257130715265;2327.7090363704538;2350;2353.8940747666397;2356.2106694257445;2359.0681680736184;8349.373796965252;8513.659453621847;8543.914560854375;8548.059713431518;8549.444286121383;5050.444451110375;5221.269022336875;5222.138347172712;5222.947770522284;5231.084560201987;2919.941601167986;3189.6969787870116;3292.621348544924;3520.68313851752;3525.982370088159;1024.1141412678055;1045.0124632222553;1052.9684109476727;1068.8503609494676;1090.2913106480771;11028.724281893017;11067.059299959514;11083.778324433466;11154.996050355427;11165.665030049031;3897.7466464679705;4522.25382811839;4582.88542786433;4686.95313046872;4796.856094317176;8151.510909345339;9208.815823683488;9551.331406801597;9562.043795620382;9587.424754514752;4920;5237.450067742909;5239;5252.474752524717;5267.71027593486;3482.8606855725993;4435.334699795057;4482.843100491467;4629.560191781776;4804.039192161582;3199.976007677521;3587.210813620999;3836.5971572984995;3910.354791459434;3926.784026878549;1264.72808346206;1280.5006047641427;1283.8459384873688;1292.3021568352983;1295.0934345957867;874.3748220022715;885.5230399976168;885.8538341173634;886.6497733395273;904.755715956688;5481.972590137024;5551.306086739158;5643.266375371258;5675.432456754292;5748.649067469141;379.30587025742824;439.91861505621563;449.8717865408343;455.153414648753;455.70606958511576;3730.123420996064;3736.23407201523;3757.0795155186606;3764.2095160016156;3883.4369016493015;9859.112679858847;10323.793524129474;10337.22470814692;10339.948300258451;10340.638077667396;9979.550920208609;9993.300468967103;10270.0756931875;10342.586296548205;10382.948085259526;7813.68745250195;7897.960510197528;7993.840123197503;8007.279344858991;8012.4791888528225;5368.302120724281;5375.973120134374;5448.509634132947;5546.084895992116;5579;9433.433993960385;9564.426134431957;9601.519924003911;9637.036296370306;9655.710328690151;9362.859557106513;9555.474448905377;9557.713268601952;9745.951270243604;9751.756206094904;7157.355837974607;7190.245024272376;7212.89180662301;7256.455765817479;7306;7849.372050236082;7965.322947549292;7972.6412311444965;7975.84048319042;7994.080680721559;6967.198772141066;7032.331928466788;7105.076340075757;7224;7292.890606640798;6995.580265184105;7126.216116227314;7128.358447739728;7152.678129484081;7249.855002900018;5474.452554744653;6789.15135608049;6800.6599670017295;6810.82972925661;6817.5568588041615;4784.473707892199;4848.8302909398;4874.829380971791;4882.60939124862;4966.304717339648;4893.828715994923;4902.828401005948;4965.329680493087;5005.77474013663;5060.2156665716875 07:54:53 INFO - PROCESS | 1643 | |4;prototype.html;298.5968941928396;298.7505432963474;301.9381026889485;305.5630448458705;309.3905007135941;5423.511883930445;5501.394846566875;5539.9169012464845;5665.130506932713;5737.2541569596;4732.503087175849;5245.849201827252;5507.063799154143;5516.931150818443;5566.630195296693;3332.7333813295;4167.874963751077;4172.395002724603;4219.9028252654225;4237.23729728648;3122.3911337289237;3141.968580314202;3363.596368435791;3701.648343407372;4359.411479450266;3920.5883382244883;3927.9803600981954;3948.1116748731592;4125.958740412602;4135.028268356934;4082.9387559186634;4087.3460246360587;4112.712110152275;4144.6062624050965;4173.207090652766;2843.843588602626;2951.2916899944075;3111.968880311213;3311.8012919224925;3460.723142148622;4398.208322501949;4743.837759748849;4794.592459640935;4894.926576101361;5397.676139431646;4135.545090040093;4341.978290108529;4381.4961279452955;4737.715737055753;4753.691010084333;5440.238366628636;5774.076147816371;5833.045929613584;5878.794242201502;5879.79420720277;3004.4892368297224;3412.4028295048265;3744.7378683492166;3782.884049205491;3909.100906791454;5278.788848446057;6009.278886533601;6029.035354343284;6077.116094010871;6178.9691051544905;3432.3993301172195;3630.3465376232;3671.963280367162;3875.895369819588;3986.760794352348;3897.9805100974313;3981.655201167415;3993.221321842213;4023.6177563131455;4036.7779772112817;4029.3553031515403;4169.478815148106;4270.444842170498;4494.910101797946;4731.69243999139;4936.963237720119;5843.357230704619;5844.185035889317;5972.372900845436;6006.369331220247;1233.2241572136274;1266.5440441441074;1274.7705413025744;1283.889435638185;1289.6517940156104;847.9364047696447;870.2559311788457;870.3863776037878;872.4590753732726;881.4667126388442;4262.488501379854;4605.930911036337;4708.929366059512;4941.678790878582;5174.715390653475;4969.726665033386;5071.41678706946;5079.564865593853;5160.48395160481;5570.607348162959;4494.573015563582;4984.850454486371;5028.899422011613;5099.796008159707;5167.689938603696;2777.7083406242054;2863.742263196281;2944.748481895186;2946.57274695168;2997.880084796627;5825.504832089235;5829.679367634821;5850.824475265749;5897.52819774417;5907.940920590825;5215.792287743011;5290.323225358416;5437.972810135924;5785.417072525033;5833.250024992485;5283.181106928432;5671.517920976763;5892.793752218738;5918.265387689917;5925.999999999914;5204.635675502678;5280.551153152025;5281.57747380201;5738.167965644875;5744.511716504144;4577;4815.975920120377;5968.83607696495;6035.486983606443;6052.246227966177;5338.4127745947135;5598.272224610938;5711.257536520226;6262.889558022281;6263.906041409474;3397.847096880696;3462.619111897639;3972.245273398045;3992.2215168041953;4017.4978127734034;5529.391766905717;5846.269216347957;6011.969940150446;6081.604695694943;6081.817545473643;5099.898002040012;5316.989771943318;5479;5766.682832444256;6002.658963004519;5239.825472428899;5901.527877769682;5972.34304226526;6045.395460453919;6058.84852878664;4304.6556275498515;5664.546836253172;5800.216970708901;5855.912161317498;5880.030189886264;4757.595604373667;4926.379111353081;5063.924041139459;5851.502622276984;5914.34942156371;5790.768369265183;5847.164125399093;5850.356460789395;5859.765609375577;5867.970660146842 07:54:53 INFO - PROCESS | 1643 | |5;yui.html;616.3312805605917;692.4771797293046;705.206642527157;758.2303961479099;791.1890312429758;12055.517779288817;12954.417051232693;13211.933940330297;13918.373673184706;14299.857001429982;13230.933845330785;13483.730325393486;13496.527621533249;13519.662008449794;13521.459141634348;802.4182467710907;822.7367242482408;825.8018075661828;826.7685048186518;826.8511667899776;646.6637348578736;670.4468813229081;793.3335997761878;824.0029564227292;836.0302049622439;864.9481031138121;865.3336930563462;867.1848462445313;869.0614136732314;872.5026734761188;862.1981557151846;865.1953683074738;865.6840253307529;866.5364030243852;866.9913300867005;631.6241836107508;634.8635043465631;637.4454224824386;637.996810015947;639.7952655150353;13595.456181752717;13893.305334733222;14003.579892603238;14018;14031.78952315716;11025.338479691245;12904.032197585218;13385.464581416732;13390.995675324291;13517.188968661814;8169.754907352789;8604.39769216155;9159.633614655406;11164.832527512093;11710.76578468426;3550.3254381667402;3691.354013047706;3694.963050369489;3699.8705045323554;3703.703703703697;63316;83686.58156709238;85201.57399212965;85640.57179714124;86173.56913215456;8687.782805429788;9664.420134791935;9759.024097590183;10283.177345812317;10570.630027948984;19809.40571782849;19995.900020500096;20160.991950402422;20177.192912283637;20230.089645965967;6285.402886725754;7509.436792240604;7539.0576177977755;7558.9244107558225;7650.540967541965;4160.771157586301;4198.4961804583645;4204.558521355275;4331.198728235287;4358.975640724428;3364.4953257011152;3469.65303469651;3491.127218195451;3497.2655742294405;3503.7722548034294;608.4979891589368;614.1524695919692;614.5882258886556;616.737886398279;628.1959092361784;544.8202093309199;611.782817099932;632.5445679111033;635.833245993607;655.6066360183852;7187.460940429489;9259.259259259377;9272.258219342437;9343.018983006823;9500.097490738368;537.3712756075402;592.5496622566794;597.5339235396398;608.9451949324493;646.3407324528954;4018;4448.888777780581;4596.333531637961;4603.746793926366;4621.2837010263465;100587.49706251569;103802;123509;126971;129178;73783.63108184424;89357;94407;95529.950232846;97439.51280243695;59883.203503894954;72620.63689681518;89143.9999999987;91230;93800.0619993805;8467.49195048299;9551.856722149312;9882.752931176778;9972.950135249277;10006.949965250127;52697.15559955383;56424;57687.1346929788;58208.41791582199;59521.404785951585;54864;56328.71835640795;71986.64006679933;72275;76555.851662224;11359.829602556134;12397.566085186974;12533.185342952678;12533.561325353568;12733.681657958625;14154.150750954976;14351.039745723525;14404.927975360475;14825.481108161594;15277.159756213516;13160;13410.061295709207;13472.461101555828;13476.865231347561;14087.718245635235;13661.112027718167;13678.384472698952;13782.586522404345;13861.861381386057;14303.570892873231;12876.935615321863;12998.220106793622;13282.667933301746;13539.458421663023;14011;11151.330920144817;11511.597094101666;11645.534178632759;11871.703207419883;11876;11156.776864462827;11570.633353508787;11619.524529611475;11737.706557336134;11761.588344407905 07:54:53 INFO - PROCESS | 1643 | __end_tp_report 07:54:53 INFO - PROCESS | 1643 | __start_cc_report 07:54:53 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,373 07:54:53 INFO - PROCESS | 1643 | __end_cc_report 07:54:53 INFO - PROCESS | 1643 | __startTimestamp1479225293965__endTimestamp 07:54:53 INFO - PROCESS | 1643 | 07:54:53 INFO - PROCESS | 1643 | ------- Summary: start ------- 07:54:53 INFO - PROCESS | 1643 | Number of tests: 6 07:54:53 INFO - PROCESS | 1643 | 07:54:53 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5788.83 Median:6046.70 stddev:691.01 (11.4%) stddev-sans-first:666.72 07:54:53 INFO - PROCESS | 1643 | Values: 3377.2 3396.8 3397.8 3404.1 3408.7 4154.0 4579.0 5053.8 5329.8 5787.5 5932.4 5948.9 5989.7 6006.5 6025.2 4490.6 5285.8 5321.9 5376.9 5401.5 5389.1 5392.9 5432.0 5437.8 5437.9 4415.9 5349.7 5358.0 5432.1 5465.1 5346.5 5353.5 5360.0 5374.8 5387.2 5192.8 5253.2 5278.5 5304.9 5402.2 5060.6 5938.2 5990.7 5995.8 6010.9 5818.5 6194.8 6243.3 6265.3 6265.7 6189.9 6296.5 6318.7 6319.2 6338.4 6029.1 6037.3 6046.7 6051.8 6076.1 6207.1 6264.0 6335.1 6387.2 6404.3 6223.7 6271.9 6280.1 6290.0 6301.9 6288.2 6308.1 6309.1 6317.8 6320.0 6166.4 6178.0 6251.9 6312.5 6333.5 5629.8 5652.7 6241.9 6266.0 6298.1 4765.7 4987.9 4991.8 4999.4 5015.9 4170.7 4406.5 4456.8 4505.2 4630.2 5886.4 5936.8 5968.5 5977.4 6013.3 6171.8 6183.2 6229.4 6257.1 6264.2 6006.3 6010.0 6013.1 6078.1 6087.0 5526.1 5559.3 5580.2 5582.3 5608.4 6307.8 6521.5 6525.3 6547.0 6549.8 6182.4 6189.8 6231.3 6280.3 6372.6 5473.3 6418.7 6441.0 6462.1 6501.3 6284.7 6298.8 6301.8 6303.7 6317.9 4835.6 6177.7 6184.9 6245.3 6248.7 6251.2 6262.7 6281.5 6284.6 6312.8 6168.3 6241.5 6245.8 6301.8 6310.8 5183.9 5965.7 5987.3 6019.8 6058.2 6153.8 6187.7 6198.9 6278.7 6324.2 4967.7 5530.3 5785.8 6205.5 6216.7 07:54:53 INFO - PROCESS | 1643 | 07:54:53 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:73653.83 Median:39585.60 stddev:166650.44 (421.0%) stddev-sans-first:167027.30 07:54:53 INFO - PROCESS | 1643 | Values: 451.7 490.3 506.9 532.5 557.1 29507.4 31163.8 31234.4 38976.0 40273.8 40015.0 40136.2 40714.0 40786.4 40790.2 9173.9 9331.7 9343.3 9376.4 9490.0 9262.9 9361.0 9361.0 9372.4 9403.1 9358.7 9383.6 9392.1 9392.9 9402.8 8352.6 9270.7 9332.9 9335.0 9360.4 9242.4 9302.3 9317.4 9327.3 9356.2 39344.8 39581.8 39636.8 39648.2 39725.4 2874.0 3375.4 3474.4 3685.1 3867.0 28471.6 29318.6 29642.3 30291.0 30429.7 3092.6 3155.3 3207.5 3217.2 3245.6 502859.4 505274.0 507843.0 509642.0 509683.0 60175.4 60283.5 60521.8 60544.7 60631.4 59679.7 59687.7 59968.7 60068.4 60181.1 12430.8 13852.2 16223.6 16282.2 16306.8 12387.4 12469.9 12476.3 12486.4 12502.7 12882.8 17351.6 17487.9 17622.1 17666.5 2933.7 3225.9 5349.5 5420.9 6062.9 876.9 951.6 990.2 1006.3 1026.9 29481.1 30278.5 30364.0 30420.9 30613.5 858.9 985.6 1032.4 1042.0 1054.2 14860.2 15636.5 15890.6 16079.5 16253.9 695507.0 695806.0 699693.0 700797.0 703860.0 57411.6 57861.7 58068.4 58191.8 58261.0 1220.9 1322.7 1326.3 1359.1 1365.1 28890.6 29570.3 29969.9 29987.6 30476.7 51351.7 52119.0 52172.5 52283.7 52337.0 638056.0 642932.0 643239.0 643285.0 644903.0 22665.8 26500.6 26512.1 26784.1 26825.7 45500.8 45529.5 46391.8 46549.5 46820.8 37121.6 38393.8 39066.4 39555.8 41560.0 33837.2 37817.5 38416.6 39295.8 39589.4 35994.0 37957.1 38721.8 38847.4 38853.8 32851.3 34045.5 34243.5 34579.0 34869.8 25805.5 25860.0 25990.5 26104.5 26413.0 07:54:53 INFO - PROCESS | 1643 | 07:54:53 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:34886.01 Median:13451.29 stddev:99862.87 (742.4%) stddev-sans-first:100109.35 07:54:53 INFO - PROCESS | 1643 | Values: 353.3 372.6 375.2 385.9 403.3 14987.5 18517.9 19261.9 19726.3 19951.6 11283.4 11705.8 11708.9 11739.0 11741.4 4820.9 5667.2 5954.6 6023.6 6083.8 3832.1 4029.8 5749.9 6012.2 6054.1 6011.2 6085.6 6089.8 6091.2 6099.1 5824.0 6021.8 6069.3 6080.4 6084.9 5633.4 5895.7 5905.1 5911.7 5939.3 12726.3 12809.7 22333.0 23560.8 24348.6 2025.3 2259.6 2282.1 2379.6 2553.9 7643.8 9728.0 10138.4 10242.7 14548.1 1619.7 1744.8 1840.8 1871.6 1918.7 127284.6 127698.4 133184.3 134912.3 135668.0 11626.7 11642.0 11738.6 11738.9 11894.4 14275.3 14619.3 14634.3 14640.4 14644.9 8431.8 8482.3 8505.6 8655.3 8683.1 7465.4 7964.2 8314.8 8446.9 8565.2 4399.3 4521.5 4533.6 4587.9 4629.2 1190.9 1575.6 1881.3 1903.6 1996.9 699.2 894.7 934.4 968.0 1031.3 18632.7 21007.6 21081.5 21112.2 21117.8 904.4 925.1 976.5 979.3 1005.9 8076.6 9864.6 10369.1 10561.7 11097.9 565886.0 566702.0 572156.0 628814.0 634643.0 127473.0 132907.3 133758.3 135153.3 139349.0 928.6 959.4 964.0 969.1 969.5 18276.9 18506.4 18579.3 18839.4 19114.6 52380.2 53080.5 53482.7 53569.0 54044.7 71687.6 77646.6 78277.6 79523.6 80555.0 6976.5 7326.2 7652.0 8088.5 8285.8 11545.0 12728.7 12856.0 12899.5 12974.3 10926.2 10980.3 11019.7 11428.5 11484.5 10881.5 11013.3 11084.4 11098.3 11203.7 11154.4 11273.8 11317.4 11389.0 11564.2 5815.0 7294.6 7384.0 7532.5 7628.2 8476.6 11076.3 11156.2 11255.0 11277.7 07:54:53 INFO - PROCESS | 1643 | 07:54:53 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5448.77 Median:4986.04 stddev:3048.14 (61.1%) stddev-sans-first:3041.21 07:54:53 INFO - PROCESS | 1643 | Values: 1361.1 1445.3 1608.1 1720.2 1780.3 7554.8 7840.1 8099.8 8576.1 8600.1 6574.9 7875.2 8334.7 8357.2 8454.2 2313.7 2328.8 2330.5 2332.9 2344.0 2316.3 2350.8 2375.5 2375.9 2390.7 1941.5 2332.5 2345.6 2348.4 2352.0 2285.9 2287.3 2301.8 2312.8 2323.8 2327.7 2350.0 2353.9 2356.2 2359.1 8349.4 8513.7 8543.9 8548.1 8549.4 5050.4 5221.3 5222.1 5222.9 5231.1 2919.9 3189.7 3292.6 3520.7 3526.0 1024.1 1045.0 1053.0 1068.9 1090.3 11028.7 11067.1 11083.8 11155.0 11165.7 3897.7 4522.3 4582.9 4687.0 4796.9 8151.5 9208.8 9551.3 9562.0 9587.4 4920.0 5237.5 5239.0 5252.5 5267.7 3482.9 4435.3 4482.8 4629.6 4804.0 3200.0 3587.2 3836.6 3910.4 3926.8 1264.7 1280.5 1283.8 1292.3 1295.1 874.4 885.5 885.9 886.6 904.8 5482.0 5551.3 5643.3 5675.4 5748.6 379.3 439.9 449.9 455.2 455.7 3730.1 3736.2 3757.1 3764.2 3883.4 9859.1 10323.8 10337.2 10339.9 10340.6 9979.6 9993.3 10270.1 10342.6 10382.9 7813.7 7898.0 7993.8 8007.3 8012.5 5368.3 5376.0 5448.5 5546.1 5579.0 9433.4 9564.4 9601.5 9637.0 9655.7 9362.9 9555.5 9557.7 9746.0 9751.8 7157.4 7190.2 7212.9 7256.5 7306.0 7849.4 7965.3 7972.6 7975.8 7994.1 6967.2 7032.3 7105.1 7224.0 7292.9 6995.6 7126.2 7128.4 7152.7 7249.9 5474.5 6789.2 6800.7 6810.8 6817.6 4784.5 4848.8 4874.8 4882.6 4966.3 4893.8 4902.8 4965.3 5005.8 5060.2 07:54:53 INFO - PROCESS | 1643 | 07:54:53 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4551.36 Median:5075.49 stddev:1462.06 (28.8%) stddev-sans-first:1430.89 07:54:53 INFO - PROCESS | 1643 | Values: 298.6 298.8 301.9 305.6 309.4 5423.5 5501.4 5539.9 5665.1 5737.3 4732.5 5245.8 5507.1 5516.9 5566.6 3332.7 4167.9 4172.4 4219.9 4237.2 3122.4 3142.0 3363.6 3701.6 4359.4 3920.6 3928.0 3948.1 4126.0 4135.0 4082.9 4087.3 4112.7 4144.6 4173.2 2843.8 2951.3 3112.0 3311.8 3460.7 4398.2 4743.8 4794.6 4894.9 5397.7 4135.5 4342.0 4381.5 4737.7 4753.7 5440.2 5774.1 5833.0 5878.8 5879.8 3004.5 3412.4 3744.7 3782.9 3909.1 5278.8 6009.3 6029.0 6077.1 6179.0 3432.4 3630.3 3672.0 3875.9 3986.8 3898.0 3981.7 3993.2 4023.6 4036.8 4029.4 4169.5 4270.4 4494.9 4731.7 4937.0 5843.4 5844.2 5972.4 6006.4 1233.2 1266.5 1274.8 1283.9 1289.7 847.9 870.3 870.4 872.5 881.5 4262.5 4605.9 4708.9 4941.7 5174.7 4969.7 5071.4 5079.6 5160.5 5570.6 4494.6 4984.9 5028.9 5099.8 5167.7 2777.7 2863.7 2944.7 2946.6 2997.9 5825.5 5829.7 5850.8 5897.5 5907.9 5215.8 5290.3 5438.0 5785.4 5833.3 5283.2 5671.5 5892.8 5918.3 5926.0 5204.6 5280.6 5281.6 5738.2 5744.5 4577.0 4816.0 5968.8 6035.5 6052.2 5338.4 5598.3 5711.3 6262.9 6263.9 3397.8 3462.6 3972.2 3992.2 4017.5 5529.4 5846.3 6012.0 6081.6 6081.8 5099.9 5317.0 5479.0 5766.7 6002.7 5239.8 5901.5 5972.3 6045.4 6058.8 4304.7 5664.5 5800.2 5855.9 5880.0 4757.6 4926.4 5063.9 5851.5 5914.3 5790.8 5847.2 5850.4 5859.8 5868.0 07:54:53 INFO - PROCESS | 1643 | 07:54:53 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20122.88 Median:26617.26 stddev:29581.41 (111.1%) stddev-sans-first:29628.14 07:54:53 INFO - PROCESS | 1643 | Values: 616.3 692.5 705.2 758.2 791.2 12055.5 12954.4 13211.9 13918.4 14299.9 13230.9 13483.7 13496.5 13519.7 13521.5 802.4 822.7 825.8 826.8 826.9 646.7 670.4 793.3 824.0 836.0 864.9 865.3 867.2 869.1 872.5 862.2 865.2 865.7 866.5 867.0 631.6 634.9 637.4 638.0 639.8 13595.5 13893.3 14003.6 14018.0 14031.8 11025.3 12904.0 13385.5 13391.0 13517.2 8169.8 8604.4 9159.6 11164.8 11710.8 3550.3 3691.4 3695.0 3699.9 3703.7 63316.0 83686.6 85201.6 85640.6 86173.6 8687.8 9664.4 9759.0 10283.2 10570.6 19809.4 19995.9 20161.0 20177.2 20230.1 6285.4 7509.4 7539.1 7558.9 7650.5 4160.8 4198.5 4204.6 4331.2 4359.0 3364.5 3469.7 3491.1 3497.3 3503.8 608.5 614.2 614.6 616.7 628.2 544.8 611.8 632.5 635.8 655.6 7187.5 9259.3 9272.3 9343.0 9500.1 537.4 592.5 597.5 608.9 646.3 4018.0 4448.9 4596.3 4603.7 4621.3 100587.5 103802.0 123509.0 126971.0 129178.0 73783.6 89357.0 94407.0 95530.0 97439.5 59883.2 72620.6 89144.0 91230.0 93800.1 8467.5 9551.9 9882.8 9973.0 10006.9 52697.2 56424.0 57687.1 58208.4 59521.4 54864.0 56328.7 71986.6 72275.0 76555.9 11359.8 12397.6 12533.2 12533.6 12733.7 14154.2 14351.0 14404.9 14825.5 15277.2 13160.0 13410.1 13472.5 13476.9 14087.7 13661.1 13678.4 13782.6 13861.9 14303.6 12876.9 12998.2 13282.7 13539.5 14011.0 11151.3 11511.6 11645.5 11871.7 11876.0 11156.8 11570.6 11619.5 11737.7 11761.6 07:54:53 INFO - PROCESS | 1643 | -------- Summary: end -------- 07:54:53 INFO - PROCESS | 1643 | 07:54:54 INFO - TEST-INFO | 1643: exit 0 07:54:54 INFO - TEST-OK | dromaeo_css | took 1115924ms 07:54:54 INFO - TEST-START | kraken 07:54:54 INFO - operating with platform_type : mac_ 07:54:54 INFO - Initialising browser for kraken test... 07:54:54 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmpEKQqWo/profile http://localhost:49244/getInfo.html) 07:54:56 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 07:54:57 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 07:54:57 INFO - PROCESS | 1654 | colorDepth:24 07:54:57 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 07:54:57 INFO - PROCESS | 1654 | __metrics 07:54:57 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 07:54:58 INFO - TEST-INFO | 1654: exit 0 07:54:58 INFO - Browser initialized. 07:54:58 INFO - Running cycle 1/1 for kraken test... 07:54:58 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmpEKQqWo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:10 INFO - PROCESS | 1656 | RSS: Main: 224227328 07:55:10 INFO - PROCESS | 1656 | 07:55:13 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:14 INFO - PROCESS | 1656 | RSS: Main: 236761088 07:55:14 INFO - PROCESS | 1656 | 07:55:16 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 07:55:17 INFO - PROCESS | 1656 | RSS: Main: 244314112 07:55:17 INFO - PROCESS | 1656 | 07:55:20 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 07:55:21 INFO - PROCESS | 1656 | RSS: Main: 248012800 07:55:21 INFO - PROCESS | 1656 | 07:55:23 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 07:55:24 INFO - PROCESS | 1656 | RSS: Main: 249286656 07:55:24 INFO - PROCESS | 1656 | 07:55:26 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:55:26 INFO - PROCESS | 1656 | RSS: Main: 249405440 07:55:26 INFO - PROCESS | 1656 | 07:55:29 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 07:55:30 INFO - PROCESS | 1656 | RSS: Main: 253190144 07:55:30 INFO - PROCESS | 1656 | 07:55:33 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 07:55:34 INFO - PROCESS | 1656 | RSS: Main: 252497920 07:55:34 INFO - PROCESS | 1656 | 07:55:37 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 07:55:37 INFO - PROCESS | 1656 | RSS: Main: 253067264 07:55:37 INFO - PROCESS | 1656 | 07:55:39 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:55:39 INFO - PROCESS | 1656 | RSS: Main: 252727296 07:55:40 INFO - PROCESS | 1656 | 07:55:42 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:55:42 INFO - PROCESS | 1656 | RSS: Main: 252522496 07:55:42 INFO - PROCESS | 1656 | 07:55:44 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:55:45 INFO - PROCESS | 1656 | RSS: Main: 252317696 07:55:45 INFO - PROCESS | 1656 | 07:55:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:55:49 INFO - PROCESS | 1656 | RSS: Main: 252526592 07:55:49 INFO - PROCESS | 1656 | 07:55:52 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:55:52 INFO - PROCESS | 1656 | RSS: Main: 252420096 07:55:52 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 07:55:54 INFO - PROCESS | 1656 | RSS: Main: 254390272 07:55:54 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | __start_tp_report 07:55:54 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 07:55:54 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 07:55:54 INFO - PROCESS | 1656 | |i|pagename|runs| 07:55:54 INFO - PROCESS | 1656 | |0;ai-astar;108;128;176;159;122;119;119;120;119;120 07:55:54 INFO - PROCESS | 1656 | |1;audio-beat-detection;182;145;112;148;116;119;112;119;144;116 07:55:54 INFO - PROCESS | 1656 | |2;audio-dft;198;202;202;195;286;254;199;195;198;196 07:55:54 INFO - PROCESS | 1656 | |3;audio-fft;79;60;78;112;54;73;83;87;114;77 07:55:54 INFO - PROCESS | 1656 | |4;audio-oscillator;88;70;92;72;69;72;85;70;92;126 07:55:54 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;110;134;99;133;139;87;92;105;138;133 07:55:54 INFO - PROCESS | 1656 | |6;imaging-darkroom;96;98;97;96;105;144;97;98;153;97 07:55:54 INFO - PROCESS | 1656 | |7;imaging-desaturate;138;140;87;87;89;88;88;89;89;88 07:55:54 INFO - PROCESS | 1656 | |8;json-parse-financial;55;56;51;59;78;58;58;58;59;60 07:55:54 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;68;68;71;84;93;75;61;92;111;108 07:55:54 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;86;87;91;85;84;89;83;83;91;87 07:55:54 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;161;163;151;173;167;162;151;150;196;166 07:55:54 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;171;173;175;175;234;182;166;169;169;168 07:55:54 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;63;90;60;84;92;91;91;69;68;67 07:55:54 INFO - PROCESS | 1656 | __end_tp_report 07:55:54 INFO - PROCESS | 1656 | __start_cc_report 07:55:54 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,985 07:55:54 INFO - PROCESS | 1656 | __end_cc_report 07:55:54 INFO - PROCESS | 1656 | __startTimestamp1479225354956__endTimestamp 07:55:54 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | ------- Summary: start ------- 07:55:54 INFO - PROCESS | 1656 | Number of tests: 14 07:55:54 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:129.00 Median:121.00 stddev:21.24 (17.6%) stddev-sans-first:21.13 07:55:54 INFO - PROCESS | 1656 | Values: 108.0 128.0 176.0 159.0 122.0 119.0 119.0 120.0 119.0 120.0 07:55:54 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:131.50 stddev:22.89 (17.4%) stddev-sans-first:15.24 07:55:54 INFO - PROCESS | 1656 | Values: 182.0 145.0 112.0 148.0 116.0 119.0 112.0 119.0 144.0 116.0 07:55:54 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:212.50 Median:200.50 stddev:31.33 (15.6%) stddev-sans-first:32.79 07:55:54 INFO - PROCESS | 1656 | Values: 198.0 202.0 202.0 195.0 286.0 254.0 199.0 195.0 198.0 196.0 07:55:54 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:81.70 Median:77.50 stddev:19.29 (24.9%) stddev-sans-first:20.43 07:55:54 INFO - PROCESS | 1656 | Values: 79.0 60.0 78.0 112.0 54.0 73.0 83.0 87.0 114.0 77.0 07:55:54 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:83.60 Median:78.50 stddev:17.68 (22.5%) stddev-sans-first:18.68 07:55:54 INFO - PROCESS | 1656 | Values: 88.0 70.0 92.0 72.0 69.0 72.0 85.0 70.0 92.0 126.0 07:55:54 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:138.50 stddev:20.46 (14.8%) stddev-sans-first:21.55 07:55:54 INFO - PROCESS | 1656 | Values: 110.0 134.0 99.0 133.0 139.0 87.0 92.0 105.0 138.0 133.0 07:55:54 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:108.10 Median:97.00 stddev:21.55 (22.2%) stddev-sans-first:22.41 07:55:54 INFO - PROCESS | 1656 | Values: 96.0 98.0 97.0 96.0 105.0 144.0 97.0 98.0 153.0 97.0 07:55:54 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:98.30 Median:88.00 stddev:21.47 (24.4%) stddev-sans-first:17.31 07:55:54 INFO - PROCESS | 1656 | Values: 138.0 140.0 87.0 87.0 89.0 88.0 88.0 89.0 89.0 88.0 07:55:54 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:58.50 stddev:7.10 (12.1%) stddev-sans-first:7.37 07:55:54 INFO - PROCESS | 1656 | Values: 55.0 56.0 51.0 59.0 78.0 58.0 58.0 58.0 59.0 60.0 07:55:54 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:83.10 Median:73.00 stddev:17.43 (23.9%) stddev-sans-first:17.61 07:55:54 INFO - PROCESS | 1656 | Values: 68.0 68.0 71.0 84.0 93.0 75.0 61.0 92.0 111.0 108.0 07:55:54 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:2.99 (3.4%) stddev-sans-first:3.16 07:55:54 INFO - PROCESS | 1656 | Values: 86.0 87.0 91.0 85.0 84.0 89.0 83.0 83.0 91.0 87.0 07:55:54 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:164.00 Median:164.50 stddev:13.61 (8.3%) stddev-sans-first:14.39 07:55:54 INFO - PROCESS | 1656 | Values: 161.0 163.0 151.0 173.0 167.0 162.0 151.0 150.0 196.0 166.0 07:55:54 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:174.00 stddev:20.14 (11.6%) stddev-sans-first:21.19 07:55:54 INFO - PROCESS | 1656 | Values: 171.0 173.0 175.0 175.0 234.0 182.0 166.0 169.0 169.0 168.0 07:55:54 INFO - PROCESS | 1656 | 07:55:54 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.50 Median:87.00 stddev:13.18 (15.1%) stddev-sans-first:12.89 07:55:54 INFO - PROCESS | 1656 | Values: 63.0 90.0 60.0 84.0 92.0 91.0 91.0 69.0 68.0 67.0 07:55:54 INFO - PROCESS | 1656 | -------- Summary: end -------- 07:55:54 INFO - PROCESS | 1656 | 07:55:55 INFO - TEST-INFO | 1656: exit 0 07:55:55 INFO - TEST-OK | kraken | took 61219ms 07:55:55 INFO - SUITE-END | took 1177s 07:55:56 INFO - Completed test suite (00:19:37) 07:55:56 INFO - javascript benchmark 07:55:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7127.152493952608, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3377.1557110722306, 3396.796192228465, 3397.7791443556166, 3404.063882432331, 3408.7273018158544, 4153.958460415402, 4578.9771051144735, 5053.848384548465, 5329.786808527664, 5787.450192231742, 5932.436418540243, 5948.910766338508, 5989.730462129204, 6006.549508786848, 6025.216721826157, 4490.618297444721, 5285.788568457277, 5321.88669628268, 5376.865578360533, 5401.459854014606, 5389.137737961927, 5392.865178370533, 5432.022235997519, 5437.809676661318, 5437.945620543804, 4415.889602759925, 5349.7057661828585, 5358.0, 5432.076546987002, 5465.07093794056, 5346.518813306821, 5353.544948679387, 5359.9732001340135, 5374.817540141163, 5387.24578559002, 5192.766325515323, 5253.185756207794, 5278.498542638443, 5304.867378315535, 5402.216678581583, 5060.5951523878, 5938.168656388109, 5990.730417131196, 5995.760169593211, 6010.939890601082, 5818.476337129637, 6194.783182588588, 6243.344448832852, 6265.310815810257, 6265.686715664198, 6189.907151392733, 6296.496280297565, 6318.715657795365, 6319.178506794087, 6338.429541341256, 6029.065494848305, 6037.335893051761, 6046.697665116727, 6051.757929682807, 6076.118962750376, 6207.131001659771, 6263.96868015657, 6335.144755458046, 6387.233531976192, 6404.263509696351, 6223.719932603044, 6271.905921411182, 6280.057991301342, 6289.96855015722, 6301.873962520815, 6288.182536270256, 6308.116863639094, 6309.14826498426, 6317.810465686037, 6319.96840015797, 6166.445019948226, 6178.0, 6251.937480625135, 6312.52656050798, 6333.461655759312, 5629.761452480448, 5652.689102099342, 6241.937580624136, 6266.0, 6298.149749783721, 4765.7140571565815, 4987.850364488999, 4991.800327986913, 4999.375078115236, 5015.924761128586, 4170.687198460128, 4406.515283318832, 4456.844010459618, 4505.234110201273, 4630.166570017429, 5886.381929897385, 5936.821895343147, 5968.46283834457, 5977.402259774075, 6013.278406591237, 6171.7531298748445, 6183.165272688129, 6229.3770622937345, 6257.124002639634, 6264.248290205113, 6006.279246490449, 6009.9617584148555, 6013.128096426081, 6078.088286757022, 6086.995645718495, 5526.143447765603, 5559.33288005442, 5580.162975553618, 5582.302212223472, 5608.411116832755, 6307.810765677037, 6521.5108866834225, 6525.282218955911, 6547.017947307847, 6549.803505894831, 6182.443580077815, 6189.81430557084, 6231.2522497300615, 6280.309165991828, 6372.617642941438, 5473.343198816167, 6418.743250269937, 6441.0, 6462.063000864942, 6501.349865013461, 6284.654344011124, 6298.779542715983, 6301.779437719658, 6303.747850085945, 6317.936820631919, 4835.637327200404, 6177.722002509808, 6184.938150618436, 6245.28179259391, 6248.718807653576, 6251.156093927261, 6262.718177682106, 6281.52888533371, 6284.591501552384, 6312.842178945563, 6168.303716478004, 6241.500679945684, 6245.750169993149, 6301.842453938688, 6310.842228944313, 5183.948160518346, 5965.6718880461995, 5987.251593550806, 6019.849503762441, 6058.182145410313, 6153.815385538441, 6187.690615469119, 6198.876022479615, 6278.654673992792, 6324.241091068917, 4967.677100988424, 5530.281063461724, 5785.784985153165, 6205.503559715122, 6216.658083805434], "value": 5745.473391879267, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.7379919646605, 490.2988726121646, 506.9493050694931, 532.5420138680736, 557.1420013179703, 29507.40985180298, 31163.84418077909, 31234.375312493765, 38976.0, 40273.7986310068, 40015.0, 40136.19727605446, 40714.0, 40786.38820417696, 40790.18419631613, 9173.908260917373, 9331.72004839856, 9343.2525397968, 9376.437413755197, 9490.0, 9262.907370926305, 9360.970293267736, 9361.0, 9372.437653740762, 9403.106704863027, 9358.672446464376, 9383.624655013791, 9392.107749763796, 9392.906070939305, 9402.7687540607, 8352.582370881431, 9270.72187834366, 9332.906670933271, 9335.019822918564, 9360.391574547666, 9242.399244049115, 9302.302327325478, 9317.440953542742, 9327.253819694408, 9356.157945784911, 39344.819655410385, 39581.80209098936, 39636.80181599074, 39648.20703585912, 39725.40411893824, 2873.951007882108, 3375.4093033719246, 3474.409350410411, 3685.0971511979737, 3867.0139114525614, 28471.572926405912, 29318.560221596694, 29642.25894352637, 30291.0, 30429.695703042908, 3092.608665289959, 3155.3058327167987, 3207.470767323389, 3217.1635374802718, 3245.6429792722784, 502859.37132829113, 505274.0, 507842.99999999633, 509642.0, 509683.0, 60175.39824601785, 60283.49291267753, 60521.78956420935, 60544.69727651333, 60631.393686062576, 59679.70160149258, 59687.70156149278, 59968.70015649894, 60068.39931600628, 60181.09728354078, 12430.813537796941, 13852.16886986784, 16223.594410139842, 16282.185890705417, 16306.75539866903, 12387.380630968595, 12469.875301247053, 12476.313802740755, 12486.375681215903, 12502.687432814071, 12882.80675789864, 17351.566210844576, 17487.912560437115, 17622.118894055504, 17666.470005899588, 2933.735963763229, 3225.8870939517005, 5349.518543331119, 5420.861619059962, 6062.939370606237, 876.9166929141721, 951.5622813505864, 990.2474119668959, 1006.2591716330788, 1026.9435181064964, 29481.115566533037, 30278.54582181269, 30364.0, 30420.93526726598, 30613.540796888065, 858.9226969572768, 985.6008316631776, 1032.4115254304975, 1041.958041958042, 1054.2146101154535, 14860.182689952157, 15636.4527241546, 15890.60273493172, 16079.517614471584, 16253.918730406509, 695507.0, 695806.0, 699693.0, 700797.0, 703860.0, 57411.564710882565, 57861.71069144627, 58068.41931580714, 58191.836163277345, 58261.0, 1220.8718084601167, 1322.7222283320611, 1326.2506683723666, 1359.0690377091723, 1365.112676760094, 28890.566641500816, 29570.260743481584, 29969.850150749106, 29987.550186747652, 30476.69523304827, 51351.743241283555, 52119.0, 52172.47827521828, 52283.73858130685, 52337.0, 638056.0, 642932.0, 643239.0, 643285.0, 644903.0, 22665.773342267024, 26500.602490963036, 26512.072077477194, 26784.062557810383, 26825.731742682325, 45500.772496138634, 45529.54470455253, 46391.768041160925, 46549.53450465587, 46820.82947926193, 37121.628783711814, 38393.80803095967, 39066.414003789396, 39555.80222098871, 41560.0, 33837.15407114743, 37817.48730050767, 38416.6158338413, 39295.80352098221, 39589.40615890821, 35994.0, 37957.05107372338, 38721.80639096787, 38847.41728874126, 38853.805730971166, 32851.34297314088, 34045.48931766075, 34243.4863477053, 34579.0, 34869.825650871586, 25805.483890322463, 25860.0, 25990.48019039571, 26104.477910442063, 26413.0], "value": 19432.18987753037, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.3445458674158, 372.5566575774828, 375.19520628252417, 385.86880460643386, 403.2660557784831, 14987.47543835966, 18517.907410462947, 19261.903690481562, 19726.309579164714, 19951.60096798063, 11283.37941413222, 11705.824412633818, 11708.946194842463, 11739.00218481428, 11741.354225517593, 4820.903581928359, 5667.178259152421, 5954.612950158225, 6023.638581685091, 6083.817485475421, 3832.099456627704, 4029.81865816039, 5749.942500574983, 6012.218411606507, 6054.091886217081, 6011.158437818709, 6085.574009819315, 6089.756409743627, 6091.238595175603, 6099.085137229429, 5823.970880145594, 6021.819345419644, 6069.332373438918, 6080.361562035967, 6084.939150608481, 5633.40849210831, 5895.675737834417, 5905.055191169436, 5911.674857882815, 5939.316978547436, 12726.300053497054, 12809.743805123939, 22333.0, 23560.764392356028, 24348.634770478457, 2025.3316405586122, 2259.618243444125, 2282.1213832674375, 2379.6073647848084, 2553.9361515962064, 7643.847123057563, 9728.027197280215, 10138.442385668784, 10242.7439314017, 14548.097120046208, 1619.6922584708868, 1744.7819022622173, 1840.815918408162, 1871.6069625378686, 1918.6834172361544, 127284.60050646994, 127698.36150819187, 133184.33407832898, 134912.32543837218, 135667.999999999, 11626.709332266591, 11642.01042911362, 11738.647840564796, 11738.94130529342, 11894.405279735978, 14275.286235688174, 14619.26903654813, 14634.268286585628, 14640.414383424757, 14644.853551464563, 8431.789205269917, 8482.279006284412, 8505.617247223767, 8655.264302534355, 8683.088275731083, 7465.432259225515, 7964.1637628049375, 8314.792130196673, 8446.915530844613, 8565.229129378262, 4399.296112621965, 4521.480029796549, 4533.569310915458, 4587.944772702297, 4629.189891768927, 1190.9341139679939, 1575.6218507558103, 1881.3227238194238, 1903.5526651236949, 1996.8901710405776, 699.2133849419403, 894.7271082319825, 934.3646320501988, 967.9642782222954, 1031.28841099641, 18632.72050919237, 21007.579848402947, 21081.472963176042, 21112.155513779584, 21117.8385188813, 904.4437670832391, 925.121134921827, 976.4580657734883, 979.294907666479, 1005.9497025148713, 8076.636551355203, 9864.556094975744, 10369.066783989327, 10561.735956601147, 11097.946879827257, 565886.0, 566702.0, 572156.0, 628814.0, 634643.0, 127473.0, 132907.33546332206, 133758.33120834528, 135153.3242333782, 139349.0, 928.6331898899897, 959.3620242538634, 964.0, 969.1181025266973, 969.4667932637162, 18276.908615456836, 18506.44480665582, 18579.349722759638, 18839.434816955512, 19114.617707646048, 52380.16669416552, 53080.46919530755, 53482.73258633682, 53569.0, 54044.72977635087, 71687.64156179185, 77646.61176694307, 78277.60861195657, 79523.60238198772, 80555.0, 6976.4767642426, 7326.157491888501, 7651.961740191264, 8088.474249173785, 8285.757136429584, 11545.0, 12728.68178295513, 12856.0, 12899.548515801902, 12974.286414247306, 10926.235163538477, 10980.286281391684, 11019.669409917715, 11428.542858285575, 11484.483198256266, 10881.455927203766, 11013.2841365311, 11084.44577771092, 11098.334099954029, 11203.71990700239, 11154.442277885912, 11273.830892536454, 11317.377544235145, 11389.031932285849, 11564.190506664452, 5814.970925145516, 7294.635268236673, 7384.0, 7532.548047116971, 7628.160902300631, 8476.576171191538, 11076.280041797258, 11156.163287753614, 11255.04332131778, 11277.71805704864], "value": 9229.344164996211, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.1016728958887, 1445.2556933179412, 1608.0833924662938, 1720.1915099903042, 1780.2878848460614, 7554.81112972176, 7840.13758486566, 8099.797505062369, 8576.142385761428, 8600.096989816066, 6574.901376479344, 7875.173106823787, 8334.666613335474, 8357.16428357164, 8454.154584541542, 2313.7223533176, 2328.790408863202, 2330.533893221354, 2332.8600283982933, 2344.003798385679, 2316.2587971849016, 2350.8354415190943, 2375.524895020994, 2375.8930848111877, 2390.713114426271, 1941.4563922101834, 2332.4751930815514, 2345.636426353918, 2348.365941195876, 2352.023910077316, 2285.897134628946, 2287.2795069553204, 2301.80434663053, 2312.791848733605, 2323.8257130715265, 2327.7090363704538, 2350.0, 2353.8940747666397, 2356.2106694257445, 2359.0681680736184, 8349.373796965252, 8513.659453621847, 8543.914560854375, 8548.059713431518, 8549.444286121383, 5050.444451110375, 5221.269022336875, 5222.138347172712, 5222.947770522284, 5231.084560201987, 2919.941601167986, 3189.6969787870116, 3292.621348544924, 3520.68313851752, 3525.982370088159, 1024.1141412678055, 1045.0124632222553, 1052.9684109476727, 1068.8503609494676, 1090.2913106480771, 11028.724281893017, 11067.059299959514, 11083.778324433466, 11154.996050355427, 11165.665030049031, 3897.7466464679705, 4522.25382811839, 4582.88542786433, 4686.95313046872, 4796.856094317176, 8151.510909345339, 9208.815823683488, 9551.331406801597, 9562.043795620382, 9587.424754514752, 4920.0, 5237.450067742909, 5239.0, 5252.474752524717, 5267.71027593486, 3482.8606855725993, 4435.334699795057, 4482.843100491467, 4629.560191781776, 4804.039192161582, 3199.976007677521, 3587.210813620999, 3836.5971572984995, 3910.354791459434, 3926.784026878549, 1264.72808346206, 1280.5006047641427, 1283.8459384873688, 1292.3021568352983, 1295.0934345957867, 874.3748220022715, 885.5230399976168, 885.8538341173634, 886.6497733395273, 904.755715956688, 5481.972590137024, 5551.306086739158, 5643.266375371258, 5675.432456754292, 5748.649067469141, 379.30587025742824, 439.91861505621563, 449.8717865408343, 455.153414648753, 455.70606958511576, 3730.123420996064, 3736.23407201523, 3757.0795155186606, 3764.2095160016156, 3883.4369016493015, 9859.112679858847, 10323.793524129474, 10337.22470814692, 10339.948300258451, 10340.638077667396, 9979.550920208609, 9993.300468967103, 10270.0756931875, 10342.586296548205, 10382.948085259526, 7813.68745250195, 7897.960510197528, 7993.840123197503, 8007.279344858991, 8012.4791888528225, 5368.302120724281, 5375.973120134374, 5448.509634132947, 5546.084895992116, 5579.0, 9433.433993960385, 9564.426134431957, 9601.519924003911, 9637.036296370306, 9655.710328690151, 9362.859557106513, 9555.474448905377, 9557.713268601952, 9745.951270243604, 9751.756206094904, 7157.355837974607, 7190.245024272376, 7212.89180662301, 7256.455765817479, 7306.0, 7849.372050236082, 7965.322947549292, 7972.6412311444965, 7975.84048319042, 7994.080680721559, 6967.198772141066, 7032.331928466788, 7105.076340075757, 7224.0, 7292.890606640798, 6995.580265184105, 7126.216116227314, 7128.358447739728, 7152.678129484081, 7249.855002900018, 5474.452554744653, 6789.15135608049, 6800.6599670017295, 6810.82972925661, 6817.5568588041615, 4784.473707892199, 4848.8302909398, 4874.829380971791, 4882.60939124862, 4966.304717339648, 4893.828715994923, 4902.828401005948, 4965.329680493087, 5005.77474013663, 5060.2156665716875], "value": 4330.471435906342, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.5968941928396, 298.7505432963474, 301.9381026889485, 305.5630448458705, 309.3905007135941, 5423.511883930445, 5501.394846566875, 5539.9169012464845, 5665.130506932713, 5737.2541569596, 4732.503087175849, 5245.849201827252, 5507.063799154143, 5516.931150818443, 5566.630195296693, 3332.7333813295, 4167.874963751077, 4172.395002724603, 4219.9028252654225, 4237.23729728648, 3122.3911337289237, 3141.968580314202, 3363.596368435791, 3701.648343407372, 4359.411479450266, 3920.5883382244883, 3927.9803600981954, 3948.1116748731592, 4125.958740412602, 4135.028268356934, 4082.9387559186634, 4087.3460246360587, 4112.712110152275, 4144.6062624050965, 4173.207090652766, 2843.843588602626, 2951.2916899944075, 3111.968880311213, 3311.8012919224925, 3460.723142148622, 4398.208322501949, 4743.837759748849, 4794.592459640935, 4894.926576101361, 5397.676139431646, 4135.545090040093, 4341.978290108529, 4381.4961279452955, 4737.715737055753, 4753.691010084333, 5440.238366628636, 5774.076147816371, 5833.045929613584, 5878.794242201502, 5879.79420720277, 3004.4892368297224, 3412.4028295048265, 3744.7378683492166, 3782.884049205491, 3909.100906791454, 5278.788848446057, 6009.278886533601, 6029.035354343284, 6077.116094010871, 6178.9691051544905, 3432.3993301172195, 3630.3465376232, 3671.963280367162, 3875.895369819588, 3986.760794352348, 3897.9805100974313, 3981.655201167415, 3993.221321842213, 4023.6177563131455, 4036.7779772112817, 4029.3553031515403, 4169.478815148106, 4270.444842170498, 4494.910101797946, 4731.69243999139, 4936.963237720119, 5843.357230704619, 5844.185035889317, 5972.372900845436, 6006.369331220247, 1233.2241572136274, 1266.5440441441074, 1274.7705413025744, 1283.889435638185, 1289.6517940156104, 847.9364047696447, 870.2559311788457, 870.3863776037878, 872.4590753732726, 881.4667126388442, 4262.488501379854, 4605.930911036337, 4708.929366059512, 4941.678790878582, 5174.715390653475, 4969.726665033386, 5071.41678706946, 5079.564865593853, 5160.48395160481, 5570.607348162959, 4494.573015563582, 4984.850454486371, 5028.899422011613, 5099.796008159707, 5167.689938603696, 2777.7083406242054, 2863.742263196281, 2944.748481895186, 2946.57274695168, 2997.880084796627, 5825.504832089235, 5829.679367634821, 5850.824475265749, 5897.52819774417, 5907.940920590825, 5215.792287743011, 5290.323225358416, 5437.972810135924, 5785.417072525033, 5833.250024992485, 5283.181106928432, 5671.517920976763, 5892.793752218738, 5918.265387689917, 5925.999999999914, 5204.635675502678, 5280.551153152025, 5281.57747380201, 5738.167965644875, 5744.511716504144, 4577.0, 4815.975920120377, 5968.83607696495, 6035.486983606443, 6052.246227966177, 5338.4127745947135, 5598.272224610938, 5711.257536520226, 6262.889558022281, 6263.906041409474, 3397.847096880696, 3462.619111897639, 3972.245273398045, 3992.2215168041953, 4017.4978127734034, 5529.391766905717, 5846.269216347957, 6011.969940150446, 6081.604695694943, 6081.817545473643, 5099.898002040012, 5316.989771943318, 5479.0, 5766.682832444256, 6002.658963004519, 5239.825472428899, 5901.527877769682, 5972.34304226526, 6045.395460453919, 6058.84852878664, 4304.6556275498515, 5664.546836253172, 5800.216970708901, 5855.912161317498, 5880.030189886264, 4757.595604373667, 4926.379111353081, 5063.924041139459, 5851.502622276984, 5914.34942156371, 5790.768369265183, 5847.164125399093, 5850.356460789395, 5859.765609375577, 5867.970660146842], "value": 4083.8432823136604, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.3312805605917, 692.4771797293046, 705.206642527157, 758.2303961479099, 791.1890312429758, 12055.517779288817, 12954.417051232693, 13211.933940330297, 13918.373673184706, 14299.857001429982, 13230.933845330785, 13483.730325393486, 13496.527621533249, 13519.662008449794, 13521.459141634348, 802.4182467710907, 822.7367242482408, 825.8018075661828, 826.7685048186518, 826.8511667899776, 646.6637348578736, 670.4468813229081, 793.3335997761878, 824.0029564227292, 836.0302049622439, 864.9481031138121, 865.3336930563462, 867.1848462445313, 869.0614136732314, 872.5026734761188, 862.1981557151846, 865.1953683074738, 865.6840253307529, 866.5364030243852, 866.9913300867005, 631.6241836107508, 634.8635043465631, 637.4454224824386, 637.996810015947, 639.7952655150353, 13595.456181752717, 13893.305334733222, 14003.579892603238, 14018.0, 14031.78952315716, 11025.338479691245, 12904.032197585218, 13385.464581416732, 13390.995675324291, 13517.188968661814, 8169.754907352789, 8604.39769216155, 9159.633614655406, 11164.832527512093, 11710.76578468426, 3550.3254381667402, 3691.354013047706, 3694.963050369489, 3699.8705045323554, 3703.703703703697, 63316.0, 83686.58156709238, 85201.57399212965, 85640.57179714124, 86173.56913215456, 8687.782805429788, 9664.420134791935, 9759.024097590183, 10283.177345812317, 10570.630027948984, 19809.40571782849, 19995.900020500096, 20160.991950402422, 20177.192912283637, 20230.089645965967, 6285.402886725754, 7509.436792240604, 7539.0576177977755, 7558.9244107558225, 7650.540967541965, 4160.771157586301, 4198.4961804583645, 4204.558521355275, 4331.198728235287, 4358.975640724428, 3364.4953257011152, 3469.65303469651, 3491.127218195451, 3497.2655742294405, 3503.7722548034294, 608.4979891589368, 614.1524695919692, 614.5882258886556, 616.737886398279, 628.1959092361784, 544.8202093309199, 611.782817099932, 632.5445679111033, 635.833245993607, 655.6066360183852, 7187.460940429489, 9259.259259259377, 9272.258219342437, 9343.018983006823, 9500.097490738368, 537.3712756075402, 592.5496622566794, 597.5339235396398, 608.9451949324493, 646.3407324528954, 4018.0, 4448.888777780581, 4596.333531637961, 4603.746793926366, 4621.2837010263465, 100587.49706251569, 103802.0, 123509.0, 126971.0, 129178.0, 73783.63108184424, 89357.0, 94407.0, 95529.950232846, 97439.51280243695, 59883.203503894954, 72620.63689681518, 89143.9999999987, 91230.0, 93800.0619993805, 8467.49195048299, 9551.856722149312, 9882.752931176778, 9972.950135249277, 10006.949965250127, 52697.15559955383, 56424.0, 57687.1346929788, 58208.41791582199, 59521.404785951585, 54864.0, 56328.71835640795, 71986.64006679933, 72275.0, 76555.851662224, 11359.829602556134, 12397.566085186974, 12533.185342952678, 12533.561325353568, 12733.681657958625, 14154.150750954976, 14351.039745723525, 14404.927975360475, 14825.481108161594, 15277.159756213516, 13160.0, 13410.061295709207, 13472.461101555828, 13476.865231347561, 14087.718245635235, 13661.112027718167, 13678.384472698952, 13782.586522404345, 13861.861381386057, 14303.570892873231, 12876.935615321863, 12998.220106793622, 13282.667933301746, 13539.458421663023, 14011.0, 11151.330920144817, 11511.597094101666, 11645.534178632759, 11871.703207419883, 11876.0, 11156.776864462827, 11570.633353508787, 11619.524529611475, 11737.706557336134, 11761.588344407905], "value": 7191.628834720212, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1610.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 128.0, 176.0, 159.0, 122.0, 119.0, 119.0, 120.0, 119.0, 120.0], "value": 129.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 145.0, 112.0, 148.0, 116.0, 119.0, 112.0, 119.0, 144.0, 116.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 202.0, 202.0, 195.0, 286.0, 254.0, 199.0, 195.0, 198.0, 196.0], "value": 212.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 78.0, 112.0, 54.0, 73.0, 83.0, 87.0, 114.0, 77.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 92.0, 72.0, 69.0, 72.0, 85.0, 70.0, 92.0, 126.0], "value": 83.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 134.0, 99.0, 133.0, 139.0, 87.0, 92.0, 105.0, 138.0, 133.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 97.0, 96.0, 105.0, 144.0, 97.0, 98.0, 153.0, 97.0], "value": 108.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 87.0, 87.0, 89.0, 88.0, 88.0, 89.0, 89.0, 88.0], "value": 98.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 51.0, 59.0, 78.0, 58.0, 58.0, 58.0, 59.0, 60.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 71.0, 84.0, 93.0, 75.0, 61.0, 92.0, 111.0, 108.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 91.0, 85.0, 84.0, 89.0, 83.0, 83.0, 91.0, 87.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 151.0, 173.0, 167.0, 162.0, 151.0, 150.0, 196.0, 166.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 175.0, 175.0, 234.0, 182.0, 166.0, 169.0, 169.0, 168.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 90.0, 60.0, 84.0, 92.0, 91.0, 91.0, 69.0, 68.0, 67.0], "value": 77.5, "unit": "score"}]}]} 07:55:56 INFO - Return code: 0 07:55:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:55:56 ERROR - # TBPL SUCCESS # 07:55:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:55:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:55:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:55:56 INFO - 2016-11-15 07:55:56.301 screenresolution[1661:10542] starting screenresolution argv=screenresolution get 07:55:56 INFO - 2016-11-15 07:55:56.304 screenresolution[1661:10542] Display 0: 1600x1200x32@50 07:55:56 INFO - 2016-11-15 07:55:56.309 screenresolution[1662:10545] starting screenresolution argv=screenresolution list 07:55:56 INFO - Available Modes on Display 0 07:55:56 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 07:55:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:55:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:55:56 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 07:55:56 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 07:55:56 INFO - Graphics/Displays: 07:55:56 INFO - Intel Iris: 07:55:56 INFO - Chipset Model: Intel Iris 07:55:56 INFO - Type: GPU 07:55:56 INFO - Bus: Built-In 07:55:56 INFO - VRAM (Dynamic, Max): 1536 MB 07:55:56 INFO - Vendor: Intel (0x8086) 07:55:56 INFO - Device ID: 0x0a2e 07:55:56 INFO - Revision ID: 0x0009 07:55:56 INFO - Displays: 07:55:56 INFO - Display: 07:55:56 INFO - Resolution: 1600 x 1200 @ 50 Hz 07:55:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:55:56 INFO - Display Serial Number: 1600x1200 50 07:55:56 INFO - Main Display: Yes 07:55:56 INFO - Mirror: Off 07:55:56 INFO - Online: Yes 07:55:56 INFO - Rotation: Supported 07:55:56 INFO - Return code: 0 07:55:56 INFO - Running post-action listener: _resource_record_post_action 07:55:56 INFO - [mozharness: 2016-11-15 15:55:56.546806Z] Finished run-tests step (success) 07:55:56 INFO - Running post-run listener: _resource_record_post_run 07:55:56 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 38740992; Write bytes: 657723904; Read time: 375; Write time: 1855 07:55:56 INFO - TinderboxPrint: CPU usage
54.4% 07:55:56 INFO - TinderboxPrint: I/O read bytes / time
38,740,992 / 375 07:55:56 INFO - TinderboxPrint: I/O write bytes / time
657,723,904 / 1,855 07:55:56 INFO - TinderboxPrint: CPU idle
2,209.5 (45.6%) 07:55:56 INFO - TinderboxPrint: CPU system
984.4 (20.3%) 07:55:56 INFO - TinderboxPrint: CPU user
1,647.8 (34.0%) 07:55:56 INFO - TinderboxPrint: Swap in / out
391,614,464 / 0 07:55:56 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 348447232; Write bytes: 349470208; Read time: 27366; Write time: 683 07:55:56 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 36779008; Write bytes: 297833472; Read time: 356; Write time: 1141 07:55:57 INFO - Running post-run listener: _upload_blobber_files 07:55:57 INFO - Blob upload gear active. 07:55:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:55:57 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 07:55:57 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:55:57 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:55:57 INFO - (blobuploader) - INFO - Open directory for files ... 07:55:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:55:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:55:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:58 INFO - (blobuploader) - INFO - Done attempting. 07:55:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:55:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:55:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:59 INFO - (blobuploader) - INFO - Done attempting. 07:55:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:55:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:01 INFO - (blobuploader) - INFO - Done attempting. 07:56:01 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:01 INFO - Return code: 0 07:56:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9742a092c61c303e27e61632d5b02817cefd7371c8b344184fffb751dbff227364d5a62190a8b32c796aa463f25c0dadf72a81392054d7428f690bcc2ff89ec7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9136241a6fa49db67df3aaa0e532b14aee793279c92849dcb3be8ae007bd10ac92a01699b41a35a3f2eebabcc7a7a86ea3286100452345ff2c8f69dc2aad10a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82aeb4c3f12e1e16fde6ac3555b8fb046aacf86273213775a7b399b81ffa9c927abf32356e1b677197a52210feb59935a38db15d1a32bb14982062b71c969385"} 07:56:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:01 INFO - Contents: 07:56:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9742a092c61c303e27e61632d5b02817cefd7371c8b344184fffb751dbff227364d5a62190a8b32c796aa463f25c0dadf72a81392054d7428f690bcc2ff89ec7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9136241a6fa49db67df3aaa0e532b14aee793279c92849dcb3be8ae007bd10ac92a01699b41a35a3f2eebabcc7a7a86ea3286100452345ff2c8f69dc2aad10a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82aeb4c3f12e1e16fde6ac3555b8fb046aacf86273213775a7b399b81ffa9c927abf32356e1b677197a52210feb59935a38db15d1a32bb14982062b71c969385"} 07:56:01 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:01 INFO - Copying logs to upload dir... 07:56:01 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.914848 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-15 07:56:01.547573) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 07:56:01.551646) ========= 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.9ADDzah3LA/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.3vM1IRqVmS/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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/Mozilla-Aurora/sha512/9742a092c61c303e27e61632d5b02817cefd7371c8b344184fffb751dbff227364d5a62190a8b32c796aa463f25c0dadf72a81392054d7428f690bcc2ff89ec7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9136241a6fa49db67df3aaa0e532b14aee793279c92849dcb3be8ae007bd10ac92a01699b41a35a3f2eebabcc7a7a86ea3286100452345ff2c8f69dc2aad10a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82aeb4c3f12e1e16fde6ac3555b8fb046aacf86273213775a7b399b81ffa9c927abf32356e1b677197a52210feb59935a38db15d1a32bb14982062b71c969385"} build_url:https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011159 build_url: 'https://queue.taskcluster.net/v1/task/WgS66y_tTr6ue1A2l7f6jA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9742a092c61c303e27e61632d5b02817cefd7371c8b344184fffb751dbff227364d5a62190a8b32c796aa463f25c0dadf72a81392054d7428f690bcc2ff89ec7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9136241a6fa49db67df3aaa0e532b14aee793279c92849dcb3be8ae007bd10ac92a01699b41a35a3f2eebabcc7a7a86ea3286100452345ff2c8f69dc2aad10a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82aeb4c3f12e1e16fde6ac3555b8fb046aacf86273213775a7b399b81ffa9c927abf32356e1b677197a52210feb59935a38db15d1a32bb14982062b71c969385"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 07:56:01.589418) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 07:56:01.589754) ========= 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.9ADDzah3LA/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.3vM1IRqVmS/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005051 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 07:56:01.639625) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 07:56:01.640008) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 07:56:01.640379) ========= ========= Total master_lag: 0.19 =========