builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0375 starttime: 1476897535.26 results: success (0) buildid: 20161019080323 builduid: 7c2ee5f38a8a4c9da62a1654f4e4a780 revision: f40960c63bfac865d510ec9da42eeed74c384082 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 10:18:55.257674) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 10:18:55.258106) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 10:18:55.258394) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 10:18:55.283059) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 10:18:55.283462) ========= 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.O9GSSJmgj2/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.xRqgtwytot/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-19 10:18:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 194M=0s 2016-10-19 10:18:55 (194 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121719 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 10:18:55.428148) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 10:18:55.428534) ========= 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.O9GSSJmgj2/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.xRqgtwytot/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.028918 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 10:18:55.479070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 10:18:55.479564) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f40960c63bfac865d510ec9da42eeed74c384082 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f40960c63bfac865d510ec9da42eeed74c384082 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O9GSSJmgj2/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.xRqgtwytot/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-19 10:18:55,562 truncating revision to first 12 chars 2016-10-19 10:18:55,562 Setting DEBUG logging. 2016-10-19 10:18:55,563 attempt 1/10 2016-10-19 10:18:55,563 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f40960c63bfa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 10:18:57,248 unpacking tar archive at: mozilla-central-f40960c63bfa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.942055 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 10:18:57.444013) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 10:18:57.444327) ========= script_repo_revision: f40960c63bfac865d510ec9da42eeed74c384082 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 10:18:57.444699) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 10:18:57.444956) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 10:18:57.463254) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-19 10:18:57.463696) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O9GSSJmgj2/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.xRqgtwytot/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 10:18:57 INFO - MultiFileLogger online at 20161019 10:18:57 in /builds/slave/test 10:18:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:18:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:18:57 INFO - {'append_to_log': False, 10:18:57 INFO - 'base_work_dir': '/builds/slave/test', 10:18:57 INFO - 'blob_upload_branch': 'Firefox', 10:18:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:18:57 INFO - 'branch': 'Firefox', 10:18:57 INFO - 'buildbot_json_path': 'buildprops.json', 10:18:57 INFO - 'config_files': ('talos/mac_config.py',), 10:18:57 INFO - 'default_actions': ('clobber', 10:18:57 INFO - 'read-buildbot-config', 10:18:57 INFO - 'download-and-extract', 10:18:57 INFO - 'populate-webroot', 10:18:57 INFO - 'create-virtualenv', 10:18:57 INFO - 'install', 10:18:57 INFO - 'run-tests'), 10:18:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:18:57 INFO - 'download_minidump_stackwalk': True, 10:18:57 INFO - 'download_symbols': 'ondemand', 10:18:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:18:57 INFO - 'tooltool.py': '/tools/tooltool.py', 10:18:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:18:57 INFO - '/tools/misc-python/virtualenv.py')}, 10:18:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:18:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:18:57 INFO - 'installer_path': 'installer.exe', 10:18:57 INFO - 'log_level': 'info', 10:18:57 INFO - 'log_name': 'talos', 10:18:57 INFO - 'log_to_console': True, 10:18:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:18:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:18:57 INFO - 'opt_config_files': (), 10:18:57 INFO - 'pip_index': False, 10:18:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:18:57 INFO - 'cmd': ('bash', 10:18:57 INFO - '-c', 10:18:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:18:57 INFO - 'enabled': True, 10:18:57 INFO - 'halt_on_failure': False, 10:18:57 INFO - 'name': 'check_screen_resolution'},), 10:18:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:18:57 INFO - 'cmd': ('bash', 10:18:57 INFO - '-c', 10:18:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:18:57 INFO - 'enabled': True, 10:18:57 INFO - 'halt_on_failure': False, 10:18:57 INFO - 'name': 'check_screen_resolution'},), 10:18:57 INFO - 'run_cmd_checks_enabled': True, 10:18:57 INFO - 'sps_profile': False, 10:18:57 INFO - 'sps_profile_interval': 0, 10:18:57 INFO - 'suite': 'dromaeojs-e10s', 10:18:57 INFO - 'system_bits': '32', 10:18:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:18:57 INFO - 'title': 't-yosemite-r7-0375', 10:18:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:18:57 INFO - 'use_talos_json': True, 10:18:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:18:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:18:57 INFO - 'work_dir': 'build'} 10:18:57 INFO - [mozharness: 2016-10-19 17:18:57.663998Z] Running clobber step. 10:18:57 INFO - Running pre-action listener: _resource_record_pre_action 10:18:57 INFO - Running main action method: clobber 10:18:57 INFO - rmtree: /builds/slave/test/build 10:18:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:19:00 INFO - Running post-action listener: _resource_record_post_action 10:19:00 INFO - [mozharness: 2016-10-19 17:19:00.209939Z] Finished clobber step (success) 10:19:00 INFO - [mozharness: 2016-10-19 17:19:00.210173Z] Running read-buildbot-config step. 10:19:00 INFO - Running pre-action listener: _resource_record_pre_action 10:19:00 INFO - Running main action method: read_buildbot_config 10:19:00 INFO - Using buildbot properties: 10:19:00 INFO - { 10:19:00 INFO - "project": "", 10:19:00 INFO - "product": "firefox", 10:19:00 INFO - "script_repo_revision": "production", 10:19:00 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:19:00 INFO - "repository": "", 10:19:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:19:00 INFO - "buildid": "20161019080323", 10:19:00 INFO - "pgo_build": "False", 10:19:00 INFO - "basedir": "/builds/slave/test", 10:19:00 INFO - "buildnumber": 312, 10:19:00 INFO - "slavename": "t-yosemite-r7-0375", 10:19:00 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:19:00 INFO - "platform": "yosemite_r7", 10:19:00 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:19:00 INFO - "branch": "mozilla-central", 10:19:00 INFO - "repo_path": "mozilla-central", 10:19:00 INFO - "revision": "f40960c63bfac865d510ec9da42eeed74c384082", 10:19:00 INFO - "stage_platform": "macosx64", 10:19:00 INFO - "builduid": "7c2ee5f38a8a4c9da62a1654f4e4a780", 10:19:00 INFO - "slavebuilddir": "test" 10:19:00 INFO - } 10:19:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 10:19:00 INFO - Running post-action listener: _resource_record_post_action 10:19:00 INFO - [mozharness: 2016-10-19 17:19:00.216017Z] Finished read-buildbot-config step (success) 10:19:00 INFO - [mozharness: 2016-10-19 17:19:00.216239Z] Running download-and-extract step. 10:19:00 INFO - Running pre-action listener: _resource_record_pre_action 10:19:00 INFO - Running main action method: download_and_extract 10:19:00 INFO - mkdir: /builds/slave/test/build/tests 10:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:00 INFO - trying https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 10:19:00 INFO - Downloading https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:19:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 10:19:01 INFO - Downloaded 1199 bytes. 10:19:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:19:01 INFO - Using the following test package requirements: 10:19:01 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:19:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:19:01 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 10:19:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:19:01 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 10:19:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:19:01 INFO - u'jsshell-mac.zip'], 10:19:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:19:01 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 10:19:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:19:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:19:01 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 10:19:01 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:19:01 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 10:19:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:19:01 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 10:19:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:19:01 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 10:19:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:19:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:19:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:19:01 INFO - Fetch https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:19:02 INFO - Http code: 200 10:19:02 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 10:19:02 INFO - x-amz-cf-id: qgA60NDB7CAeO8F5v1s2Q64xX_EFGQO6fEL5leY_48p-ca6vNBvKsQ== 10:19:02 INFO - x-amz-version-id: ALcYBRvEns3Ms6AUKWXTahQU9GLJMXMk 10:19:02 INFO - Expected file size: 16501194 10:19:02 INFO - Obtained file size: 16501194 10:19:09 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:19:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:19:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:19:09 INFO - Fetch https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:19:09 INFO - Http code: 200 10:19:09 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 10:19:09 INFO - x-amz-cf-id: XCKyiSgcoET5nkR5qVIi3Iy1bXeNSktkl6vj3SKi2GTI-11ylw5kKg== 10:19:09 INFO - x-amz-version-id: ALcYBRvEns3Ms6AUKWXTahQU9GLJMXMk 10:19:10 INFO - Expected file size: 16501194 10:19:10 INFO - Obtained file size: 16501194 10:19:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 10:19:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:19:16 INFO - Fetch https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 10:19:17 INFO - Http code: 200 10:19:17 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 10:19:17 INFO - x-amz-cf-id: bybKvB0W8e3Qa0AeLbwuGACqK-8q-duaeGesdivTd1RY3HOTNOFW9Q== 10:19:17 INFO - x-amz-version-id: Rgiascjtbd50vSAz4Y7LeAdeGfp1G0Jg 10:19:17 INFO - Expected file size: 14409028 10:19:17 INFO - Obtained file size: 14409028 10:19: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')]} 10:19:18 INFO - trying https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:19:18 INFO - Downloading https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 10:19:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 10:19:20 INFO - Downloaded 111623746 bytes. 10:19:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:19:20 INFO - mkdir: /builds/slave/test/properties 10:19:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:19:20 INFO - Writing to file /builds/slave/test/properties/build_url 10:19:20 INFO - Contents: 10:19:20 INFO - build_url:https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:19:21 INFO - Running post-action listener: _resource_record_post_action 10:19:21 INFO - Running post-action listener: set_extra_try_arguments 10:19:21 INFO - [mozharness: 2016-10-19 17:19:21.541434Z] Finished download-and-extract step (success) 10:19:21 INFO - [mozharness: 2016-10-19 17:19:21.541585Z] Running populate-webroot step. 10:19:21 INFO - Running pre-action listener: _resource_record_pre_action 10:19:21 INFO - Running main action method: populate_webroot 10:19:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:19:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:19:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:19:21 INFO - '--tppagecycles', 10:19:21 INFO - '7'], 10:19:21 INFO - 'tests': ['tsvgm']}}, 10:19:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:19:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:19:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:19:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:19:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:19:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:19:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:21 INFO - 'talos_options': ['--disable-e10s'], 10:19:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:21 INFO - 'talos_options': ['--disable-e10s'], 10:19:21 INFO - 'tests': ['damp', 'tps']}, 10:19:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:21 INFO - 'tests': ['damp', 'tps']}, 10:19:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:19:21 INFO - 'tests': ['dromaeo_dom']}, 10:19:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:19:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:19:21 INFO - 'tests': ['basic_compositor_video']}, 10:19:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:19:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:19:21 INFO - 'tests': ['a11yr', 10:19:21 INFO - 'ts_paint', 10:19:21 INFO - 'tpaint', 10:19:21 INFO - 'sessionrestore', 10:19:21 INFO - 'sessionrestore_no_auto_restore', 10:19:21 INFO - 'tabpaint']}, 10:19:21 INFO - 'other-e10s': {'tests': ['a11yr', 10:19:21 INFO - 'ts_paint', 10:19:21 INFO - 'tpaint', 10:19:21 INFO - 'sessionrestore', 10:19:21 INFO - 'sessionrestore_no_auto_restore', 10:19:21 INFO - 'tabpaint']}, 10:19:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:19:21 INFO - 'ts_paint', 10:19:21 INFO - 'tpaint', 10:19:21 INFO - 'sessionrestore', 10:19:21 INFO - 'sessionrestore_no_auto_restore', 10:19:21 INFO - 'tabpaint']}, 10:19:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:19:21 INFO - 'ts_paint', 10:19:21 INFO - 'tpaint', 10:19:21 INFO - 'sessionrestore', 10:19:21 INFO - 'sessionrestore_no_auto_restore', 10:19:21 INFO - 'tabpaint']}, 10:19:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:19:21 INFO - 'tests': ['a11yr', 10:19:21 INFO - 'ts_paint', 10:19:21 INFO - 'tpaint', 10:19:21 INFO - 'sessionrestore', 10:19:21 INFO - 'sessionrestore_no_auto_restore', 10:19:21 INFO - 'tabpaint']}, 10:19:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:19:21 INFO - 'tests': ['a11yr', 10:19:21 INFO - 'ts_paint', 10:19:21 INFO - 'tpaint', 10:19:21 INFO - 'sessionrestore', 10:19:21 INFO - 'sessionrestore_no_auto_restore', 10:19:21 INFO - 'tabpaint']}, 10:19:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:19:21 INFO - 'tests': ['tsvgx', 10:19:21 INFO - 'tsvgr_opacity', 10:19:21 INFO - 'tart', 10:19:21 INFO - 'tscrollx', 10:19:21 INFO - 'cart']}, 10:19:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:19:21 INFO - 'tsvgr_opacity', 10:19:21 INFO - 'tart', 10:19:21 INFO - 'tscrollx', 10:19:21 INFO - 'cart']}, 10:19:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:21 INFO - 'talos_options': ['--disable-e10s'], 10:19:21 INFO - 'tests': ['tp5o']}, 10:19:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:21 INFO - 'tests': ['tp5o']}, 10:19:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:21 INFO - 'talos_options': ['--disable-e10s', 10:19:21 INFO - '--xperf_path', 10:19:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:21 INFO - 'tests': ['tp5n']}, 10:19:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:21 INFO - 'talos_options': ['--xperf_path', 10:19:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:21 INFO - 'tests': ['tp5n']}}, 10:19:21 INFO - 'talos.zip': {'path': '', 10:19:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:19:21 INFO - Running post-action listener: _resource_record_post_action 10:19:21 INFO - [mozharness: 2016-10-19 17:19:21.560471Z] Finished populate-webroot step (success) 10:19:21 INFO - [mozharness: 2016-10-19 17:19:21.560599Z] Running create-virtualenv step. 10:19:21 INFO - Running pre-action listener: _resource_record_pre_action 10:19:21 INFO - Running main action method: create_virtualenv 10:19:21 INFO - Creating virtualenv /builds/slave/test/build/venv 10:19:21 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 10:19:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:19:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:19:21 INFO - Using real prefix '/tools/python27' 10:19:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:19:22 INFO - Installing distribute.............................................................................................................................................................................................done. 10:19:25 INFO - Installing pip.................done. 10:19:25 INFO - Return code: 0 10:19:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:19:25 INFO - Reading from file tmpfile_stdout 10:19:25 INFO - Output received: 10:19:25 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) 10:19:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100bff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c0cd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a13d30>, '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 0x100839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a0bb20>, '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.O9GSSJmgj2/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.xRqgtwytot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 10:19: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', 'pip>=1.5'] in /builds/slave/test/build 10:19: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 pip>=1.5 10:19:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9GSSJmgj2/Render', 10:19:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:25 INFO - 'HOME': '/Users/cltbld', 10:19:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:25 INFO - 'LOGNAME': 'cltbld', 10:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:25 INFO - 'MOZ_NO_REMOTE': '1', 10:19:25 INFO - 'NO_EM_RESTART': '1', 10:19:25 INFO - 'PAGER': '/bin/cat', 10:19:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:25 INFO - 'PWD': '/builds/slave/test', 10:19:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:25 INFO - 'SHELL': '/bin/bash', 10:19:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRqgtwytot/Listeners', 10:19:25 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 10:19:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:25 INFO - 'USER': 'cltbld', 10:19:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:25 INFO - 'XPC_FLAGS': '0x0', 10:19:25 INFO - 'XPC_SERVICE_NAME': '0', 10:19:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:25 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 10:19:25 INFO - Cleaning up... 10:19:25 INFO - Return code: 0 10:19:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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', '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 0x100bff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c0cd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a13d30>, '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 0x100839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a0bb20>, '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.O9GSSJmgj2/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.xRqgtwytot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 10:19: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', 'psutil>=3.1.1'] in /builds/slave/test/build 10:19: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 psutil>=3.1.1 10:19:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9GSSJmgj2/Render', 10:19:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:25 INFO - 'HOME': '/Users/cltbld', 10:19:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:25 INFO - 'LOGNAME': 'cltbld', 10:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:25 INFO - 'MOZ_NO_REMOTE': '1', 10:19:25 INFO - 'NO_EM_RESTART': '1', 10:19:25 INFO - 'PAGER': '/bin/cat', 10:19:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:25 INFO - 'PWD': '/builds/slave/test', 10:19:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:25 INFO - 'SHELL': '/bin/bash', 10:19:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRqgtwytot/Listeners', 10:19:25 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 10:19:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:25 INFO - 'USER': 'cltbld', 10:19:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:25 INFO - 'XPC_FLAGS': '0x0', 10:19:25 INFO - 'XPC_SERVICE_NAME': '0', 10:19:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:26 INFO - Downloading/unpacking psutil>=3.1.1 10:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:19:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:29 INFO - Installing collected packages: psutil 10:19:29 INFO - Running setup.py install for psutil 10:19:29 INFO - building 'psutil._psutil_osx' extension 10:19:29 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 10:19:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:19:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:19:30 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 10:19:30 INFO - building 'psutil._psutil_posix' extension 10:19:30 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 10:19:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:19:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:19:30 INFO - ^ 10:19:30 INFO - 1 warning generated. 10:19:30 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 10:19:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:30 INFO - Successfully installed psutil 10:19:30 INFO - Cleaning up... 10:19:30 INFO - Return code: 0 10:19:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:19:30 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')]} 10:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:30 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')]} 10:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:30 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 0x100bff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c0cd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a13d30>, '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 0x100839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a0bb20>, '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.O9GSSJmgj2/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.xRqgtwytot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 10:19:30 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 10:19:30 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 10:19:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9GSSJmgj2/Render', 10:19:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:30 INFO - 'HOME': '/Users/cltbld', 10:19:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:30 INFO - 'LOGNAME': 'cltbld', 10:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:30 INFO - 'MOZ_NO_REMOTE': '1', 10:19:30 INFO - 'NO_EM_RESTART': '1', 10:19:30 INFO - 'PAGER': '/bin/cat', 10:19:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:30 INFO - 'PWD': '/builds/slave/test', 10:19:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:30 INFO - 'SHELL': '/bin/bash', 10:19:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRqgtwytot/Listeners', 10:19:30 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 10:19:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:30 INFO - 'USER': 'cltbld', 10:19:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:30 INFO - 'XPC_FLAGS': '0x0', 10:19:30 INFO - 'XPC_SERVICE_NAME': '0', 10:19:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:19:30 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 10:19:30 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 10:19:30 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 10:19:30 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 10:19:30 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 10:19:30 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 10:19:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:19:33 INFO - Installing collected packages: mozsystemmonitor 10:19:33 INFO - Running setup.py install for mozsystemmonitor 10:19:33 INFO - Successfully installed mozsystemmonitor 10:19:33 INFO - Cleaning up... 10:19:33 INFO - Return code: 0 10:19:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100bff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c0cd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a13d30>, '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 0x100839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a0bb20>, '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.O9GSSJmgj2/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.xRqgtwytot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 10:19:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:19:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9GSSJmgj2/Render', 10:19:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:33 INFO - 'HOME': '/Users/cltbld', 10:19:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:33 INFO - 'LOGNAME': 'cltbld', 10:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:33 INFO - 'MOZ_NO_REMOTE': '1', 10:19:33 INFO - 'NO_EM_RESTART': '1', 10:19:33 INFO - 'PAGER': '/bin/cat', 10:19:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:33 INFO - 'PWD': '/builds/slave/test', 10:19:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:33 INFO - 'SHELL': '/bin/bash', 10:19:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRqgtwytot/Listeners', 10:19:33 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 10:19:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:33 INFO - 'USER': 'cltbld', 10:19:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:33 INFO - 'XPC_FLAGS': '0x0', 10:19:33 INFO - 'XPC_SERVICE_NAME': '0', 10:19:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:33 INFO - Downloading/unpacking jsonschema==2.5.1 10:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:19:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:36 INFO - Downloading functools32-3.2.3-2.tar.gz 10:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:19:36 INFO - warning: no files found matching '*.txt' 10:19:36 INFO - no previously-included directories found matching 'build' 10:19:36 INFO - no previously-included directories found matching 'dist' 10:19:36 INFO - no previously-included directories found matching '.git*' 10:19:36 INFO - Installing collected packages: jsonschema, functools32 10:19:36 INFO - Running setup.py install for functools32 10:19:36 INFO - warning: no files found matching '*.txt' 10:19:36 INFO - no previously-included directories found matching 'build' 10:19:36 INFO - no previously-included directories found matching 'dist' 10:19:36 INFO - no previously-included directories found matching '.git*' 10:19:37 INFO - Successfully installed jsonschema functools32 10:19:37 INFO - Cleaning up... 10:19:37 INFO - Return code: 0 10:19:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:37 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 0x100bff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c0cd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a13d30>, '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 0x100839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a0bb20>, '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.O9GSSJmgj2/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.xRqgtwytot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 10:19:37 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 10:19:37 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 10:19:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9GSSJmgj2/Render', 10:19:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:37 INFO - 'HOME': '/Users/cltbld', 10:19:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:37 INFO - 'LOGNAME': 'cltbld', 10:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:37 INFO - 'MOZ_NO_REMOTE': '1', 10:19:37 INFO - 'NO_EM_RESTART': '1', 10:19:37 INFO - 'PAGER': '/bin/cat', 10:19:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:37 INFO - 'PWD': '/builds/slave/test', 10:19:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:37 INFO - 'SHELL': '/bin/bash', 10:19:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRqgtwytot/Listeners', 10:19:37 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 10:19:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:37 INFO - 'USER': 'cltbld', 10:19:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:37 INFO - 'XPC_FLAGS': '0x0', 10:19:37 INFO - 'XPC_SERVICE_NAME': '0', 10:19:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:19:37 INFO - Cleaning up... 10:19:37 INFO - Return code: 0 10:19:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:37 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 0x100bff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c0cd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a13d30>, '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 0x100839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a0bb20>, '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.O9GSSJmgj2/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.xRqgtwytot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 10:19:37 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 10:19:37 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 10:19:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9GSSJmgj2/Render', 10:19:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:37 INFO - 'HOME': '/Users/cltbld', 10:19:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:37 INFO - 'LOGNAME': 'cltbld', 10:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:37 INFO - 'MOZ_NO_REMOTE': '1', 10:19:37 INFO - 'NO_EM_RESTART': '1', 10:19:37 INFO - 'PAGER': '/bin/cat', 10:19:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:37 INFO - 'PWD': '/builds/slave/test', 10:19:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:37 INFO - 'SHELL': '/bin/bash', 10:19:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRqgtwytot/Listeners', 10:19:37 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 10:19:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:37 INFO - 'USER': 'cltbld', 10:19:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:37 INFO - 'XPC_FLAGS': '0x0', 10:19:37 INFO - 'XPC_SERVICE_NAME': '0', 10:19:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:37 INFO - Downloading/unpacking blobuploader==1.2.4 10:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:40 INFO - Downloading blobuploader-1.2.4.tar.gz 10:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:19:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:19:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:41 INFO - Downloading docopt-0.6.1.tar.gz 10:19:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:19:41 INFO - Installing collected packages: blobuploader, requests, docopt 10:19:41 INFO - Running setup.py install for blobuploader 10:19:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:19:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:19:41 INFO - Running setup.py install for requests 10:19:42 INFO - Running setup.py install for docopt 10:19:42 INFO - Successfully installed blobuploader requests docopt 10:19:42 INFO - Cleaning up... 10:19:42 INFO - Return code: 0 10:19:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:42 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 0x100bff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c0cd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a13d30>, '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 0x100839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a0bb20>, '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.O9GSSJmgj2/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.xRqgtwytot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 10:19:42 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 10:19:42 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 10:19:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9GSSJmgj2/Render', 10:19:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:42 INFO - 'HOME': '/Users/cltbld', 10:19:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:42 INFO - 'LOGNAME': 'cltbld', 10:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:42 INFO - 'MOZ_NO_REMOTE': '1', 10:19:42 INFO - 'NO_EM_RESTART': '1', 10:19:42 INFO - 'PAGER': '/bin/cat', 10:19:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:42 INFO - 'PWD': '/builds/slave/test', 10:19:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:42 INFO - 'SHELL': '/bin/bash', 10:19:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRqgtwytot/Listeners', 10:19:42 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 10:19:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:42 INFO - 'USER': 'cltbld', 10:19:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:42 INFO - 'XPC_FLAGS': '0x0', 10:19:42 INFO - 'XPC_SERVICE_NAME': '0', 10:19:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-MjEIUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-4avpbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-LOW0k0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-5gHqKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-FiDf5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-4U3dAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-khgErq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-CVYWWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-8zmRlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-V5Q3Ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-_oBpGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-INm_SH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-jBHe7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:44 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-OZnzQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:44 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-qUwI7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:44 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-0Y8Mc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:44 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-i1HFAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:19:44 INFO - Running setup.py install for manifestparser 10:19:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:19:44 INFO - Running setup.py install for mozcrash 10:19:44 INFO - Running setup.py install for mozdebug 10:19:44 INFO - Running setup.py install for mozdevice 10:19:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:19:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:19:45 INFO - Running setup.py install for mozfile 10:19:45 INFO - Running setup.py install for mozhttpd 10:19:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:19:45 INFO - Running setup.py install for mozinfo 10:19:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:19:45 INFO - Running setup.py install for mozInstall 10:19:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:19:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:19:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:19:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:19:45 INFO - Running setup.py install for mozleak 10:19:45 INFO - Running setup.py install for mozlog 10:19:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:19:45 INFO - Running setup.py install for moznetwork 10:19:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:19:46 INFO - Running setup.py install for mozprocess 10:19:46 INFO - Running setup.py install for mozprofile 10:19:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:19:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:19:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:19:46 INFO - Running setup.py install for mozrunner 10:19:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:19:46 INFO - Running setup.py install for mozscreenshot 10:19:46 INFO - Running setup.py install for moztest 10:19:46 INFO - Running setup.py install for mozversion 10:19:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:19:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:19:46 INFO - Cleaning up... 10:19:46 INFO - Return code: 0 10:19:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:46 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')]} 10:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:47 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')]} 10:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:47 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 0x100bff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c0cd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a13d30>, '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 0x100839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a0bb20>, '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.O9GSSJmgj2/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.xRqgtwytot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 10:19:47 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 10:19:47 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 10:19:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9GSSJmgj2/Render', 10:19:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:47 INFO - 'HOME': '/Users/cltbld', 10:19:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:47 INFO - 'LOGNAME': 'cltbld', 10:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:47 INFO - 'MOZ_NO_REMOTE': '1', 10:19:47 INFO - 'NO_EM_RESTART': '1', 10:19:47 INFO - 'PAGER': '/bin/cat', 10:19:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:47 INFO - 'PWD': '/builds/slave/test', 10:19:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:47 INFO - 'SHELL': '/bin/bash', 10:19:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRqgtwytot/Listeners', 10:19:47 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 10:19:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:47 INFO - 'USER': 'cltbld', 10:19:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:47 INFO - 'XPC_FLAGS': '0x0', 10:19:47 INFO - 'XPC_SERVICE_NAME': '0', 10:19:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-iCKWfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:47 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)) 10:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-pnRNTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-gb4SCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:47 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)) 10:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-0mixC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:47 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)) 10:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-O1cvcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:47 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)) 10:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-bzbMBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:47 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)) 10:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:47 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-ZXknmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:48 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)) 10:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-dbDdP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:48 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)) 10:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-z5f6Op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:48 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)) 10:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-9MYbuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:48 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)) 10:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-oKxfpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:48 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)) 10:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-SCvHMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:48 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)) 10:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-tLJj3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:48 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)) 10:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-1ia9Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-UwP2BR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:48 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)) 10:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-dl6e1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:48 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)) 10:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-d20ff_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:49 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)) 10:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:19:49 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)) 10:19:49 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)) 10:19:49 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)) 10:19:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:51 INFO - Downloading blessings-1.6.tar.gz 10:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:19:51 INFO - Installing collected packages: blessings 10:19:51 INFO - Running setup.py install for blessings 10:19:51 INFO - Successfully installed blessings 10:19:51 INFO - Cleaning up... 10:19:52 INFO - Return code: 0 10:19:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:19:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:19:52 INFO - Reading from file tmpfile_stdout 10:19:52 INFO - Current package versions: 10:19:52 INFO - blessings == 1.6 10:19:52 INFO - blobuploader == 1.2.4 10:19:52 INFO - docopt == 0.6.1 10:19:52 INFO - functools32 == 3.2.3-2 10:19:52 INFO - jsonschema == 2.5.1 10:19:52 INFO - manifestparser == 1.1 10:19:52 INFO - mozInstall == 1.12 10:19:52 INFO - mozcrash == 0.17 10:19:52 INFO - mozdebug == 0.1 10:19:52 INFO - mozdevice == 0.48 10:19:52 INFO - mozfile == 1.2 10:19:52 INFO - mozhttpd == 0.7 10:19:52 INFO - mozinfo == 0.9 10:19:52 INFO - mozleak == 0.1 10:19:52 INFO - mozlog == 3.4 10:19:52 INFO - moznetwork == 0.27 10:19:52 INFO - mozprocess == 0.23 10:19:52 INFO - mozprofile == 0.28 10:19:52 INFO - mozrunner == 6.12 10:19:52 INFO - mozscreenshot == 0.1 10:19:52 INFO - mozsystemmonitor == 0.3 10:19:52 INFO - moztest == 0.7 10:19:52 INFO - mozversion == 1.4 10:19:52 INFO - psutil == 3.1.1 10:19:52 INFO - requests == 1.2.3 10:19:52 INFO - wsgiref == 0.1.2 10:19:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:52 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')]} 10:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:52 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')]} 10:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:52 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 0x100bff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c0cd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a13d30>, '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 0x100839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a0bb20>, '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.O9GSSJmgj2/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.xRqgtwytot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 10:19:52 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 10:19:52 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 10:19:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9GSSJmgj2/Render', 10:19:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:52 INFO - 'HOME': '/Users/cltbld', 10:19:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:52 INFO - 'LOGNAME': 'cltbld', 10:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:52 INFO - 'MOZ_NO_REMOTE': '1', 10:19:52 INFO - 'NO_EM_RESTART': '1', 10:19:52 INFO - 'PAGER': '/bin/cat', 10:19:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:52 INFO - 'PWD': '/builds/slave/test', 10:19:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:52 INFO - 'SHELL': '/bin/bash', 10:19:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRqgtwytot/Listeners', 10:19:52 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 10:19:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:52 INFO - 'USER': 'cltbld', 10:19:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:52 INFO - 'XPC_FLAGS': '0x0', 10:19:52 INFO - 'XPC_SERVICE_NAME': '0', 10:19:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:52 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)) 10:19:52 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)) 10:19:52 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)) 10:19:52 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)) 10:19:52 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)) 10:19:52 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)) 10:19:52 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)) 10:19:52 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)) 10:19:52 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)) 10:19:52 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)) 10:19:52 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)) 10:19:52 INFO - Cleaning up... 10:19:53 INFO - Return code: 0 10:19:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100bff490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b75570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2c0cd6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a13d30>, '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 0x100839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a0bb20>, '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.O9GSSJmgj2/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.xRqgtwytot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 10:19:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:19:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9GSSJmgj2/Render', 10:19:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:53 INFO - 'HOME': '/Users/cltbld', 10:19:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:53 INFO - 'LOGNAME': 'cltbld', 10:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:53 INFO - 'MOZ_NO_REMOTE': '1', 10:19:53 INFO - 'NO_EM_RESTART': '1', 10:19:53 INFO - 'PAGER': '/bin/cat', 10:19:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:53 INFO - 'PWD': '/builds/slave/test', 10:19:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:53 INFO - 'SHELL': '/bin/bash', 10:19:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRqgtwytot/Listeners', 10:19:53 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 10:19:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:53 INFO - 'USER': 'cltbld', 10:19:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:53 INFO - 'XPC_FLAGS': '0x0', 10:19:53 INFO - 'XPC_SERVICE_NAME': '0', 10:19:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:19:53 INFO - Cleaning up... 10:19:53 INFO - Return code: 0 10:19:53 INFO - Running post-action listener: _resource_record_post_action 10:19:53 INFO - Running post-action listener: _start_resource_monitoring 10:19:53 INFO - Starting resource monitoring. 10:19:53 INFO - [mozharness: 2016-10-19 17:19:53.710439Z] Finished create-virtualenv step (success) 10:19:53 INFO - [mozharness: 2016-10-19 17:19:53.711397Z] Running install step. 10:19:53 INFO - Running pre-action listener: _resource_record_pre_action 10:19:53 INFO - Running main action method: install 10:19:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:19:53 INFO - Reading from file tmpfile_stdout 10:19:53 INFO - Detecting whether we're running mozinstall >=1.0... 10:19:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:19:54 INFO - Reading from file tmpfile_stdout 10:19:54 INFO - Output received: 10:19:54 INFO - Usage: mozinstall [options] installer 10:19:54 INFO - Options: 10:19:54 INFO - -h, --help show this help message and exit 10:19:54 INFO - -d DEST, --destination=DEST 10:19:54 INFO - Directory to install application into. [default: 10:19:54 INFO - "/builds/slave/test"] 10:19:54 INFO - --app=APP Application being installed. [default: firefox] 10:19:54 INFO - mkdir: /builds/slave/test/build/application 10:19:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:20:28 INFO - Reading from file tmpfile_stdout 10:20:28 INFO - Output received: 10:20:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:20:28 INFO - Running post-action listener: _resource_record_post_action 10:20:28 INFO - [mozharness: 2016-10-19 17:20:28.277918Z] Finished install step (success) 10:20:28 INFO - [mozharness: 2016-10-19 17:20:28.278048Z] Running run-tests step. 10:20:28 INFO - Running pre-action listener: _resource_record_pre_action 10:20:28 INFO - Running main action method: run_tests 10:20:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:20:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:20:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:20:28 INFO - 2016-10-19 10:20:28.292 screenresolution[1646:7777] starting screenresolution argv=screenresolution get 10:20:28 INFO - 2016-10-19 10:20:28.295 screenresolution[1646:7777] Display 0: 1600x1200x32@60 10:20:28 INFO - 2016-10-19 10:20:28.301 screenresolution[1647:7779] starting screenresolution argv=screenresolution list 10:20:28 INFO - Available Modes on Display 0 10:20:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:20:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:20:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:20:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:20:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:20:28 INFO - Intel Iris: 10:20:28 INFO - Chipset Model: Intel Iris 10:20:28 INFO - Type: GPU 10:20:28 INFO - Bus: Built-In 10:20:28 INFO - VRAM (Dynamic, Max): 1536 MB 10:20:28 INFO - Vendor: Intel (0x8086) 10:20:28 INFO - Device ID: 0x0a2e 10:20:28 INFO - Revision ID: 0x0009 10:20:28 INFO - Displays: 10:20:28 INFO - Display: 10:20:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:20:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:20:28 INFO - Display Serial Number: 1600x1200 60 10:20:28 INFO - Main Display: Yes 10:20:28 INFO - Mirror: Off 10:20:28 INFO - Online: Yes 10:20:28 INFO - Rotation: Supported 10:20:28 INFO - Return code: 0 10:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:20:28 INFO - Python 2.7.3 10:20:28 INFO - Return code: 0 10:20:28 INFO - grabbing minidump binary from tooltool 10:20: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')]} 10:20:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a13d30>, '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 0x100839db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a0bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:20:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:20:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:20:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:20:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:20:28 INFO - Return code: 0 10:20:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:20:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:20:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:20:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:20:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--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 10:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0375 --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 10:20:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9GSSJmgj2/Render', 10:20:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:20:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:20:28 INFO - 'HOME': '/Users/cltbld', 10:20:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:20:28 INFO - 'LOGNAME': 'cltbld', 10:20:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:20:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:28 INFO - 'MOZ_NO_REMOTE': '1', 10:20:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:20:28 INFO - 'NO_EM_RESTART': '1', 10:20:28 INFO - 'PAGER': '/bin/cat', 10:20:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:28 INFO - 'PWD': '/builds/slave/test', 10:20:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:20:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:20:28 INFO - 'SHELL': '/bin/bash', 10:20:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRqgtwytot/Listeners', 10:20:28 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 10:20:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:20:28 INFO - 'USER': 'cltbld', 10:20:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:20:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:28 INFO - 'XPC_FLAGS': '0x0', 10:20:28 INFO - 'XPC_SERVICE_NAME': '0', 10:20:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:20:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--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 10:20:28 INFO - mozversion application_buildid: 20161019080323 10:20:28 INFO - mozversion application_changeset: f40960c63bfac865d510ec9da42eeed74c384082 10:20:28 INFO - mozversion application_display_name: Nightly 10:20:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:20:28 INFO - mozversion application_name: Firefox 10:20:28 INFO - mozversion application_remotingname: firefox 10:20:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:20:28 INFO - mozversion application_vendor: Mozilla 10:20:28 INFO - mozversion application_version: 52.0a1 10:20:28 INFO - mozversion platform_buildid: 20161019080323 10:20:28 INFO - mozversion platform_changeset: f40960c63bfac865d510ec9da42eeed74c384082 10:20:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:20:28 INFO - mozversion platform_version: 52.0a1 10:20:28 INFO - using testdate: 1476897628 10:20:28 INFO - actual date: 1476897628 10:20:28 INFO - starting webserver on 'localhost:49272' 10:20:28 INFO - SUITE-START | Running 2 tests 10:20:28 INFO - TEST-START | dromaeo_css 10:20:28 INFO - operating with platform_type : mac_ 10:20:28 INFO - Initialising browser for dromaeo_css test... 10:20:28 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmp8MqFKq/profile http://localhost:49272/getInfo.html) 10:20:31 INFO - PROCESS | 1657 | 2016-10-19 10:20:31.799 plugin-container[1659:7935] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 10:20:31 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:20:31 INFO - PROCESS | 1657 | 2016-10-19 10:20:31.801 plugin-container[1659:7935] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9303, name = 'com.apple.CFPasteboardClient' 10:20:31 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:20:31 INFO - PROCESS | 1657 | 2016-10-19 10:20:31.802 plugin-container[1659:7935] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:20:31 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 10:20:31 INFO - PROCESS | 1657 | colorDepth:24 10:20:31 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 10:20:31 INFO - PROCESS | 1657 | __metrics 10:20:32 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 10:20:32 INFO - TEST-INFO | 1657: exit 0 10:20:32 INFO - Browser initialized. 10:20:32 INFO - Running cycle 1/1 for dromaeo_css test... 10:20:32 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmp8MqFKq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:35 INFO - PROCESS | 1660 | 2016-10-19 10:20:35.462 plugin-container[1661:8057] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 10:20:35 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:20:35 INFO - PROCESS | 1660 | 2016-10-19 10:20:35.463 plugin-container[1661:8057] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 10:20:35 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:20:35 INFO - PROCESS | 1660 | 2016-10-19 10:20:35.463 plugin-container[1661:8057] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:20:45 INFO - PROCESS | 1660 | RSS: Main: 236896256 10:20:45 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | 1476897694816 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] 10:23:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 10:23:49 INFO - PROCESS | 1660 | RSS: Main: 252174336 10:23:49 INFO - PROCESS | 1660 | 10:26:51 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 10:26:52 INFO - PROCESS | 1660 | RSS: Main: 263737344 10:26:52 INFO - PROCESS | 1660 | 10:29:54 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 10:29:55 INFO - PROCESS | 1660 | RSS: Main: 268132352 10:29:55 INFO - PROCESS | 1660 | 10:32:57 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 10:32:57 INFO - PROCESS | 1660 | RSS: Main: 267853824 10:32:57 INFO - PROCESS | 1660 | 10:36:00 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 10:36:01 INFO - PROCESS | 1660 | RSS: Main: 274182144 10:36:01 INFO - PROCESS | 1660 | 10:39:04 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 10:39:04 INFO - PROCESS | 1660 | RSS: Main: 276803584 10:39:04 INFO - PROCESS | 1660 | 10:39:04 INFO - PROCESS | 1660 | __start_tp_report 10:39:04 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 10:39:04 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 10:39:04 INFO - PROCESS | 1660 | |i|pagename|runs| 10:39:04 INFO - PROCESS | 1660 | |0;dojo.html;2845.331347133423;3353.664633536645;3377.3920694275034;3417.521546983421;3441.8107004114763;5610.859728506789;5691.317041954966;5698.51562617177;5725.942740572593;5765.3369862465825;5404.297441332631;5635.042042852715;5721.5994880358285;5804.564657650682;5804.82585522434;5150.04724126036;5186.948130518703;5237.921431178535;5316.3620365556;5332;4806.663533552653;4982.2526621006955;5315.867103322409;5328.8401347959425;5353.52777986055;5141.691498510101;5203.16749320107;5267.446918073585;5289.86775330616;5334.359876814788;3870.3613903705855;5155.66488178271;5184.688918664892;5283.154695248781;5317.760700768475;4932.654714170009;5177.818776342848;5185.481451854822;5226.242194881721;5243.056249875021;4816.903661926777;5583.246261754693;5616.073347897592;5835.212246346774;5839.678817665027;6105.126180223406;6135.263768347782;6178.196834411498;6188;6255.280642726099;5509.118541033416;6216.2851272103835;6237.96881015592;6241.78153764616;6242.438180563771;4758.690685105457;5848.824535263949;5853.94146058534;5856.912146317809;5870;6147.72335244915;6172.783952561639;6198.6280823150755;6248.75004999804;6263.279722831841;5143.7685304161405;6109.725062372204;6163.907541386883;6166.660833654102;6172.259328880473;6176.536759743038;6231.657258850807;6238.625682459067;6252.531060170505;6258.937410625836;5061.721605311744;6084.665343406066;6099.461111717566;6148.231471066117;6192.504599632019;6144.880016394337;6168.845778855564;6224;6229.906551401733;6237.906431403532;4938;4945.826896058693;4961.70229786214;4968.8509344719;4978.701277923336;4342.82628694855;4378.190034843564;4457.531959144308;4463.776811159429;4472.642188624902;5728.742206600713;5791.420857914175;5867.237259156283;5884.293884733859;5989.610675306179;6203.7828675996125;6227.314995350508;6234.314225435199;6241.656708880964;6253.906191407133;5522.779088836482;5937.198478205387;5937.910931336033;5955.166276721263;5991.730372133265;4774.498677638868;5000.1249781288125;5434.10337294342;5446.101393270145;5454.236406903036;6378.330275321025;6410.038494225903;6426.325235850262;6429.839254018687;6433.292337842927;6256.687165641609;6256.781012664717;6262.906056409066;6277.654728989949;6280.905786413116;5485.807996720096;5981.1327357532045;6101.03536932808;6303.086052522267;6424.967875160594;5165.793368265227;6183.876322473615;6208.441240288215;6210.347913469021;6218.502519798315;5128.923066154085;5184.833412482161;6189.876202476015;6208.00671892495;6229.3770622937345;5081.72050537224;6022.8857661332795;6122.204113465221;6139.171211886517;6158.137860699416;4833.419989601271;5819.447152520504;6123.343628574205;6183.84540386494;6198.907016394848;4797.56821886032;5962.37395073511;6031.185789918305;6060.39396060408;6085.300190478151;4853.781579828987;6097.1314910987585;6098.644029114022;6133.854967165127;6198.256209254918;5994.940050599613;6037.305709843425;6043.879122417439;6064.527045521411;6117.051856962178 10:39:04 INFO - PROCESS | 1660 | |1;ext.html;519.4156573854414;521.4108057894579;524.9186376111704;533.1629341933165;565.2143520506495;32309.838450807743;32654;41742;41775.79112104435;41782.37326440102;43003.13993720124;43052;43445;43479;43564.78217608907;9541.475218862959;9587.66443174489;9621.134097931184;9681.661141860037;9759.512024398788;9676.56455459506;9693.176080033205;9734.26992975526;9736.221102311834;9757.951210243975;9699.563519641633;9745.561449734743;9748.415095094282;9757.707268781913;9762.707118786448;9666.90333096667;9679.080487353725;9691.612335506572;9727;9728.027197280286;9591.376560523544;9604.327697061208;9657.613695452244;9688.273379496566;9691.70924872255;41233.1753364931;41316.793416033026;41446.37830432546;41546.79226603878;41776;3448.6551344865566;3496.6328535503912;3532.823358832048;3555.1467647764607;3677.5770786359644;30797.538036929465;31723.682763172303;31870.681293187004;31914.042578722674;32666.183345416317;3229.7739158258933;3275.4431746602895;3280.4095262852675;3336.349411864687;3383.813890236036;449543;458612;459019;461259;462631.686841567;61303.386966129765;61706.69146654238;61797;61856.69071654703;62030.75938481205;64651.67674161693;64941;65571.34428655748;65705.67147164233;65746;16215.594610134842;16362.181890905407;16482.58793530171;16513.091779951978;16524.09117498549;12348.320842353756;12353.32056736888;12620.684482888002;12658;12667.683307917376;19084.33204837824;19408.029598520017;19513.92673402948;19544.827310361423;19547.413577592695;7303.926960730431;7881.369490440751;8119.066307374609;8125.187481251827;8131.113454723606;719.4280546965175;827.2637352756052;964.3779762053576;1007.5113569918584;1011.529638717985;30190;30559.541606875915;30612.846935765177;30764.53853192204;31077.844610777254;1044.6500422358442;1053.1416895230363;1076.6447072466067;1147.3173461790389;1167.5038108803724;15741.134237617041;15901.681966360607;15994.920025400032;16065.759013614805;16372.590685232964;641254;645776;656575;661795;662716;59099.704501477216;59402.405975939684;59556;59778.10332845011;59806;1360.5034162530605;1385.1273697570466;1388.7083712420506;1407.648087977985;1410.5556749623836;29531.557026644186;30175.245618859703;30783.88921591042;30861.228469288446;31137.065888023397;50665.24002139897;50829.49170508247;51378.486215138866;51639.74180129075;51665.225021625454;545679;545749;548794;549895;550830.2458487682;25664.23007309784;26226.60660090062;26668.59997100006;26812.463750725266;26870;47193;48194.554163375156;48907.510924890295;49298.274560390215;49413.75293123511;36213.63786362103;39478;40069.39895901505;40930;40980.97547561335;30859.84570077135;35076;35941.640583594875;39383.60616393914;39478.2104357917;37910;38924;38960.41559376668;39099.413508796824;39235.60764392434;32656.020319390456;35003.82498087493;35188.306923427066;35221.64778352184;35476.11309717174;21217.681734774298;24176.75823241745;25429.347092438933;25738.485230294915;26458.470830583665 10:39:04 INFO - PROCESS | 1660 | |2;jquery.html;371.708209055891;373.54614143815263;380.8095952023988;381.218502070755;400.93151750584695;18626.25494980201;20726;21197.788022119792;21489.140434382643;21520.569588608218;20492.8975355123;20529.38411847643;20654.793452065474;20882.85144317062;20946.581068378622;5699.2590963174935;5741.971290143543;5827.096799995987;5842.298924129111;5879.941200587982;4085.6935729820384;4281.336392859112;5837.416258374171;5845.152452894327;5891.617044892089;6089.508070522728;6376.904346434807;6423.807285781434;6444.516661250402;6466.06242094896;5778.219940308068;5890.646561206341;6440.13058237139;6513.413792758674;6522.902156467657;4929.975350123226;5550.27846379972;5651.717414129318;5664.178694089375;5671.914921276143;25372.238832835046;25442;25839.741602583923;25940.61089083665;25985;1923.9230430782752;2308.7114110736156;2400.915967941131;2449.9755002449924;2909.4762942670523;9540.045995400475;9724.854127188099;10399.84400233997;13127.86872131276;15551.455699050592;1663.193351224655;1736.5137761426695;1881.8964956927364;1951.687729963199;1994.4415563642203;111331.44334278358;112084.43957780159;118767;121371;123507.38246308711;11356.886431135748;11557;11670.183087183985;11673.533058677558;11851.459310289607;12975.156614820007;13864.792028119586;14515.491957781427;14702.970792044669;14740.189289589176;8343.582820859054;8511.148885111563;8554.743357699279;8704;8712.390132690778;8487.10885357041;8499.66001359951;8507.957460212783;8591.3556483264;8686.174813392718;4512.4133862597655;4598.563136502027;4606.216943119678;4680.578747912704;4680.625549955996;1943.4558323669396;1964.0670681426209;2000.5898790748154;2953.7784666150123;3596;750.7560042986051;973.8149751547184;974.3861367338673;992.6823416506649;1034.4569101221919;19214.327498537485;20816.791832081486;21265.89367053155;21566.353009409744;21567.78432215689;846.3144852669358;918.2332752151895;948.9098535639104;953.1278879824882;978.7944531648434;8965.551722413853;9366.829146356706;10055.497225138713;10787.137029037658;10806.35161890289;448242;518029;535482;549825;562131;109919.45040274748;125562;129061;129198.70801291867;136587.31706341406;863.5423225690395;981.7741919358588;988.1748739802202;1009.6769033909079;1041.0578426524007;18836.34072807445;18946.810531894505;19017.619647607247;19023.048847557842;19078;51703.22445163401;52039.73980130075;53072.46927530675;53296.73351633372;55136.93493715768;76206;76414.03308784911;76426.85359719498;76725;77221.61389193017;7152.6066066364765;7312.780616581511;7335.339819416278;7557.886631700419;7987.520748755093;11408.372539510407;12772.872271277169;13112.737745245233;13223.537176198786;13235.404406801525;10996.615118470816;11440.885591144315;11484.598039068593;11528.538858445569;11560.30638161713;10898.782024359627;10902.727431814268;11184.993350598159;11231.887681123084;11393.601223957454;10433.843492347773;11261.887381126084;11313.886861131283;11545.13411494158;11639.88360116388;5727.513161381329;7297.854042919218;7379.594122323324;7579.469437139347;7639.770806875803;9444.291678124031;9446.38598491096;10972.341659500455;11168.720781980515;11372.507859395659 10:39:04 INFO - PROCESS | 1660 | |3;mootools.html;1545.8763298936087;1589.1339220125033;1811.4656176427952;1897.2316211934171;1954.8533859960507;7969.960150199256;8220.465669731464;8444.577771111442;9049.773755656104;9062.909370906289;8460.238578527931;8795.604197811097;8809.339299552526;8896.644134234639;8933.374663773538;2368.692070030898;2406.6402482597364;2413.963790543143;2419.5765740995344;2420.903163873452;2373.786359227669;2404.615261558151;2416.03358656537;2417.8065754739578;2431.088341871798;2386.2364043506086;2395.6526303685955;2404.026369320428;2413.4931664350506;2417.9481925362434;2346.8239882008916;2348.612478940973;2364.8581085134774;2373.881305934705;2386.140989243871;1966.2135145941595;1982.7521559805025;2083.4687154775434;2086.791320867901;2111.0078263216265;8543.743687689379;8858.68994585193;8880.777980550472;8932.910670893272;8952.418092823946;5273.841784746463;5331.306930099101;5352.598555108382;5399.352077750656;5440.646357986719;2981.2695889506995;3207.8556464959133;3391.5930088389305;3397.69420752131;3410.897673069812;998.1665309466604;1070.4273213830563;1086.3264775838952;1091.2633972068822;1098.4617537406693;11458.083353331796;11736.23714458566;11745.941270293679;11773.352465614387;11860.169788114836;4631.3516107744945;4705.7176569405265;4828.927566086511;4873.537013983666;4895.8041678332465;9841.50792460374;9970.451625160686;9991.300608957303;10002.699919002442;10018.64934727281;5321.787128514893;5372.70450125239;5383.084875571162;5389.83830485086;5424.972875135599;3921.490206273166;4441.955580444154;4826.903461930741;4961.7271050092595;4965.4041515018425;3360.815155166489;3953.5651078381356;3975.7216994810087;4034.2133284009924;4131.628153466202;1313.4614807928895;1324.582756431721;1327.2501036914305;1332.6468485851258;1335.37904874232;841.6549214821894;909.8589718593629;920;937.4796987671771;953.8998405167496;5307.805743707635;5394.78420863161;5746.511546518509;6002.339742628307;6066.3630318815885;429.439581346346;432.34068046229123;435.3382858055738;439.53848459117796;442.34312046610756;2944.911652650424;3575.713942884563;3938.232044751246;4002.7598344099447;4009.67922566194;10506.579736810441;10691.358518488916;10727.731806704895;10839.945800270949;10841.241113122163;10697.946510267398;10827.83758243627;10829.187810914213;10871.510782014828;10879.83680244797;7174.748883789042;7254.129504459499;7278.526895751759;7986.281234689022;8320.251177393942;4792.520747925179;5708.286464191976;5847.859667364994;5864.882702346014;5930.644161350333;8170.346372290083;9954.054364835329;10028.398296102258;10094.798104038025;10135.037171468699;9921.900780992097;10218.744531386776;10314.27800053989;10316.742081448025;10326.535305911102;6898.724051037902;7128.108986376703;7331.560106393634;7540.472166948261;7643.159252482112;8291.792705182419;8558.144185581641;8578.45587794178;8589.699360522352;8595.87106193395;7549.698012079455;7638.885416718643;7647.541147531166;7749.845003100019;7780.2219778021745;7424.368928641126;7496.550206987598;7506.737264195727;7524.887126693214;7636.274553917369;6988.825279368057;7109.0402795623995;7109.324614161646;7116.715331386687;7122.60825654594;4903.41159060915;5023.708448151763;5076.771545280545;5077.416097148727;5081.949180508148;4312.9137417252105;4912.435069966857;4972.801087956586;5093.567046800915;5135.743212839268 10:39:04 INFO - PROCESS | 1660 | |4;prototype.html;293.8648221817965;295.5684700337507;303.86478017282303;307.17217099915723;310.41176969642515;5429.592780541456;5481.643693159946;5495.560355171587;5610.887782244363;5645.745941432635;4485.798139083741;4547.931781023287;5299.576033917287;5420.214068959998;5578.856334451438;3541.061618671054;4062.756234625917;4125.226152754314;4130.75215487071;4204.747715137101;3411.982940085296;4131.21506913687;4266.893327666802;4268.222622978671;4314.741115533062;3903.1022864741126;4175.290200665894;4177.665786737069;4196.538380778112;4199.685023623225;3189.81497674094;3513.631068737797;4175.707700460969;4178.56125106864;4214.777714462802;3135.513995330705;3441.7074548663145;3609.0075229311888;3624.8912532624063;3629.4374371972385;4747.7893137249785;4825.324454576362;4842.951570484285;5455.881544283412;5505.476979686923;4795.6163506919365;4815.181419158752;4815.831445899412;4826.22780355145;4832.975835120802;4619.607333376667;5152.273988213953;5832.125181222808;5845.09401042839;5911.970440147815;3772.1135533149686;3875.457435958968;3908.8241029153755;3925.823337949799;3953.8220780064967;4771.665983381165;4838.467768545457;5092.923606145874;6178.69106544671;6292.905606415908;3653.671169594696;3786.3184626766897;3969.4045893116263;3990.4413382126527;4016.1566071124807;3865.96134038656;3989.940150897739;4036.6770658347264;4061.2283666103344;4095.89760255996;4680.625549956064;4740.19416699162;4781.760911954389;4782.258749893772;4793.23308270682;4997.1260777208545;5844.88310233793;5901.852453688606;5966.940330596725;6002.249718785152;1081.7782354617284;1293.8770816772392;1324.8145259663654;1341.9597412077653;1370.280602683599;888.8177923525661;901.8061116859907;907.4419232172298;922.8879200563305;927.6057675487891;4886.340344053508;4923.187674033816;5552.583556233299;5562.694051827189;5579.46995035471;5118.462561431071;5726.885462290731;6065.727042283108;6102.938970610326;6119.969400152971;4781.856544303677;5190.792368305301;5365.892682146336;5563.162786978589;5589.776408943678;2356.8350215485093;2521.617071867068;2651.310659228576;2657.601359796046;2665;4320.083943338234;4331.826726930951;4419.779011049434;5171.63798534099;5264.684118952875;4199.601037901394;4535.9773201133785;5034.622403319692;5124.4114324559505;5157.922631160535;4519;4539.092181563767;4733.840209148781;4976;5341.050516561505;4528.524504926935;4943.937053533507;4947.45577986414;5039.313438502229;5127.769250383667;4605.526231605854;4659.369220772838;4996.775145118551;5090.592752579859;5096.668716533413;4399.9120017598825;4454.777261136995;5282.524572788314;5285.383735051174;5328.866778330573;3445.707114895262;3501.6323286055617;3527.9118022049656;3529.311784202056;3559.6440355964196;4665.763572653182;4760.452547957029;4968.925466118083;5044.695724300589;5141.460146684544;4146.315857883536;4419.668524860584;4479.395281636937;4988.775505102207;5026.4973502649445;4166.458360413127;4561.6315105467565;4824.842037910947;4897.2654101885;4986.850394488026;4616.122936642161;4784.162771515041;4797.001873828857;4830.396200474941;5228.7647055883335;4994.525520075587;5048.217526283432;5987.215944585614;6001.519878409804;6007.047709494519;4725.692829966041;5034.421041580265;5102.933312008642;5801.79693710735;5866.50134738535 10:39:04 INFO - PROCESS | 1660 | |5;yui.html;684.2780866186173;730.8099894027555;791.5685951156619;828.3331917806165;833.4582521361118;15763.527094187164;16090;16507;16514.256858441353;16530.33878644854;14950.850491495083;14982.550523484313;15066.623334416645;15117;15131.470398536054;886.2201262888649;903.7740564858785;905.8414777413959;906.4515967839461;910.7449914024083;901.342020325163;902.1835239108617;903.8644203369514;904.8280826642949;906.084854297158;946.3848498475977;949.4920217683541;949.6059135458777;951.1344676344528;953.0945601678433;898.9190972812446;915.0666320353236;942.3874481586955;943.4245110482634;944.1361154543584;689.9965500172517;706.6431452116648;707.5613119865665;708.691719102187;710.0556260173956;13564.186148831002;13656.112352697042;13730.588082357544;13766.24285664288;13768.724625507533;11411.771764564663;11896.58361957336;12124.151309408346;12150.214292136614;12544.059195560278;10529.84205236922;10558.78882422355;10723;10776.78446431067;10820.513076911559;3649.233660931181;3708.054446116223;3722.8510859565586;3882.0683036071423;3900.7464514806447;110856;111382.44308778485;111484.4425777874;112096.4395178027;112946;10760.677179684622;10812.297200681931;10826.404547749791;10860.402677852637;10988.670339889815;20962.161513539286;21108.89445552793;21134.788652113588;21157.78842211558;21201;7535.6985720570565;7831.765047048598;7836.294733474015;7930.9603451982375;7953.761387158394;4322.783860806947;4387.736735795863;4426.424564806554;4466.330050492452;4585.518520555361;3528.558930133733;3612.5303710517464;3634.327649384872;3660.5790334111916;3665.0104471793;669.4303395747432;674.7941877727341;678.5792808458689;682.5563383800569;686.3376841348123;602.4848754315085;662.9436497897636;664.8204984654117;698.8078278473461;703.4372501998381;8852.114788521096;8866.33502487316;9443.575039123256;9731.951340243253;9814.803703925882;452.3734627540814;514.8995945790609;537.9853240768172;650.9674516274167;690.9861802763917;4141.213169497786;4254.617084462351;4757.83871800469;4848.7090774553635;4882.438519570223;109150;120079.19881201789;144650;150928;155568.44431555766;130556;130953;131616;132028;132281.33859330835;96997.57506062405;98207.50896245617;105991.94008059974;112816;117203;9527.904720952702;9620.567074481805;10018.298719089886;10070.8489372658;10074.093331600192;56683.716581416826;57894.84210315686;58023.709881450326;59139.22582322537;62846.685766570874;79303;85673;87677;89652;90636.18727625543;12953.676158096123;13250.933745331597;13444.193348399127;13537.59387218385;13904.30478476052;14856.480023199136;14932.7760083601;15019.249037548298;15215.315310810818;15536;13777.242251675852;13944.651383715083;13947.442102315794;13990.300484975915;13994.300284985506;13517.797233041709;13549.322533873465;13777.793333100211;14115.929420352833;14243.786343205067;13301.534446294334;13611.86388136106;13677.521286754916;13719.45122195101;13958.651033724238;9423.340366174301;11160.720981975192;11312.377819220023;11323.547058117583;11467.483963221508;11000.449977501254;11251.606193783178;11459.541618335174;11554.364509952033;11589.942050289694 10:39:04 INFO - PROCESS | 1660 | __end_tp_report 10:39:04 INFO - PROCESS | 1660 | __start_cc_report 10:39:04 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,375 10:39:04 INFO - PROCESS | 1660 | __end_cc_report 10:39:04 INFO - PROCESS | 1660 | __startTimestamp1476898744338__endTimestamp 10:39:04 INFO - PROCESS | 1660 | 10:39:04 INFO - PROCESS | 1660 | ------- Summary: start ------- 10:39:04 INFO - PROCESS | 1660 | Number of tests: 6 10:39:04 INFO - PROCESS | 1660 | 10:39:04 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5663.81 Median:5937.20 stddev:687.39 (11.6%) stddev-sans-first:652.97 10:39:04 INFO - PROCESS | 1660 | Values: 2845.3 3353.7 3377.4 3417.5 3441.8 5610.9 5691.3 5698.5 5725.9 5765.3 5404.3 5635.0 5721.6 5804.6 5804.8 5150.0 5186.9 5237.9 5316.4 5332.0 4806.7 4982.3 5315.9 5328.8 5353.5 5141.7 5203.2 5267.4 5289.9 5334.4 3870.4 5155.7 5184.7 5283.2 5317.8 4932.7 5177.8 5185.5 5226.2 5243.1 4816.9 5583.2 5616.1 5835.2 5839.7 6105.1 6135.3 6178.2 6188.0 6255.3 5509.1 6216.3 6238.0 6241.8 6242.4 4758.7 5848.8 5853.9 5856.9 5870.0 6147.7 6172.8 6198.6 6248.8 6263.3 5143.8 6109.7 6163.9 6166.7 6172.3 6176.5 6231.7 6238.6 6252.5 6258.9 5061.7 6084.7 6099.5 6148.2 6192.5 6144.9 6168.8 6224.0 6229.9 6237.9 4938.0 4945.8 4961.7 4968.9 4978.7 4342.8 4378.2 4457.5 4463.8 4472.6 5728.7 5791.4 5867.2 5884.3 5989.6 6203.8 6227.3 6234.3 6241.7 6253.9 5522.8 5937.2 5937.9 5955.2 5991.7 4774.5 5000.1 5434.1 5446.1 5454.2 6378.3 6410.0 6426.3 6429.8 6433.3 6256.7 6256.8 6262.9 6277.7 6280.9 5485.8 5981.1 6101.0 6303.1 6425.0 5165.8 6183.9 6208.4 6210.3 6218.5 5128.9 5184.8 6189.9 6208.0 6229.4 5081.7 6022.9 6122.2 6139.2 6158.1 4833.4 5819.4 6123.3 6183.8 6198.9 4797.6 5962.4 6031.2 6060.4 6085.3 4853.8 6097.1 6098.6 6133.9 6198.3 5994.9 6037.3 6043.9 6064.5 6117.1 10:39:04 INFO - PROCESS | 1660 | 10:39:04 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:69277.62 Median:41381.59 stddev:149309.04 (360.8%) stddev-sans-first:149638.65 10:39:04 INFO - PROCESS | 1660 | Values: 519.4 521.4 524.9 533.2 565.2 32309.8 32654.0 41742.0 41775.8 41782.4 43003.1 43052.0 43445.0 43479.0 43564.8 9541.5 9587.7 9621.1 9681.7 9759.5 9676.6 9693.2 9734.3 9736.2 9758.0 9699.6 9745.6 9748.4 9757.7 9762.7 9666.9 9679.1 9691.6 9727.0 9728.0 9591.4 9604.3 9657.6 9688.3 9691.7 41233.2 41316.8 41446.4 41546.8 41776.0 3448.7 3496.6 3532.8 3555.1 3677.6 30797.5 31723.7 31870.7 31914.0 32666.2 3229.8 3275.4 3280.4 3336.3 3383.8 449543.0 458612.0 459019.0 461259.0 462631.7 61303.4 61706.7 61797.0 61856.7 62030.8 64651.7 64941.0 65571.3 65705.7 65746.0 16215.6 16362.2 16482.6 16513.1 16524.1 12348.3 12353.3 12620.7 12658.0 12667.7 19084.3 19408.0 19513.9 19544.8 19547.4 7303.9 7881.4 8119.1 8125.2 8131.1 719.4 827.3 964.4 1007.5 1011.5 30190.0 30559.5 30612.8 30764.5 31077.8 1044.7 1053.1 1076.6 1147.3 1167.5 15741.1 15901.7 15994.9 16065.8 16372.6 641254.0 645776.0 656575.0 661795.0 662716.0 59099.7 59402.4 59556.0 59778.1 59806.0 1360.5 1385.1 1388.7 1407.6 1410.6 29531.6 30175.2 30783.9 30861.2 31137.1 50665.2 50829.5 51378.5 51639.7 51665.2 545679.0 545749.0 548794.0 549895.0 550830.2 25664.2 26226.6 26668.6 26812.5 26870.0 47193.0 48194.6 48907.5 49298.3 49413.8 36213.6 39478.0 40069.4 40930.0 40981.0 30859.8 35076.0 35941.6 39383.6 39478.2 37910.0 38924.0 38960.4 39099.4 39235.6 32656.0 35003.8 35188.3 35221.6 35476.1 21217.7 24176.8 25429.3 25738.5 26458.5 10:39:04 INFO - PROCESS | 1660 | 10:39:04 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:32852.02 Median:3274.89 stddev:88198.50 (2693.2%) stddev-sans-first:88412.21 10:39:04 INFO - PROCESS | 1660 | Values: 371.7 373.5 380.8 381.2 400.9 18626.3 20726.0 21197.8 21489.1 21520.6 20492.9 20529.4 20654.8 20882.9 20946.6 5699.3 5742.0 5827.1 5842.3 5879.9 4085.7 4281.3 5837.4 5845.2 5891.6 6089.5 6376.9 6423.8 6444.5 6466.1 5778.2 5890.6 6440.1 6513.4 6522.9 4930.0 5550.3 5651.7 5664.2 5671.9 25372.2 25442.0 25839.7 25940.6 25985.0 1923.9 2308.7 2400.9 2450.0 2909.5 9540.0 9724.9 10399.8 13127.9 15551.5 1663.2 1736.5 1881.9 1951.7 1994.4 111331.4 112084.4 118767.0 121371.0 123507.4 11356.9 11557.0 11670.2 11673.5 11851.5 12975.2 13864.8 14515.5 14703.0 14740.2 8343.6 8511.1 8554.7 8704.0 8712.4 8487.1 8499.7 8508.0 8591.4 8686.2 4512.4 4598.6 4606.2 4680.6 4680.6 1943.5 1964.1 2000.6 2953.8 3596.0 750.8 973.8 974.4 992.7 1034.5 19214.3 20816.8 21265.9 21566.4 21567.8 846.3 918.2 948.9 953.1 978.8 8965.6 9366.8 10055.5 10787.1 10806.4 448242.0 518029.0 535482.0 549825.0 562131.0 109919.5 125562.0 129061.0 129198.7 136587.3 863.5 981.8 988.2 1009.7 1041.1 18836.3 18946.8 19017.6 19023.0 19078.0 51703.2 52039.7 53072.5 53296.7 55136.9 76206.0 76414.0 76426.9 76725.0 77221.6 7152.6 7312.8 7335.3 7557.9 7987.5 11408.4 12772.9 13112.7 13223.5 13235.4 10996.6 11440.9 11484.6 11528.5 11560.3 10898.8 10902.7 11185.0 11231.9 11393.6 10433.8 11261.9 11313.9 11545.1 11639.9 5727.5 7297.9 7379.6 7579.5 7639.8 9444.3 9446.4 10972.3 11168.7 11372.5 10:39:04 INFO - PROCESS | 1660 | 10:39:04 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5677.48 Median:4851.23 stddev:3236.67 (66.7%) stddev-sans-first:3230.86 10:39:04 INFO - PROCESS | 1660 | Values: 1545.9 1589.1 1811.5 1897.2 1954.9 7970.0 8220.5 8444.6 9049.8 9062.9 8460.2 8795.6 8809.3 8896.6 8933.4 2368.7 2406.6 2414.0 2419.6 2420.9 2373.8 2404.6 2416.0 2417.8 2431.1 2386.2 2395.7 2404.0 2413.5 2417.9 2346.8 2348.6 2364.9 2373.9 2386.1 1966.2 1982.8 2083.5 2086.8 2111.0 8543.7 8858.7 8880.8 8932.9 8952.4 5273.8 5331.3 5352.6 5399.4 5440.6 2981.3 3207.9 3391.6 3397.7 3410.9 998.2 1070.4 1086.3 1091.3 1098.5 11458.1 11736.2 11745.9 11773.4 11860.2 4631.4 4705.7 4828.9 4873.5 4895.8 9841.5 9970.5 9991.3 10002.7 10018.6 5321.8 5372.7 5383.1 5389.8 5425.0 3921.5 4442.0 4826.9 4961.7 4965.4 3360.8 3953.6 3975.7 4034.2 4131.6 1313.5 1324.6 1327.3 1332.6 1335.4 841.7 909.9 920.0 937.5 953.9 5307.8 5394.8 5746.5 6002.3 6066.4 429.4 432.3 435.3 439.5 442.3 2944.9 3575.7 3938.2 4002.8 4009.7 10506.6 10691.4 10727.7 10839.9 10841.2 10697.9 10827.8 10829.2 10871.5 10879.8 7174.7 7254.1 7278.5 7986.3 8320.3 4792.5 5708.3 5847.9 5864.9 5930.6 8170.3 9954.1 10028.4 10094.8 10135.0 9921.9 10218.7 10314.3 10316.7 10326.5 6898.7 7128.1 7331.6 7540.5 7643.2 8291.8 8558.1 8578.5 8589.7 8595.9 7549.7 7638.9 7647.5 7749.8 7780.2 7424.4 7496.6 7506.7 7524.9 7636.3 6988.8 7109.0 7109.3 7116.7 7122.6 4903.4 5023.7 5076.8 5077.4 5081.9 4312.9 4912.4 4972.8 5093.6 5135.7 10:39:04 INFO - PROCESS | 1660 | 10:39:04 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4369.95 Median:4782.06 stddev:1322.16 (27.6%) stddev-sans-first:1289.99 10:39:04 INFO - PROCESS | 1660 | Values: 293.9 295.6 303.9 307.2 310.4 5429.6 5481.6 5495.6 5610.9 5645.7 4485.8 4547.9 5299.6 5420.2 5578.9 3541.1 4062.8 4125.2 4130.8 4204.7 3412.0 4131.2 4266.9 4268.2 4314.7 3903.1 4175.3 4177.7 4196.5 4199.7 3189.8 3513.6 4175.7 4178.6 4214.8 3135.5 3441.7 3609.0 3624.9 3629.4 4747.8 4825.3 4843.0 5455.9 5505.5 4795.6 4815.2 4815.8 4826.2 4833.0 4619.6 5152.3 5832.1 5845.1 5912.0 3772.1 3875.5 3908.8 3925.8 3953.8 4771.7 4838.5 5092.9 6178.7 6292.9 3653.7 3786.3 3969.4 3990.4 4016.2 3866.0 3989.9 4036.7 4061.2 4095.9 4680.6 4740.2 4781.8 4782.3 4793.2 4997.1 5844.9 5901.9 5966.9 6002.2 1081.8 1293.9 1324.8 1342.0 1370.3 888.8 901.8 907.4 922.9 927.6 4886.3 4923.2 5552.6 5562.7 5579.5 5118.5 5726.9 6065.7 6102.9 6120.0 4781.9 5190.8 5365.9 5563.2 5589.8 2356.8 2521.6 2651.3 2657.6 2665.0 4320.1 4331.8 4419.8 5171.6 5264.7 4199.6 4536.0 5034.6 5124.4 5157.9 4519.0 4539.1 4733.8 4976.0 5341.1 4528.5 4943.9 4947.5 5039.3 5127.8 4605.5 4659.4 4996.8 5090.6 5096.7 4399.9 4454.8 5282.5 5285.4 5328.9 3445.7 3501.6 3527.9 3529.3 3559.6 4665.8 4760.5 4968.9 5044.7 5141.5 4146.3 4419.7 4479.4 4988.8 5026.5 4166.5 4561.6 4824.8 4897.3 4986.9 4616.1 4784.2 4797.0 4830.4 5228.8 4994.5 5048.2 5987.2 6001.5 6007.0 4725.7 5034.4 5102.9 5801.8 5866.5 10:39:04 INFO - PROCESS | 1660 | 10:39:04 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:24264.80 Median:3570.54 stddev:38411.64 (1075.8%) stddev-sans-first:38478.59 10:39:04 INFO - PROCESS | 1660 | Values: 684.3 730.8 791.6 828.3 833.5 15763.5 16090.0 16507.0 16514.3 16530.3 14950.9 14982.6 15066.6 15117.0 15131.5 886.2 903.8 905.8 906.5 910.7 901.3 902.2 903.9 904.8 906.1 946.4 949.5 949.6 951.1 953.1 898.9 915.1 942.4 943.4 944.1 690.0 706.6 707.6 708.7 710.1 13564.2 13656.1 13730.6 13766.2 13768.7 11411.8 11896.6 12124.2 12150.2 12544.1 10529.8 10558.8 10723.0 10776.8 10820.5 3649.2 3708.1 3722.9 3882.1 3900.7 110856.0 111382.4 111484.4 112096.4 112946.0 10760.7 10812.3 10826.4 10860.4 10988.7 20962.2 21108.9 21134.8 21157.8 21201.0 7535.7 7831.8 7836.3 7931.0 7953.8 4322.8 4387.7 4426.4 4466.3 4585.5 3528.6 3612.5 3634.3 3660.6 3665.0 669.4 674.8 678.6 682.6 686.3 602.5 662.9 664.8 698.8 703.4 8852.1 8866.3 9443.6 9732.0 9814.8 452.4 514.9 538.0 651.0 691.0 4141.2 4254.6 4757.8 4848.7 4882.4 109150.0 120079.2 144650.0 150928.0 155568.4 130556.0 130953.0 131616.0 132028.0 132281.3 96997.6 98207.5 105991.9 112816.0 117203.0 9527.9 9620.6 10018.3 10070.8 10074.1 56683.7 57894.8 58023.7 59139.2 62846.7 79303.0 85673.0 87677.0 89652.0 90636.2 12953.7 13250.9 13444.2 13537.6 13904.3 14856.5 14932.8 15019.2 15215.3 15536.0 13777.2 13944.7 13947.4 13990.3 13994.3 13517.8 13549.3 13777.8 14115.9 14243.8 13301.5 13611.9 13677.5 13719.5 13958.7 9423.3 11160.7 11312.4 11323.5 11467.5 11000.4 11251.6 11459.5 11554.4 11589.9 10:39:04 INFO - PROCESS | 1660 | -------- Summary: end -------- 10:39:04 INFO - PROCESS | 1660 | 10:39:04 INFO - TEST-INFO | 1660: exit 0 10:39:04 INFO - TEST-OK | dromaeo_css | took 1116055ms 10:39:04 INFO - TEST-START | kraken 10:39:04 INFO - operating with platform_type : mac_ 10:39:04 INFO - Initialising browser for kraken test... 10:39:04 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpBaT9m7/profile http://localhost:49272/getInfo.html) 10:39:07 INFO - PROCESS | 1670 | 2016-10-19 10:39:07.621 plugin-container[1671:10419] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 10:39:07 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:39:07 INFO - PROCESS | 1670 | 2016-10-19 10:39:07.626 plugin-container[1671:10419] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d1b, name = 'com.apple.CFPasteboardClient' 10:39:07 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:39:07 INFO - PROCESS | 1670 | 2016-10-19 10:39:07.626 plugin-container[1671:10419] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:39:07 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 10:39:07 INFO - PROCESS | 1670 | colorDepth:24 10:39:07 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 10:39:07 INFO - PROCESS | 1670 | __metrics 10:39:07 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 10:39:08 INFO - TEST-INFO | 1670: exit 0 10:39:08 INFO - Browser initialized. 10:39:08 INFO - Running cycle 1/1 for kraken test... 10:39:08 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpBaT9m7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:39:11 INFO - PROCESS | 1672 | 2016-10-19 10:39:10.995 plugin-container[1673:10532] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 10:39:11 INFO - PROCESS | 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:39:11 INFO - PROCESS | 1672 | 2016-10-19 10:39:10.995 plugin-container[1673:10532] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 10:39:11 INFO - PROCESS | 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:39:11 INFO - PROCESS | 1672 | 2016-10-19 10:39:10.995 plugin-container[1673:10532] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:39:20 INFO - PROCESS | 1672 | RSS: Main: 237187072 10:39:20 INFO - PROCESS | 1672 | 10:39:23 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 10:39:24 INFO - PROCESS | 1672 | RSS: Main: 249532416 10:39:24 INFO - PROCESS | 1672 | 10:39:26 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 10:39:27 INFO - PROCESS | 1672 | RSS: Main: 258199552 10:39:27 INFO - PROCESS | 1672 | 10:39:30 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 10:39:31 INFO - PROCESS | 1672 | RSS: Main: 260243456 10:39:31 INFO - PROCESS | 1672 | 10:39:33 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 10:39:33 INFO - PROCESS | 1672 | RSS: Main: 262287360 10:39:33 INFO - PROCESS | 1672 | 10:39:35 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:39:36 INFO - PROCESS | 1672 | RSS: Main: 262717440 10:39:36 INFO - PROCESS | 1672 | 10:39:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 10:39:39 INFO - PROCESS | 1672 | RSS: Main: 263454720 10:39:39 INFO - PROCESS | 1672 | 10:39:42 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 10:39:43 INFO - PROCESS | 1672 | RSS: Main: 263368704 10:39:43 INFO - PROCESS | 1672 | 10:39:46 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 10:39:46 INFO - PROCESS | 1672 | RSS: Main: 263675904 10:39:46 INFO - PROCESS | 1672 | 10:39:48 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:39:48 INFO - PROCESS | 1672 | RSS: Main: 262975488 10:39:48 INFO - PROCESS | 1672 | 10:39:50 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:39:51 INFO - PROCESS | 1672 | RSS: Main: 263163904 10:39:51 INFO - PROCESS | 1672 | 10:39:53 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:39:54 INFO - PROCESS | 1672 | RSS: Main: 263077888 10:39:54 INFO - PROCESS | 1672 | 10:39:57 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:39:58 INFO - PROCESS | 1672 | RSS: Main: 263057408 10:39:58 INFO - PROCESS | 1672 | 10:40:01 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:40:01 INFO - PROCESS | 1672 | RSS: Main: 263409664 10:40:01 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 10:40:03 INFO - PROCESS | 1672 | RSS: Main: 265248768 10:40:03 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | __start_tp_report 10:40:03 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 10:40:03 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 10:40:03 INFO - PROCESS | 1672 | |i|pagename|runs| 10:40:03 INFO - PROCESS | 1672 | |0;ai-astar;115;119;114;116;117;114;113;117;117;117 10:40:03 INFO - PROCESS | 1672 | |1;audio-beat-detection;156;151;129;151;117;117;116;115;161;139 10:40:03 INFO - PROCESS | 1672 | |2;audio-dft;202;202;203;202;215;197;198;198;198;197 10:40:03 INFO - PROCESS | 1672 | |3;audio-fft;78;57;57;84;60;61;60;59;78;58 10:40:03 INFO - PROCESS | 1672 | |4;audio-oscillator;88;71;85;72;68;72;116;101;90;86 10:40:03 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;90;87;89;87;88;86;94;86;89;86 10:40:03 INFO - PROCESS | 1672 | |6;imaging-darkroom;95;96;130;100;101;131;96;95;94;97 10:40:03 INFO - PROCESS | 1672 | |7;imaging-desaturate;86;88;84;86;87;88;100;87;88;94 10:40:03 INFO - PROCESS | 1672 | |8;json-parse-financial;55;56;55;56;60;63;61;50;50;92 10:40:03 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;69;77;72;80;75;109;108;110;75;69 10:40:03 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;89;92;89;90;91;88;90;93;92;88 10:40:03 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;164;163;155;149;157;152;148;148;196;150 10:40:03 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;168;229;212;178;194;188;171;176;172;176 10:40:03 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;70;71;67;68;70;70;70;69;68;75 10:40:03 INFO - PROCESS | 1672 | __end_tp_report 10:40:03 INFO - PROCESS | 1672 | __start_cc_report 10:40:03 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,958 10:40:03 INFO - PROCESS | 1672 | __end_cc_report 10:40:03 INFO - PROCESS | 1672 | __startTimestamp1476898803732__endTimestamp 10:40:03 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | ------- Summary: start ------- 10:40:03 INFO - PROCESS | 1672 | Number of tests: 14 10:40:03 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:115.90 Median:117.00 stddev:1.85 (1.6%) stddev-sans-first:1.94 10:40:03 INFO - PROCESS | 1672 | Values: 115.0 119.0 114.0 116.0 117.0 114.0 113.0 117.0 117.0 117.0 10:40:03 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:145.00 stddev:18.53 (12.8%) stddev-sans-first:18.06 10:40:03 INFO - PROCESS | 1672 | Values: 156.0 151.0 129.0 151.0 117.0 117.0 116.0 115.0 161.0 139.0 10:40:03 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:201.20 Median:202.00 stddev:5.39 (2.7%) stddev-sans-first:5.71 10:40:03 INFO - PROCESS | 1672 | Values: 202.0 202.0 203.0 202.0 215.0 197.0 198.0 198.0 198.0 197.0 10:40:03 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:65.20 Median:60.50 stddev:10.42 (17.2%) stddev-sans-first:9.97 10:40:03 INFO - PROCESS | 1672 | Values: 78.0 57.0 57.0 84.0 60.0 61.0 60.0 59.0 78.0 58.0 10:40:03 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:84.90 Median:78.50 stddev:15.18 (19.3%) stddev-sans-first:16.06 10:40:03 INFO - PROCESS | 1672 | Values: 88.0 71.0 85.0 72.0 68.0 72.0 116.0 101.0 90.0 86.0 10:40:03 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:88.50 stddev:2.49 (2.8%) stddev-sans-first:2.55 10:40:03 INFO - PROCESS | 1672 | Values: 90.0 87.0 89.0 87.0 88.0 86.0 94.0 86.0 89.0 86.0 10:40:03 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:103.50 Median:95.00 stddev:14.40 (15.2%) stddev-sans-first:14.94 10:40:03 INFO - PROCESS | 1672 | Values: 95.0 96.0 130.0 100.0 101.0 131.0 96.0 95.0 94.0 97.0 10:40:03 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:88.80 Median:87.50 stddev:4.71 (5.4%) stddev-sans-first:4.88 10:40:03 INFO - PROCESS | 1672 | Values: 86.0 88.0 84.0 86.0 87.0 88.0 100.0 87.0 88.0 94.0 10:40:03 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:58.00 stddev:12.09 (20.8%) stddev-sans-first:12.70 10:40:03 INFO - PROCESS | 1672 | Values: 55.0 56.0 55.0 56.0 60.0 63.0 61.0 50.0 50.0 92.0 10:40:03 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:84.40 Median:73.50 stddev:17.31 (23.5%) stddev-sans-first:17.44 10:40:03 INFO - PROCESS | 1672 | Values: 69.0 77.0 72.0 80.0 75.0 109.0 108.0 110.0 75.0 69.0 10:40:03 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:90.50 stddev:1.75 (1.9%) stddev-sans-first:1.80 10:40:03 INFO - PROCESS | 1672 | Values: 89.0 92.0 89.0 90.0 91.0 88.0 90.0 93.0 92.0 88.0 10:40:03 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:158.20 Median:156.00 stddev:14.51 (9.3%) stddev-sans-first:15.24 10:40:03 INFO - PROCESS | 1672 | Values: 164.0 163.0 155.0 149.0 157.0 152.0 148.0 148.0 196.0 150.0 10:40:03 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.40 Median:183.00 stddev:20.00 (10.9%) stddev-sans-first:20.08 10:40:03 INFO - PROCESS | 1672 | Values: 168.0 229.0 212.0 178.0 194.0 188.0 171.0 176.0 172.0 176.0 10:40:03 INFO - PROCESS | 1672 | 10:40:03 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:2.20 (3.1%) stddev-sans-first:2.33 10:40:03 INFO - PROCESS | 1672 | Values: 70.0 71.0 67.0 68.0 70.0 70.0 70.0 69.0 68.0 75.0 10:40:03 INFO - PROCESS | 1672 | -------- Summary: end -------- 10:40:03 INFO - PROCESS | 1672 | 10:40:04 INFO - TEST-INFO | 1672: exit 0 10:40:04 INFO - TEST-OK | kraken | took 59829ms 10:40:04 INFO - SUITE-END | took 1175s 10:40:04 INFO - Completed test suite (00:19:36) 10:40:04 INFO - javascript benchmark 10:40:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7294.459386343339, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2845.331347133423, 3353.664633536645, 3377.3920694275034, 3417.521546983421, 3441.8107004114763, 5610.859728506789, 5691.317041954966, 5698.51562617177, 5725.942740572593, 5765.3369862465825, 5404.297441332631, 5635.042042852715, 5721.5994880358285, 5804.564657650682, 5804.82585522434, 5150.04724126036, 5186.948130518703, 5237.921431178535, 5316.3620365556, 5332.0, 4806.663533552653, 4982.2526621006955, 5315.867103322409, 5328.8401347959425, 5353.52777986055, 5141.691498510101, 5203.16749320107, 5267.446918073585, 5289.86775330616, 5334.359876814788, 3870.3613903705855, 5155.66488178271, 5184.688918664892, 5283.154695248781, 5317.760700768475, 4932.654714170009, 5177.818776342848, 5185.481451854822, 5226.242194881721, 5243.056249875021, 4816.903661926777, 5583.246261754693, 5616.073347897592, 5835.212246346774, 5839.678817665027, 6105.126180223406, 6135.263768347782, 6178.196834411498, 6188.0, 6255.280642726099, 5509.118541033416, 6216.2851272103835, 6237.96881015592, 6241.78153764616, 6242.438180563771, 4758.690685105457, 5848.824535263949, 5853.94146058534, 5856.912146317809, 5870.0, 6147.72335244915, 6172.783952561639, 6198.6280823150755, 6248.75004999804, 6263.279722831841, 5143.7685304161405, 6109.725062372204, 6163.907541386883, 6166.660833654102, 6172.259328880473, 6176.536759743038, 6231.657258850807, 6238.625682459067, 6252.531060170505, 6258.937410625836, 5061.721605311744, 6084.665343406066, 6099.461111717566, 6148.231471066117, 6192.504599632019, 6144.880016394337, 6168.845778855564, 6224.0, 6229.906551401733, 6237.906431403532, 4938.0, 4945.826896058693, 4961.70229786214, 4968.8509344719, 4978.701277923336, 4342.82628694855, 4378.190034843564, 4457.531959144308, 4463.776811159429, 4472.642188624902, 5728.742206600713, 5791.420857914175, 5867.237259156283, 5884.293884733859, 5989.610675306179, 6203.7828675996125, 6227.314995350508, 6234.314225435199, 6241.656708880964, 6253.906191407133, 5522.779088836482, 5937.198478205387, 5937.910931336033, 5955.166276721263, 5991.730372133265, 4774.498677638868, 5000.1249781288125, 5434.10337294342, 5446.101393270145, 5454.236406903036, 6378.330275321025, 6410.038494225903, 6426.325235850262, 6429.839254018687, 6433.292337842927, 6256.687165641609, 6256.781012664717, 6262.906056409066, 6277.654728989949, 6280.905786413116, 5485.807996720096, 5981.1327357532045, 6101.03536932808, 6303.086052522267, 6424.967875160594, 5165.793368265227, 6183.876322473615, 6208.441240288215, 6210.347913469021, 6218.502519798315, 5128.923066154085, 5184.833412482161, 6189.876202476015, 6208.00671892495, 6229.3770622937345, 5081.72050537224, 6022.8857661332795, 6122.204113465221, 6139.171211886517, 6158.137860699416, 4833.419989601271, 5819.447152520504, 6123.343628574205, 6183.84540386494, 6198.907016394848, 4797.56821886032, 5962.37395073511, 6031.185789918305, 6060.39396060408, 6085.300190478151, 4853.781579828987, 6097.1314910987585, 6098.644029114022, 6133.854967165127, 6198.256209254918, 5994.940050599613, 6037.305709843425, 6043.879122417439, 6064.527045521411, 6117.051856962178], "value": 5623.243356752434, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [519.4156573854414, 521.4108057894579, 524.9186376111704, 533.1629341933165, 565.2143520506495, 32309.838450807743, 32654.0, 41742.0, 41775.79112104435, 41782.37326440102, 43003.13993720124, 43052.0, 43445.0, 43479.0, 43564.78217608907, 9541.475218862959, 9587.66443174489, 9621.134097931184, 9681.661141860037, 9759.512024398788, 9676.56455459506, 9693.176080033205, 9734.26992975526, 9736.221102311834, 9757.951210243975, 9699.563519641633, 9745.561449734743, 9748.415095094282, 9757.707268781913, 9762.707118786448, 9666.90333096667, 9679.080487353725, 9691.612335506572, 9727.0, 9728.027197280286, 9591.376560523544, 9604.327697061208, 9657.613695452244, 9688.273379496566, 9691.70924872255, 41233.1753364931, 41316.793416033026, 41446.37830432546, 41546.79226603878, 41776.0, 3448.6551344865566, 3496.6328535503912, 3532.823358832048, 3555.1467647764607, 3677.5770786359644, 30797.538036929465, 31723.682763172303, 31870.681293187004, 31914.042578722674, 32666.183345416317, 3229.7739158258933, 3275.4431746602895, 3280.4095262852675, 3336.349411864687, 3383.813890236036, 449543.0, 458612.0, 459019.0, 461259.0, 462631.686841567, 61303.386966129765, 61706.69146654238, 61797.0, 61856.69071654703, 62030.75938481205, 64651.67674161693, 64941.0, 65571.34428655748, 65705.67147164233, 65746.0, 16215.594610134842, 16362.181890905407, 16482.58793530171, 16513.091779951978, 16524.09117498549, 12348.320842353756, 12353.32056736888, 12620.684482888002, 12658.0, 12667.683307917376, 19084.33204837824, 19408.029598520017, 19513.92673402948, 19544.827310361423, 19547.413577592695, 7303.926960730431, 7881.369490440751, 8119.066307374609, 8125.187481251827, 8131.113454723606, 719.4280546965175, 827.2637352756052, 964.3779762053576, 1007.5113569918584, 1011.529638717985, 30190.0, 30559.541606875915, 30612.846935765177, 30764.53853192204, 31077.844610777254, 1044.6500422358442, 1053.1416895230363, 1076.6447072466067, 1147.3173461790389, 1167.5038108803724, 15741.134237617041, 15901.681966360607, 15994.920025400032, 16065.759013614805, 16372.590685232964, 641254.0, 645776.0, 656575.0, 661795.0, 662716.0, 59099.704501477216, 59402.405975939684, 59556.0, 59778.10332845011, 59806.0, 1360.5034162530605, 1385.1273697570466, 1388.7083712420506, 1407.648087977985, 1410.5556749623836, 29531.557026644186, 30175.245618859703, 30783.88921591042, 30861.228469288446, 31137.065888023397, 50665.24002139897, 50829.49170508247, 51378.486215138866, 51639.74180129075, 51665.225021625454, 545679.0, 545749.0, 548794.0, 549895.0, 550830.2458487682, 25664.23007309784, 26226.60660090062, 26668.59997100006, 26812.463750725266, 26870.0, 47193.0, 48194.554163375156, 48907.510924890295, 49298.274560390215, 49413.75293123511, 36213.63786362103, 39478.0, 40069.39895901505, 40930.0, 40980.97547561335, 30859.84570077135, 35076.0, 35941.640583594875, 39383.60616393914, 39478.2104357917, 37910.0, 38924.0, 38960.41559376668, 39099.413508796824, 39235.60764392434, 32656.020319390456, 35003.82498087493, 35188.306923427066, 35221.64778352184, 35476.11309717174, 21217.681734774298, 24176.75823241745, 25429.347092438933, 25738.485230294915, 26458.470830583665], "value": 20171.66788256429, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.708209055891, 373.54614143815263, 380.8095952023988, 381.218502070755, 400.93151750584695, 18626.25494980201, 20726.0, 21197.788022119792, 21489.140434382643, 21520.569588608218, 20492.8975355123, 20529.38411847643, 20654.793452065474, 20882.85144317062, 20946.581068378622, 5699.2590963174935, 5741.971290143543, 5827.096799995987, 5842.298924129111, 5879.941200587982, 4085.6935729820384, 4281.336392859112, 5837.416258374171, 5845.152452894327, 5891.617044892089, 6089.508070522728, 6376.904346434807, 6423.807285781434, 6444.516661250402, 6466.06242094896, 5778.219940308068, 5890.646561206341, 6440.13058237139, 6513.413792758674, 6522.902156467657, 4929.975350123226, 5550.27846379972, 5651.717414129318, 5664.178694089375, 5671.914921276143, 25372.238832835046, 25442.0, 25839.741602583923, 25940.61089083665, 25985.0, 1923.9230430782752, 2308.7114110736156, 2400.915967941131, 2449.9755002449924, 2909.4762942670523, 9540.045995400475, 9724.854127188099, 10399.84400233997, 13127.86872131276, 15551.455699050592, 1663.193351224655, 1736.5137761426695, 1881.8964956927364, 1951.687729963199, 1994.4415563642203, 111331.44334278358, 112084.43957780159, 118767.0, 121371.0, 123507.38246308711, 11356.886431135748, 11557.0, 11670.183087183985, 11673.533058677558, 11851.459310289607, 12975.156614820007, 13864.792028119586, 14515.491957781427, 14702.970792044669, 14740.189289589176, 8343.582820859054, 8511.148885111563, 8554.743357699279, 8704.0, 8712.390132690778, 8487.10885357041, 8499.66001359951, 8507.957460212783, 8591.3556483264, 8686.174813392718, 4512.4133862597655, 4598.563136502027, 4606.216943119678, 4680.578747912704, 4680.625549955996, 1943.4558323669396, 1964.0670681426209, 2000.5898790748154, 2953.7784666150123, 3596.0, 750.7560042986051, 973.8149751547184, 974.3861367338673, 992.6823416506649, 1034.4569101221919, 19214.327498537485, 20816.791832081486, 21265.89367053155, 21566.353009409744, 21567.78432215689, 846.3144852669358, 918.2332752151895, 948.9098535639104, 953.1278879824882, 978.7944531648434, 8965.551722413853, 9366.829146356706, 10055.497225138713, 10787.137029037658, 10806.35161890289, 448242.0, 518029.0, 535482.0, 549825.0, 562131.0, 109919.45040274748, 125562.0, 129061.0, 129198.70801291867, 136587.31706341406, 863.5423225690395, 981.7741919358588, 988.1748739802202, 1009.6769033909079, 1041.0578426524007, 18836.34072807445, 18946.810531894505, 19017.619647607247, 19023.048847557842, 19078.0, 51703.22445163401, 52039.73980130075, 53072.46927530675, 53296.73351633372, 55136.93493715768, 76206.0, 76414.03308784911, 76426.85359719498, 76725.0, 77221.61389193017, 7152.6066066364765, 7312.780616581511, 7335.339819416278, 7557.886631700419, 7987.520748755093, 11408.372539510407, 12772.872271277169, 13112.737745245233, 13223.537176198786, 13235.404406801525, 10996.615118470816, 11440.885591144315, 11484.598039068593, 11528.538858445569, 11560.30638161713, 10898.782024359627, 10902.727431814268, 11184.993350598159, 11231.887681123084, 11393.601223957454, 10433.843492347773, 11261.887381126084, 11313.886861131283, 11545.13411494158, 11639.88360116388, 5727.513161381329, 7297.854042919218, 7379.594122323324, 7579.469437139347, 7639.770806875803, 9444.291678124031, 9446.38598491096, 10972.341659500455, 11168.720781980515, 11372.507859395659], "value": 9582.13061298801, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1545.8763298936087, 1589.1339220125033, 1811.4656176427952, 1897.2316211934171, 1954.8533859960507, 7969.960150199256, 8220.465669731464, 8444.577771111442, 9049.773755656104, 9062.909370906289, 8460.238578527931, 8795.604197811097, 8809.339299552526, 8896.644134234639, 8933.374663773538, 2368.692070030898, 2406.6402482597364, 2413.963790543143, 2419.5765740995344, 2420.903163873452, 2373.786359227669, 2404.615261558151, 2416.03358656537, 2417.8065754739578, 2431.088341871798, 2386.2364043506086, 2395.6526303685955, 2404.026369320428, 2413.4931664350506, 2417.9481925362434, 2346.8239882008916, 2348.612478940973, 2364.8581085134774, 2373.881305934705, 2386.140989243871, 1966.2135145941595, 1982.7521559805025, 2083.4687154775434, 2086.791320867901, 2111.0078263216265, 8543.743687689379, 8858.68994585193, 8880.777980550472, 8932.910670893272, 8952.418092823946, 5273.841784746463, 5331.306930099101, 5352.598555108382, 5399.352077750656, 5440.646357986719, 2981.2695889506995, 3207.8556464959133, 3391.5930088389305, 3397.69420752131, 3410.897673069812, 998.1665309466604, 1070.4273213830563, 1086.3264775838952, 1091.2633972068822, 1098.4617537406693, 11458.083353331796, 11736.23714458566, 11745.941270293679, 11773.352465614387, 11860.169788114836, 4631.3516107744945, 4705.7176569405265, 4828.927566086511, 4873.537013983666, 4895.8041678332465, 9841.50792460374, 9970.451625160686, 9991.300608957303, 10002.699919002442, 10018.64934727281, 5321.787128514893, 5372.70450125239, 5383.084875571162, 5389.83830485086, 5424.972875135599, 3921.490206273166, 4441.955580444154, 4826.903461930741, 4961.7271050092595, 4965.4041515018425, 3360.815155166489, 3953.5651078381356, 3975.7216994810087, 4034.2133284009924, 4131.628153466202, 1313.4614807928895, 1324.582756431721, 1327.2501036914305, 1332.6468485851258, 1335.37904874232, 841.6549214821894, 909.8589718593629, 920.0, 937.4796987671771, 953.8998405167496, 5307.805743707635, 5394.78420863161, 5746.511546518509, 6002.339742628307, 6066.3630318815885, 429.439581346346, 432.34068046229123, 435.3382858055738, 439.53848459117796, 442.34312046610756, 2944.911652650424, 3575.713942884563, 3938.232044751246, 4002.7598344099447, 4009.67922566194, 10506.579736810441, 10691.358518488916, 10727.731806704895, 10839.945800270949, 10841.241113122163, 10697.946510267398, 10827.83758243627, 10829.187810914213, 10871.510782014828, 10879.83680244797, 7174.748883789042, 7254.129504459499, 7278.526895751759, 7986.281234689022, 8320.251177393942, 4792.520747925179, 5708.286464191976, 5847.859667364994, 5864.882702346014, 5930.644161350333, 8170.346372290083, 9954.054364835329, 10028.398296102258, 10094.798104038025, 10135.037171468699, 9921.900780992097, 10218.744531386776, 10314.27800053989, 10316.742081448025, 10326.535305911102, 6898.724051037902, 7128.108986376703, 7331.560106393634, 7540.472166948261, 7643.159252482112, 8291.792705182419, 8558.144185581641, 8578.45587794178, 8589.699360522352, 8595.87106193395, 7549.698012079455, 7638.885416718643, 7647.541147531166, 7749.845003100019, 7780.2219778021745, 7424.368928641126, 7496.550206987598, 7506.737264195727, 7524.887126693214, 7636.274553917369, 6988.825279368057, 7109.0402795623995, 7109.324614161646, 7116.715331386687, 7122.60825654594, 4903.41159060915, 5023.708448151763, 5076.771545280545, 5077.416097148727, 5081.949180508148, 4312.9137417252105, 4912.435069966857, 4972.801087956586, 5093.567046800915, 5135.743212839268], "value": 4477.600150879207, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.8648221817965, 295.5684700337507, 303.86478017282303, 307.17217099915723, 310.41176969642515, 5429.592780541456, 5481.643693159946, 5495.560355171587, 5610.887782244363, 5645.745941432635, 4485.798139083741, 4547.931781023287, 5299.576033917287, 5420.214068959998, 5578.856334451438, 3541.061618671054, 4062.756234625917, 4125.226152754314, 4130.75215487071, 4204.747715137101, 3411.982940085296, 4131.21506913687, 4266.893327666802, 4268.222622978671, 4314.741115533062, 3903.1022864741126, 4175.290200665894, 4177.665786737069, 4196.538380778112, 4199.685023623225, 3189.81497674094, 3513.631068737797, 4175.707700460969, 4178.56125106864, 4214.777714462802, 3135.513995330705, 3441.7074548663145, 3609.0075229311888, 3624.8912532624063, 3629.4374371972385, 4747.7893137249785, 4825.324454576362, 4842.951570484285, 5455.881544283412, 5505.476979686923, 4795.6163506919365, 4815.181419158752, 4815.831445899412, 4826.22780355145, 4832.975835120802, 4619.607333376667, 5152.273988213953, 5832.125181222808, 5845.09401042839, 5911.970440147815, 3772.1135533149686, 3875.457435958968, 3908.8241029153755, 3925.823337949799, 3953.8220780064967, 4771.665983381165, 4838.467768545457, 5092.923606145874, 6178.69106544671, 6292.905606415908, 3653.671169594696, 3786.3184626766897, 3969.4045893116263, 3990.4413382126527, 4016.1566071124807, 3865.96134038656, 3989.940150897739, 4036.6770658347264, 4061.2283666103344, 4095.89760255996, 4680.625549956064, 4740.19416699162, 4781.760911954389, 4782.258749893772, 4793.23308270682, 4997.1260777208545, 5844.88310233793, 5901.852453688606, 5966.940330596725, 6002.249718785152, 1081.7782354617284, 1293.8770816772392, 1324.8145259663654, 1341.9597412077653, 1370.280602683599, 888.8177923525661, 901.8061116859907, 907.4419232172298, 922.8879200563305, 927.6057675487891, 4886.340344053508, 4923.187674033816, 5552.583556233299, 5562.694051827189, 5579.46995035471, 5118.462561431071, 5726.885462290731, 6065.727042283108, 6102.938970610326, 6119.969400152971, 4781.856544303677, 5190.792368305301, 5365.892682146336, 5563.162786978589, 5589.776408943678, 2356.8350215485093, 2521.617071867068, 2651.310659228576, 2657.601359796046, 2665.0, 4320.083943338234, 4331.826726930951, 4419.779011049434, 5171.63798534099, 5264.684118952875, 4199.601037901394, 4535.9773201133785, 5034.622403319692, 5124.4114324559505, 5157.922631160535, 4519.0, 4539.092181563767, 4733.840209148781, 4976.0, 5341.050516561505, 4528.524504926935, 4943.937053533507, 4947.45577986414, 5039.313438502229, 5127.769250383667, 4605.526231605854, 4659.369220772838, 4996.775145118551, 5090.592752579859, 5096.668716533413, 4399.9120017598825, 4454.777261136995, 5282.524572788314, 5285.383735051174, 5328.866778330573, 3445.707114895262, 3501.6323286055617, 3527.9118022049656, 3529.311784202056, 3559.6440355964196, 4665.763572653182, 4760.452547957029, 4968.925466118083, 5044.695724300589, 5141.460146684544, 4146.315857883536, 4419.668524860584, 4479.395281636937, 4988.775505102207, 5026.4973502649445, 4166.458360413127, 4561.6315105467565, 4824.842037910947, 4897.2654101885, 4986.850394488026, 4616.122936642161, 4784.162771515041, 4797.001873828857, 4830.396200474941, 5228.7647055883335, 4994.525520075587, 5048.217526283432, 5987.215944585614, 6001.519878409804, 6007.047709494519, 4725.692829966041, 5034.421041580265, 5102.933312008642, 5801.79693710735, 5866.50134738535], "value": 3956.5871941491314, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.2780866186173, 730.8099894027555, 791.5685951156619, 828.3331917806165, 833.4582521361118, 15763.527094187164, 16090.0, 16507.0, 16514.256858441353, 16530.33878644854, 14950.850491495083, 14982.550523484313, 15066.623334416645, 15117.0, 15131.470398536054, 886.2201262888649, 903.7740564858785, 905.8414777413959, 906.4515967839461, 910.7449914024083, 901.342020325163, 902.1835239108617, 903.8644203369514, 904.8280826642949, 906.084854297158, 946.3848498475977, 949.4920217683541, 949.6059135458777, 951.1344676344528, 953.0945601678433, 898.9190972812446, 915.0666320353236, 942.3874481586955, 943.4245110482634, 944.1361154543584, 689.9965500172517, 706.6431452116648, 707.5613119865665, 708.691719102187, 710.0556260173956, 13564.186148831002, 13656.112352697042, 13730.588082357544, 13766.24285664288, 13768.724625507533, 11411.771764564663, 11896.58361957336, 12124.151309408346, 12150.214292136614, 12544.059195560278, 10529.84205236922, 10558.78882422355, 10723.0, 10776.78446431067, 10820.513076911559, 3649.233660931181, 3708.054446116223, 3722.8510859565586, 3882.0683036071423, 3900.7464514806447, 110856.0, 111382.44308778485, 111484.4425777874, 112096.4395178027, 112946.0, 10760.677179684622, 10812.297200681931, 10826.404547749791, 10860.402677852637, 10988.670339889815, 20962.161513539286, 21108.89445552793, 21134.788652113588, 21157.78842211558, 21201.0, 7535.6985720570565, 7831.765047048598, 7836.294733474015, 7930.9603451982375, 7953.761387158394, 4322.783860806947, 4387.736735795863, 4426.424564806554, 4466.330050492452, 4585.518520555361, 3528.558930133733, 3612.5303710517464, 3634.327649384872, 3660.5790334111916, 3665.0104471793, 669.4303395747432, 674.7941877727341, 678.5792808458689, 682.5563383800569, 686.3376841348123, 602.4848754315085, 662.9436497897636, 664.8204984654117, 698.8078278473461, 703.4372501998381, 8852.114788521096, 8866.33502487316, 9443.575039123256, 9731.951340243253, 9814.803703925882, 452.3734627540814, 514.8995945790609, 537.9853240768172, 650.9674516274167, 690.9861802763917, 4141.213169497786, 4254.617084462351, 4757.83871800469, 4848.7090774553635, 4882.438519570223, 109150.0, 120079.19881201789, 144650.0, 150928.0, 155568.44431555766, 130556.0, 130953.0, 131616.0, 132028.0, 132281.33859330835, 96997.57506062405, 98207.50896245617, 105991.94008059974, 112816.0, 117203.0, 9527.904720952702, 9620.567074481805, 10018.298719089886, 10070.8489372658, 10074.093331600192, 56683.716581416826, 57894.84210315686, 58023.709881450326, 59139.22582322537, 62846.685766570874, 79303.0, 85673.0, 87677.0, 89652.0, 90636.18727625543, 12953.676158096123, 13250.933745331597, 13444.193348399127, 13537.59387218385, 13904.30478476052, 14856.480023199136, 14932.7760083601, 15019.249037548298, 15215.315310810818, 15536.0, 13777.242251675852, 13944.651383715083, 13947.442102315794, 13990.300484975915, 13994.300284985506, 13517.797233041709, 13549.322533873465, 13777.793333100211, 14115.929420352833, 14243.786343205067, 13301.534446294334, 13611.86388136106, 13677.521286754916, 13719.45122195101, 13958.651033724238, 9423.340366174301, 11160.720981975192, 11312.377819220023, 11323.547058117583, 11467.483963221508, 11000.449977501254, 11251.606193783178, 11459.541618335174, 11554.364509952033, 11589.942050289694], "value": 7822.62871870715, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 119.0, 114.0, 116.0, 117.0, 114.0, 113.0, 117.0, 117.0, 117.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 151.0, 129.0, 151.0, 117.0, 117.0, 116.0, 115.0, 161.0, 139.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 202.0, 203.0, 202.0, 215.0, 197.0, 198.0, 198.0, 198.0, 197.0], "value": 201.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 57.0, 57.0, 84.0, 60.0, 61.0, 60.0, 59.0, 78.0, 58.0], "value": 65.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 85.0, 72.0, 68.0, 72.0, 116.0, 101.0, 90.0, 86.0], "value": 84.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 87.0, 88.0, 86.0, 94.0, 86.0, 89.0, 86.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 130.0, 100.0, 101.0, 131.0, 96.0, 95.0, 94.0, 97.0], "value": 103.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 84.0, 86.0, 87.0, 88.0, 100.0, 87.0, 88.0, 94.0], "value": 88.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 56.0, 60.0, 63.0, 61.0, 50.0, 50.0, 92.0], "value": 59.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 77.0, 72.0, 80.0, 75.0, 109.0, 108.0, 110.0, 75.0, 69.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 89.0, 90.0, 91.0, 88.0, 90.0, 93.0, 92.0, 88.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 155.0, 149.0, 157.0, 152.0, 148.0, 148.0, 196.0, 150.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 229.0, 212.0, 178.0, 194.0, 188.0, 171.0, 176.0, 172.0, 176.0], "value": 186.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 67.0, 68.0, 70.0, 70.0, 70.0, 69.0, 68.0, 75.0], "value": 69.8, "unit": "score"}]}]} 10:40:04 INFO - Return code: 0 10:40:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:40:05 ERROR - # TBPL SUCCESS # 10:40:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:40:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:40:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:40:05 INFO - 2016-10-19 10:40:05.048 screenresolution[1677:10918] starting screenresolution argv=screenresolution get 10:40:05 INFO - 2016-10-19 10:40:05.051 screenresolution[1677:10918] Display 0: 1600x1200x32@60 10:40:05 INFO - 2016-10-19 10:40:05.058 screenresolution[1678:10921] starting screenresolution argv=screenresolution list 10:40:05 INFO - Available Modes on Display 0 10:40:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:40:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:40:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:40:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:40:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:40:05 INFO - Intel Iris: 10:40:05 INFO - Chipset Model: Intel Iris 10:40:05 INFO - Type: GPU 10:40:05 INFO - Bus: Built-In 10:40:05 INFO - VRAM (Dynamic, Max): 1536 MB 10:40:05 INFO - Vendor: Intel (0x8086) 10:40:05 INFO - Device ID: 0x0a2e 10:40:05 INFO - Revision ID: 0x0009 10:40:05 INFO - Displays: 10:40:05 INFO - Display: 10:40:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:40:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:40:05 INFO - Display Serial Number: 1600x1200 60 10:40:05 INFO - Main Display: Yes 10:40:05 INFO - Mirror: Off 10:40:05 INFO - Online: Yes 10:40:05 INFO - Rotation: Supported 10:40:05 INFO - Return code: 0 10:40:05 INFO - Running post-action listener: _resource_record_post_action 10:40:05 INFO - [mozharness: 2016-10-19 17:40:05.300115Z] Finished run-tests step (success) 10:40:05 INFO - Running post-run listener: _resource_record_post_run 10:40:05 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 38373888; Write bytes: 711737344; Read time: 246; Write time: 1985 10:40:05 INFO - TinderboxPrint: CPU usage
54.7% 10:40:05 INFO - TinderboxPrint: I/O read bytes / time
38,373,888 / 246 10:40:05 INFO - TinderboxPrint: I/O write bytes / time
711,737,344 / 1,985 10:40:05 INFO - TinderboxPrint: CPU idle
2,196.1 (45.3%) 10:40:05 INFO - TinderboxPrint: CPU system
983.5 (20.3%) 10:40:05 INFO - TinderboxPrint: CPU user
1,666.1 (34.4%) 10:40:05 INFO - TinderboxPrint: Swap in / out
445,140,992 / 0 10:40:05 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 402659840; Write bytes: 392734720; Read time: 29456; Write time: 793 10:40:05 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 31150592; Write bytes: 300709888; Read time: 188; Write time: 1147 10:40:05 INFO - Running post-run listener: _upload_blobber_files 10:40:05 INFO - Blob upload gear active. 10:40:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:40:05 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 10:40:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:40:06 INFO - (blobuploader) - INFO - Open directory for files ... 10:40:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:40:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:40:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:07 INFO - (blobuploader) - INFO - Done attempting. 10:40:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:40:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:40:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:09 INFO - (blobuploader) - INFO - Done attempting. 10:40:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:40:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:40:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:11 INFO - (blobuploader) - INFO - Done attempting. 10:40:11 INFO - (blobuploader) - INFO - Iteration through files over. 10:40:11 INFO - Return code: 0 10:40:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:40:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:40:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cb10c97d771564655f3ad98f96a82881343e984ad56f29b202c1cb9051754d31a6c623c65c55d6dd5bdbf695b881f285b6d23cc11b8e6b6c04d6e64ac9ebbd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ed932212c07768f38fc2f4eb85491bc2ead41c2da26f665ef4034002c3c9233dc8c051b1c6333abde8a6249efad8e8fd71460fbedef34508577daf3108e56c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac2abf08e08554801e7a9d5d9608431732320845d4d64aa2d82d6c8d1686d64ccae6647abb98e6849c96b0ebd776c7d3b8c3743237720165573f68a285b13e32"} 10:40:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:40:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:40:11 INFO - Contents: 10:40:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cb10c97d771564655f3ad98f96a82881343e984ad56f29b202c1cb9051754d31a6c623c65c55d6dd5bdbf695b881f285b6d23cc11b8e6b6c04d6e64ac9ebbd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ed932212c07768f38fc2f4eb85491bc2ead41c2da26f665ef4034002c3c9233dc8c051b1c6333abde8a6249efad8e8fd71460fbedef34508577daf3108e56c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac2abf08e08554801e7a9d5d9608431732320845d4d64aa2d82d6c8d1686d64ccae6647abb98e6849c96b0ebd776c7d3b8c3743237720165573f68a285b13e32"} 10:40:11 INFO - Running post-run listener: copy_logs_to_upload_dir 10:40:11 INFO - Copying logs to upload dir... 10:40:11 INFO - mkdir: /builds/slave/test/build/upload/logs 10:40:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.058562 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-19 10:40:11.577788) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 10:40:11.581928) ========= 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.O9GSSJmgj2/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.xRqgtwytot/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cb10c97d771564655f3ad98f96a82881343e984ad56f29b202c1cb9051754d31a6c623c65c55d6dd5bdbf695b881f285b6d23cc11b8e6b6c04d6e64ac9ebbd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ed932212c07768f38fc2f4eb85491bc2ead41c2da26f665ef4034002c3c9233dc8c051b1c6333abde8a6249efad8e8fd71460fbedef34508577daf3108e56c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac2abf08e08554801e7a9d5d9608431732320845d4d64aa2d82d6c8d1686d64ccae6647abb98e6849c96b0ebd776c7d3b8c3743237720165573f68a285b13e32"} build_url:https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010866 build_url: 'https://queue.taskcluster.net/v1/task/W_szAQOuQMqLpcfbwljePg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cb10c97d771564655f3ad98f96a82881343e984ad56f29b202c1cb9051754d31a6c623c65c55d6dd5bdbf695b881f285b6d23cc11b8e6b6c04d6e64ac9ebbd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ed932212c07768f38fc2f4eb85491bc2ead41c2da26f665ef4034002c3c9233dc8c051b1c6333abde8a6249efad8e8fd71460fbedef34508577daf3108e56c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac2abf08e08554801e7a9d5d9608431732320845d4d64aa2d82d6c8d1686d64ccae6647abb98e6849c96b0ebd776c7d3b8c3743237720165573f68a285b13e32"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 10:40:11.620940) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 10:40:11.621373) ========= 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.O9GSSJmgj2/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.xRqgtwytot/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.004982 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 10:40:11.673100) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 10:40:11.673711) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 10:40:11.674358) ========= ========= Total master_lag: 0.20 =========