builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0093 starttime: 1475646094.93 results: success (0) buildid: 20161004195000 builduid: c97035c1b3cb45fe9a32fe92fd8b415a revision: d3366b063f5231867f2cea79ae229ac4b4e2c63b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 22:41:34.927965) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 22:41:34.928432) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 22:41:34.928713) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 22:41:34.954039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-04 22:41:34.954308) ========= 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.VTxwpS42iT/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.bFTTw2CIRf/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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-04 22:41:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.2M=0.001s 2016-10-04 22:41:35 (20.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137657 ========= master_lag: 2.42 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-04 22:41:37.507967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 22:41:37.508297) ========= 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.VTxwpS42iT/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.bFTTw2CIRf/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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.029028 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 22:41:37.563967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-04 22:41:37.564593) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d3366b063f5231867f2cea79ae229ac4b4e2c63b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d3366b063f5231867f2cea79ae229ac4b4e2c63b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VTxwpS42iT/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.bFTTw2CIRf/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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-04 22:41:37,641 truncating revision to first 12 chars 2016-10-04 22:41:37,641 Setting DEBUG logging. 2016-10-04 22:41:37,641 attempt 1/10 2016-10-04 22:41:37,641 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d3366b063f52?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 22:41:39,374 unpacking tar archive at: fx-team-d3366b063f52/testing/mozharness/ program finished with exit code 0 elapsedTime=1.993481 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-04 22:41:39.583365) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 22:41:39.583682) ========= script_repo_revision: d3366b063f5231867f2cea79ae229ac4b4e2c63b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 22:41:39.584142) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 22:41:39.584483) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 22:41:39.603000) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-04 22:41:39.603619) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VTxwpS42iT/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.bFTTw2CIRf/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 22:41:39 INFO - MultiFileLogger online at 20161004 22:41:39 in /builds/slave/test 22:41:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:41:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:41:39 INFO - {'append_to_log': False, 22:41:39 INFO - 'base_work_dir': '/builds/slave/test', 22:41:39 INFO - 'blob_upload_branch': 'Fx-Team', 22:41:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:41:39 INFO - 'branch': 'Fx-Team', 22:41:39 INFO - 'buildbot_json_path': 'buildprops.json', 22:41:39 INFO - 'config_files': ('talos/mac_config.py',), 22:41:39 INFO - 'default_actions': ('clobber', 22:41:39 INFO - 'read-buildbot-config', 22:41:39 INFO - 'download-and-extract', 22:41:39 INFO - 'populate-webroot', 22:41:39 INFO - 'create-virtualenv', 22:41:39 INFO - 'install', 22:41:39 INFO - 'run-tests'), 22:41:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:41:39 INFO - 'download_minidump_stackwalk': True, 22:41:39 INFO - 'download_symbols': 'ondemand', 22:41:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:41:39 INFO - 'tooltool.py': '/tools/tooltool.py', 22:41:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:41:39 INFO - '/tools/misc-python/virtualenv.py')}, 22:41:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:41:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:41:39 INFO - 'installer_path': 'installer.exe', 22:41:39 INFO - 'log_level': 'info', 22:41:39 INFO - 'log_name': 'talos', 22:41:39 INFO - 'log_to_console': True, 22:41:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:41:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:41:39 INFO - 'opt_config_files': (), 22:41:39 INFO - 'pip_index': False, 22:41:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:41:39 INFO - 'cmd': ('bash', 22:41:39 INFO - '-c', 22:41:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:41:39 INFO - 'enabled': True, 22:41:39 INFO - 'halt_on_failure': False, 22:41:39 INFO - 'name': 'check_screen_resolution'},), 22:41:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:41:39 INFO - 'cmd': ('bash', 22:41:39 INFO - '-c', 22:41:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:41:39 INFO - 'enabled': True, 22:41:39 INFO - 'halt_on_failure': False, 22:41:39 INFO - 'name': 'check_screen_resolution'},), 22:41:39 INFO - 'run_cmd_checks_enabled': True, 22:41:39 INFO - 'sps_profile': False, 22:41:39 INFO - 'sps_profile_interval': 0, 22:41:39 INFO - 'suite': 'dromaeojs-e10s', 22:41:39 INFO - 'system_bits': '32', 22:41:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:41:39 INFO - 'title': 't-yosemite-r7-0093', 22:41:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:41:39 INFO - 'use_talos_json': True, 22:41:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:41:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:41:39 INFO - 'work_dir': 'build'} 22:41:39 INFO - [mozharness: 2016-10-05 05:41:39.804655Z] Running clobber step. 22:41:39 INFO - Running pre-action listener: _resource_record_pre_action 22:41:39 INFO - Running main action method: clobber 22:41:39 INFO - rmtree: /builds/slave/test/build 22:41:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:41:41 INFO - Running post-action listener: _resource_record_post_action 22:41:41 INFO - [mozharness: 2016-10-05 05:41:41.953174Z] Finished clobber step (success) 22:41:41 INFO - [mozharness: 2016-10-05 05:41:41.953329Z] Running read-buildbot-config step. 22:41:41 INFO - Running pre-action listener: _resource_record_pre_action 22:41:41 INFO - Running main action method: read_buildbot_config 22:41:41 INFO - Using buildbot properties: 22:41:41 INFO - { 22:41:41 INFO - "project": "", 22:41:41 INFO - "product": "firefox", 22:41:41 INFO - "script_repo_revision": "production", 22:41:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 22:41:41 INFO - "repository": "", 22:41:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 22:41:41 INFO - "buildid": "20161004195000", 22:41:41 INFO - "pgo_build": "False", 22:41:41 INFO - "basedir": "/builds/slave/test", 22:41:41 INFO - "buildnumber": 137, 22:41:41 INFO - "slavename": "t-yosemite-r7-0093", 22:41:41 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 22:41:41 INFO - "platform": "yosemite_r7", 22:41:41 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 22:41:41 INFO - "branch": "fx-team", 22:41:41 INFO - "repo_path": "integration/fx-team", 22:41:41 INFO - "revision": "d3366b063f5231867f2cea79ae229ac4b4e2c63b", 22:41:41 INFO - "stage_platform": "macosx64", 22:41:41 INFO - "builduid": "c97035c1b3cb45fe9a32fe92fd8b415a", 22:41:41 INFO - "slavebuilddir": "test" 22:41:41 INFO - } 22:41:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 22:41:41 INFO - Running post-action listener: _resource_record_post_action 22:41:41 INFO - [mozharness: 2016-10-05 05:41:41.956728Z] Finished read-buildbot-config step (success) 22:41:41 INFO - [mozharness: 2016-10-05 05:41:41.956830Z] Running download-and-extract step. 22:41:41 INFO - Running pre-action listener: _resource_record_pre_action 22:41:41 INFO - Running main action method: download_and_extract 22:41:41 INFO - mkdir: /builds/slave/test/build/tests 22:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:41:41 INFO - trying https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 22:41:41 INFO - Downloading https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/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 22:41:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/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 22:41:43 INFO - Downloaded 1199 bytes. 22:41:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 22:41:43 INFO - Using the following test package requirements: 22:41:43 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 22:41:43 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:41:43 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 22:41:43 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:41:43 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 22:41:43 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:41:43 INFO - u'jsshell-mac.zip'], 22:41:43 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:41:43 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 22:41:43 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 22:41:43 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:41:43 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 22:41:43 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:41:43 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 22:41:43 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:41:43 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 22:41:43 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:41:43 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 22:41:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:41:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 22:41:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:41:43 INFO - Fetch https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 22:41:43 INFO - Http code: 200 22:41:43 INFO - via: 1.1 1c6cc78b8ca6319854350cf7a741a470.cloudfront.net (CloudFront) 22:41:43 INFO - x-amz-cf-id: 0QHwUB35N_VkK2fStijsQtPOlyx0oTTlqzHP0aihIfp_YlEGxt-z8Q== 22:41:43 INFO - x-amz-version-id: DuLRh4GpRPB_hudKsJLA11BV4RaV08aq 22:41:44 INFO - Expected file size: 16476869 22:41:44 INFO - Obtained file size: 16476869 22:41:50 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 22:41:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 22:41:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:41:50 INFO - Fetch https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 22:41:51 INFO - Http code: 200 22:41:51 INFO - via: 1.1 88972e3933cc06dd11a6fa704a208631.cloudfront.net (CloudFront) 22:41:51 INFO - x-amz-cf-id: AWOAUbCQSE_XuWqqkR3QuzJHxgdlDWHbEn97vOnUjFyzRUneluvL8Q== 22:41:51 INFO - x-amz-version-id: DuLRh4GpRPB_hudKsJLA11BV4RaV08aq 22:41:51 INFO - Expected file size: 16476869 22:41:51 INFO - Obtained file size: 16476869 22:41:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 22:41:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 22:41:57 INFO - Fetch https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 22:41:58 INFO - Http code: 200 22:41:58 INFO - via: 1.1 4a7b695b8ae560fe9087da065a2b7812.cloudfront.net (CloudFront) 22:41:58 INFO - x-amz-cf-id: Wk4RAHPp-G_4_rTVS2listGcscAo3sLbZonIb2X7pkllqISJBeZQDQ== 22:41:58 INFO - x-amz-version-id: 1PduFBbfUo6Uv7qhHEdNXvnymuZiS5jL 22:41:58 INFO - Expected file size: 14409006 22:41:58 INFO - Obtained file size: 14409006 22:41:59 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')]} 22:41:59 INFO - trying https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 22:41:59 INFO - Downloading https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 22:41:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/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 22:42:02 INFO - Downloaded 111717635 bytes. 22:42:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 22:42:02 INFO - mkdir: /builds/slave/test/properties 22:42:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:42:02 INFO - Writing to file /builds/slave/test/properties/build_url 22:42:02 INFO - Contents: 22:42:02 INFO - build_url:https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 22:42:02 INFO - Running post-action listener: _resource_record_post_action 22:42:02 INFO - Running post-action listener: set_extra_try_arguments 22:42:02 INFO - [mozharness: 2016-10-05 05:42:02.696563Z] Finished download-and-extract step (success) 22:42:02 INFO - [mozharness: 2016-10-05 05:42:02.696720Z] Running populate-webroot step. 22:42:02 INFO - Running pre-action listener: _resource_record_pre_action 22:42:02 INFO - Running main action method: populate_webroot 22:42:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:42:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:42:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:42:02 INFO - '--tppagecycles', 22:42:02 INFO - '7'], 22:42:02 INFO - 'tests': ['tsvgm']}}, 22:42:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:42:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:42:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:42:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:42:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:42:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:42:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:02 INFO - 'talos_options': ['--disable-e10s'], 22:42:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:42:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:42:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:02 INFO - 'talos_options': ['--disable-e10s'], 22:42:02 INFO - 'tests': ['damp', 'tps']}, 22:42:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:02 INFO - 'tests': ['damp', 'tps']}, 22:42:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:42:02 INFO - 'tests': ['dromaeo_dom']}, 22:42:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:42:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:42:02 INFO - 'tests': ['basic_compositor_video']}, 22:42:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:42:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:42:02 INFO - 'tests': ['a11yr', 22:42:02 INFO - 'ts_paint', 22:42:02 INFO - 'tpaint', 22:42:02 INFO - 'sessionrestore', 22:42:02 INFO - 'sessionrestore_no_auto_restore', 22:42:02 INFO - 'tabpaint']}, 22:42:02 INFO - 'other-e10s': {'tests': ['a11yr', 22:42:02 INFO - 'ts_paint', 22:42:02 INFO - 'tpaint', 22:42:02 INFO - 'sessionrestore', 22:42:02 INFO - 'sessionrestore_no_auto_restore', 22:42:02 INFO - 'tabpaint']}, 22:42:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:42:02 INFO - 'ts_paint', 22:42:02 INFO - 'tpaint', 22:42:02 INFO - 'sessionrestore', 22:42:02 INFO - 'sessionrestore_no_auto_restore', 22:42:02 INFO - 'tabpaint']}, 22:42:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:42:02 INFO - 'ts_paint', 22:42:02 INFO - 'tpaint', 22:42:02 INFO - 'sessionrestore', 22:42:02 INFO - 'sessionrestore_no_auto_restore', 22:42:02 INFO - 'tabpaint']}, 22:42:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:42:02 INFO - 'tests': ['a11yr', 22:42:02 INFO - 'ts_paint', 22:42:02 INFO - 'tpaint', 22:42:02 INFO - 'sessionrestore', 22:42:02 INFO - 'sessionrestore_no_auto_restore', 22:42:02 INFO - 'tabpaint']}, 22:42:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:42:02 INFO - 'tests': ['a11yr', 22:42:02 INFO - 'ts_paint', 22:42:02 INFO - 'tpaint', 22:42:02 INFO - 'sessionrestore', 22:42:02 INFO - 'sessionrestore_no_auto_restore', 22:42:02 INFO - 'tabpaint']}, 22:42:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:42:02 INFO - 'tests': ['tsvgx', 22:42:02 INFO - 'tsvgr_opacity', 22:42:02 INFO - 'tart', 22:42:02 INFO - 'tscrollx', 22:42:02 INFO - 'cart']}, 22:42:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:42:02 INFO - 'tsvgr_opacity', 22:42:02 INFO - 'tart', 22:42:02 INFO - 'tscrollx', 22:42:02 INFO - 'cart']}, 22:42:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:02 INFO - 'talos_options': ['--disable-e10s'], 22:42:02 INFO - 'tests': ['tp5o']}, 22:42:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:02 INFO - 'tests': ['tp5o']}, 22:42:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:02 INFO - 'talos_options': ['--disable-e10s', 22:42:02 INFO - '--xperf_path', 22:42:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:42:02 INFO - 'tests': ['tp5n']}, 22:42:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:42:02 INFO - 'talos_options': ['--xperf_path', 22:42:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:42:02 INFO - 'tests': ['tp5n']}}, 22:42:02 INFO - 'talos.zip': {'path': '', 22:42:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:42:02 INFO - Running post-action listener: _resource_record_post_action 22:42:02 INFO - [mozharness: 2016-10-05 05:42:02.715429Z] Finished populate-webroot step (success) 22:42:02 INFO - [mozharness: 2016-10-05 05:42:02.715534Z] Running create-virtualenv step. 22:42:02 INFO - Running pre-action listener: _resource_record_pre_action 22:42:02 INFO - Running main action method: create_virtualenv 22:42:02 INFO - Creating virtualenv /builds/slave/test/build/venv 22:42:02 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 22:42:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:42:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:42:02 INFO - Using real prefix '/tools/python27' 22:42:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:42:03 INFO - Installing distribute.............................................................................................................................................................................................done. 22:42:06 INFO - Installing pip.................done. 22:42:06 INFO - Return code: 0 22:42:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:42:06 INFO - Reading from file tmpfile_stdout 22:42:06 INFO - Output received: 22:42:06 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) 22:42:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:42:06 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')]} 22:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:06 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')]} 22:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:06 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 0x10eb6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0cad8dea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e980d30>, '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 0x10e7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e978b20>, '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.VTxwpS42iT/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.bFTTw2CIRf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 22:42:06 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 22:42:06 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 22:42:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VTxwpS42iT/Render', 22:42:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:42:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:42:06 INFO - 'HOME': '/Users/cltbld', 22:42:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:42:06 INFO - 'LOGNAME': 'cltbld', 22:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:06 INFO - 'MOZ_NO_REMOTE': '1', 22:42:06 INFO - 'NO_EM_RESTART': '1', 22:42:06 INFO - 'PAGER': '/bin/cat', 22:42:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:06 INFO - 'PWD': '/builds/slave/test', 22:42:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:42:06 INFO - 'SHELL': '/bin/bash', 22:42:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFTTw2CIRf/Listeners', 22:42:06 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 22:42:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:42:06 INFO - 'USER': 'cltbld', 22:42:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:42:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:06 INFO - 'XPC_FLAGS': '0x0', 22:42:06 INFO - 'XPC_SERVICE_NAME': '0', 22:42:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:06 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 22:42:06 INFO - Cleaning up... 22:42:06 INFO - Return code: 0 22:42:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:42:06 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')]} 22:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:06 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')]} 22:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:06 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 0x10eb6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0cad8dea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e980d30>, '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 0x10e7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e978b20>, '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.VTxwpS42iT/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.bFTTw2CIRf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 22:42:06 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 22:42:06 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 22:42:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VTxwpS42iT/Render', 22:42:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:42:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:42:06 INFO - 'HOME': '/Users/cltbld', 22:42:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:42:06 INFO - 'LOGNAME': 'cltbld', 22:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:06 INFO - 'MOZ_NO_REMOTE': '1', 22:42:06 INFO - 'NO_EM_RESTART': '1', 22:42:06 INFO - 'PAGER': '/bin/cat', 22:42:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:06 INFO - 'PWD': '/builds/slave/test', 22:42:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:42:06 INFO - 'SHELL': '/bin/bash', 22:42:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFTTw2CIRf/Listeners', 22:42:06 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 22:42:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:42:06 INFO - 'USER': 'cltbld', 22:42:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:42:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:06 INFO - 'XPC_FLAGS': '0x0', 22:42:06 INFO - 'XPC_SERVICE_NAME': '0', 22:42:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:07 INFO - Downloading/unpacking psutil>=3.1.1 22:42:07 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 22:42:07 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 22:42:07 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 22:42:07 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 22:42:07 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 22:42:07 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 22:42:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:42:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:42:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:42:10 INFO - Installing collected packages: psutil 22:42:10 INFO - Running setup.py install for psutil 22:42:10 INFO - building 'psutil._psutil_osx' extension 22:42:10 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 22:42:11 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 22:42:11 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 22:42:11 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 22:42:11 INFO - building 'psutil._psutil_posix' extension 22:42:11 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 22:42:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:42:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:42:11 INFO - ^ 22:42:11 INFO - 1 warning generated. 22:42:11 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 22:42:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:42:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:42:11 INFO - Successfully installed psutil 22:42:11 INFO - Cleaning up... 22:42:11 INFO - Return code: 0 22:42:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:42:11 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')]} 22:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:11 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')]} 22:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:11 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 0x10eb6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0cad8dea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e980d30>, '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 0x10e7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e978b20>, '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.VTxwpS42iT/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.bFTTw2CIRf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 22:42:11 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 22:42:11 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 22:42:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VTxwpS42iT/Render', 22:42:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:42:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:42:11 INFO - 'HOME': '/Users/cltbld', 22:42:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:42:11 INFO - 'LOGNAME': 'cltbld', 22:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:11 INFO - 'MOZ_NO_REMOTE': '1', 22:42:11 INFO - 'NO_EM_RESTART': '1', 22:42:11 INFO - 'PAGER': '/bin/cat', 22:42:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:11 INFO - 'PWD': '/builds/slave/test', 22:42:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:42:11 INFO - 'SHELL': '/bin/bash', 22:42:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFTTw2CIRf/Listeners', 22:42:11 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 22:42:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:42:11 INFO - 'USER': 'cltbld', 22:42:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:42:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:11 INFO - 'XPC_FLAGS': '0x0', 22:42:11 INFO - 'XPC_SERVICE_NAME': '0', 22:42:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:42:12 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 22:42:12 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 22:42:12 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 22:42:12 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 22:42:12 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 22:42:12 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 22:42:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:42:14 INFO - Installing collected packages: mozsystemmonitor 22:42:14 INFO - Running setup.py install for mozsystemmonitor 22:42:14 INFO - Successfully installed mozsystemmonitor 22:42:14 INFO - Cleaning up... 22:42:14 INFO - Return code: 0 22:42:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:42:14 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')]} 22:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:14 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')]} 22:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:14 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 0x10eb6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0cad8dea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e980d30>, '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 0x10e7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e978b20>, '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.VTxwpS42iT/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.bFTTw2CIRf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 22:42:14 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 22:42:14 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 22:42:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VTxwpS42iT/Render', 22:42:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:42:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:42:14 INFO - 'HOME': '/Users/cltbld', 22:42:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:42:14 INFO - 'LOGNAME': 'cltbld', 22:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:14 INFO - 'MOZ_NO_REMOTE': '1', 22:42:14 INFO - 'NO_EM_RESTART': '1', 22:42:14 INFO - 'PAGER': '/bin/cat', 22:42:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:14 INFO - 'PWD': '/builds/slave/test', 22:42:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:42:14 INFO - 'SHELL': '/bin/bash', 22:42:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFTTw2CIRf/Listeners', 22:42:14 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 22:42:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:42:14 INFO - 'USER': 'cltbld', 22:42:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:42:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:14 INFO - 'XPC_FLAGS': '0x0', 22:42:14 INFO - 'XPC_SERVICE_NAME': '0', 22:42:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:15 INFO - Downloading/unpacking jsonschema==2.5.1 22:42:15 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 22:42:15 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 22:42:15 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 22:42:15 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 22:42:15 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 22:42:15 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 22:42:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:42:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:17 INFO - Downloading functools32-3.2.3-2.tar.gz 22:42:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:42:18 INFO - warning: no files found matching '*.txt' 22:42:18 INFO - no previously-included directories found matching 'build' 22:42:18 INFO - no previously-included directories found matching 'dist' 22:42:18 INFO - no previously-included directories found matching '.git*' 22:42:18 INFO - Installing collected packages: jsonschema, functools32 22:42:18 INFO - Running setup.py install for functools32 22:42:18 INFO - warning: no files found matching '*.txt' 22:42:18 INFO - no previously-included directories found matching 'build' 22:42:18 INFO - no previously-included directories found matching 'dist' 22:42:18 INFO - no previously-included directories found matching '.git*' 22:42:18 INFO - Successfully installed jsonschema functools32 22:42:18 INFO - Cleaning up... 22:42:18 INFO - Return code: 0 22:42:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:42: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')]} 22:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42: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')]} 22:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:18 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 0x10eb6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0cad8dea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e980d30>, '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 0x10e7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e978b20>, '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.VTxwpS42iT/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.bFTTw2CIRf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 22:42:18 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 22:42:18 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 22:42:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VTxwpS42iT/Render', 22:42:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:42:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:42:18 INFO - 'HOME': '/Users/cltbld', 22:42:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:42:18 INFO - 'LOGNAME': 'cltbld', 22:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:18 INFO - 'MOZ_NO_REMOTE': '1', 22:42:18 INFO - 'NO_EM_RESTART': '1', 22:42:18 INFO - 'PAGER': '/bin/cat', 22:42:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:18 INFO - 'PWD': '/builds/slave/test', 22:42:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:42:18 INFO - 'SHELL': '/bin/bash', 22:42:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFTTw2CIRf/Listeners', 22:42:18 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 22:42:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:42:18 INFO - 'USER': 'cltbld', 22:42:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:42:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:18 INFO - 'XPC_FLAGS': '0x0', 22:42:18 INFO - 'XPC_SERVICE_NAME': '0', 22:42:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:42:18 INFO - Cleaning up... 22:42:18 INFO - Return code: 0 22:42:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:42: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')]} 22:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42: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')]} 22:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:18 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 0x10eb6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0cad8dea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e980d30>, '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 0x10e7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e978b20>, '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.VTxwpS42iT/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.bFTTw2CIRf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 22:42:18 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 22:42:18 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 22:42:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VTxwpS42iT/Render', 22:42:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:42:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:42:18 INFO - 'HOME': '/Users/cltbld', 22:42:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:42:18 INFO - 'LOGNAME': 'cltbld', 22:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:18 INFO - 'MOZ_NO_REMOTE': '1', 22:42:18 INFO - 'NO_EM_RESTART': '1', 22:42:18 INFO - 'PAGER': '/bin/cat', 22:42:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:18 INFO - 'PWD': '/builds/slave/test', 22:42:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:42:18 INFO - 'SHELL': '/bin/bash', 22:42:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFTTw2CIRf/Listeners', 22:42:18 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 22:42:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:42:18 INFO - 'USER': 'cltbld', 22:42:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:42:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:18 INFO - 'XPC_FLAGS': '0x0', 22:42:18 INFO - 'XPC_SERVICE_NAME': '0', 22:42:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:18 INFO - Downloading/unpacking blobuploader==1.2.4 22:42:18 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 22:42:18 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 22:42:18 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 22:42:18 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 22:42:18 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 22:42:18 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 22:42:21 INFO - Downloading blobuploader-1.2.4.tar.gz 22:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:42:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:42:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:22 INFO - Downloading docopt-0.6.1.tar.gz 22:42:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:42:22 INFO - Installing collected packages: blobuploader, requests, docopt 22:42:22 INFO - Running setup.py install for blobuploader 22:42:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:42:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:42:22 INFO - Running setup.py install for requests 22:42:23 INFO - Running setup.py install for docopt 22:42:23 INFO - Successfully installed blobuploader requests docopt 22:42:23 INFO - Cleaning up... 22:42:23 INFO - Return code: 0 22:42:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:42:23 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')]} 22:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:23 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')]} 22:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:23 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 0x10eb6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0cad8dea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e980d30>, '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 0x10e7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e978b20>, '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.VTxwpS42iT/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.bFTTw2CIRf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 22:42:23 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 22:42:23 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 22:42:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VTxwpS42iT/Render', 22:42:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:42:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:42:23 INFO - 'HOME': '/Users/cltbld', 22:42:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:42:23 INFO - 'LOGNAME': 'cltbld', 22:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:23 INFO - 'MOZ_NO_REMOTE': '1', 22:42:23 INFO - 'NO_EM_RESTART': '1', 22:42:23 INFO - 'PAGER': '/bin/cat', 22:42:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:23 INFO - 'PWD': '/builds/slave/test', 22:42:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:42:23 INFO - 'SHELL': '/bin/bash', 22:42:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFTTw2CIRf/Listeners', 22:42:23 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 22:42:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:42:23 INFO - 'USER': 'cltbld', 22:42:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:42:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:23 INFO - 'XPC_FLAGS': '0x0', 22:42:23 INFO - 'XPC_SERVICE_NAME': '0', 22:42:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:42:23 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-s0UbkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:42:23 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-sE8Q4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:42:23 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-PUOIj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:42:24 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-XMq375-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:42:24 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-wWiUuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:42:24 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-uwztqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:42:24 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-5rVFT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:42:24 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-td4wVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:42:24 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-b6igZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:42:24 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-xPvL5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:42:24 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-mL90UA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:42:24 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-ZS09AZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:42:24 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-ZqeJLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:42:25 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-Z0dEmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:42:25 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-gIHBUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:42:25 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-BEHeaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:42:25 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-CWLHZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:42:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:42:25 INFO - Running setup.py install for manifestparser 22:42:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:42:25 INFO - Running setup.py install for mozcrash 22:42:25 INFO - Running setup.py install for mozdebug 22:42:25 INFO - Running setup.py install for mozdevice 22:42:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:42:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:42:26 INFO - Running setup.py install for mozfile 22:42:26 INFO - Running setup.py install for mozhttpd 22:42:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:42:26 INFO - Running setup.py install for mozinfo 22:42:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:42:26 INFO - Running setup.py install for mozInstall 22:42:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:42:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:42:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:42:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:42:26 INFO - Running setup.py install for mozleak 22:42:26 INFO - Running setup.py install for mozlog 22:42:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:42:26 INFO - Running setup.py install for moznetwork 22:42:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:42:27 INFO - Running setup.py install for mozprocess 22:42:27 INFO - Running setup.py install for mozprofile 22:42:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:42:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:42:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:42:27 INFO - Running setup.py install for mozrunner 22:42:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:42:27 INFO - Running setup.py install for mozscreenshot 22:42:27 INFO - Running setup.py install for moztest 22:42:27 INFO - Running setup.py install for mozversion 22:42:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:42:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:42:28 INFO - Cleaning up... 22:42:28 INFO - Return code: 0 22:42:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:42: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')]} 22:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42: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')]} 22:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:28 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 0x10eb6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0cad8dea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e980d30>, '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 0x10e7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e978b20>, '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.VTxwpS42iT/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.bFTTw2CIRf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 22:42:28 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 22:42:28 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 22:42:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VTxwpS42iT/Render', 22:42:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:42:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:42:28 INFO - 'HOME': '/Users/cltbld', 22:42:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:42:28 INFO - 'LOGNAME': 'cltbld', 22:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:28 INFO - 'MOZ_NO_REMOTE': '1', 22:42:28 INFO - 'NO_EM_RESTART': '1', 22:42:28 INFO - 'PAGER': '/bin/cat', 22:42:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:28 INFO - 'PWD': '/builds/slave/test', 22:42:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:42:28 INFO - 'SHELL': '/bin/bash', 22:42:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFTTw2CIRf/Listeners', 22:42:28 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 22:42:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:42:28 INFO - 'USER': 'cltbld', 22:42:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:42:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:28 INFO - 'XPC_FLAGS': '0x0', 22:42:28 INFO - 'XPC_SERVICE_NAME': '0', 22:42:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:42:28 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-SlX7sH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:42:28 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)) 22:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:42:28 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-qmBCUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:42:28 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)) 22:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:42:28 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-0hsGPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:42:28 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)) 22:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:42:28 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-dxvqhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:42:28 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)) 22:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:42:28 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-g6Buwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:42:28 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)) 22:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:42:28 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-Zv0HnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:42:28 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)) 22:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:42:28 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-RMFGC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:42:29 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)) 22:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:42:29 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-EkUEPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:42:29 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)) 22:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:42:29 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-hlYOpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:42:29 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)) 22:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:42:29 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-gpu3lV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:42:29 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)) 22:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:42:29 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-9OuiFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:42:29 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)) 22:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:42:29 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-AUKmL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:42:29 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)) 22:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:42:29 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-evQgdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:42:29 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)) 22:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:42:29 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-seHP14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:42:29 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)) 22:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:42:29 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-ZbLirp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:42:29 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)) 22:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:42:29 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-Durdf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:42:29 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)) 22:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:42:29 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-9KkPfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:42:30 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)) 22:42:30 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)) 22:42:30 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)) 22:42:30 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)) 22:42:30 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)) 22:42:30 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)) 22:42:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:32 INFO - Downloading blessings-1.6.tar.gz 22:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:42:32 INFO - Installing collected packages: blessings 22:42:32 INFO - Running setup.py install for blessings 22:42:32 INFO - Successfully installed blessings 22:42:32 INFO - Cleaning up... 22:42:32 INFO - Return code: 0 22:42:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:42:33 INFO - Reading from file tmpfile_stdout 22:42:33 INFO - Current package versions: 22:42:33 INFO - blessings == 1.6 22:42:33 INFO - blobuploader == 1.2.4 22:42:33 INFO - docopt == 0.6.1 22:42:33 INFO - functools32 == 3.2.3-2 22:42:33 INFO - jsonschema == 2.5.1 22:42:33 INFO - manifestparser == 1.1 22:42:33 INFO - mozInstall == 1.12 22:42:33 INFO - mozcrash == 0.17 22:42:33 INFO - mozdebug == 0.1 22:42:33 INFO - mozdevice == 0.48 22:42:33 INFO - mozfile == 1.2 22:42:33 INFO - mozhttpd == 0.7 22:42:33 INFO - mozinfo == 0.9 22:42:33 INFO - mozleak == 0.1 22:42:33 INFO - mozlog == 3.4 22:42:33 INFO - moznetwork == 0.27 22:42:33 INFO - mozprocess == 0.23 22:42:33 INFO - mozprofile == 0.28 22:42:33 INFO - mozrunner == 6.12 22:42:33 INFO - mozscreenshot == 0.1 22:42:33 INFO - mozsystemmonitor == 0.3 22:42:33 INFO - moztest == 0.7 22:42:33 INFO - mozversion == 1.4 22:42:33 INFO - psutil == 3.1.1 22:42:33 INFO - requests == 1.2.3 22:42:33 INFO - wsgiref == 0.1.2 22:42:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:42: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')]} 22:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42: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')]} 22:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:34 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 0x10eb6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0cad8dea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e980d30>, '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 0x10e7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e978b20>, '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.VTxwpS42iT/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.bFTTw2CIRf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 22:42:34 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 22:42:34 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 22:42:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VTxwpS42iT/Render', 22:42:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:42:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:42:34 INFO - 'HOME': '/Users/cltbld', 22:42:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:42:34 INFO - 'LOGNAME': 'cltbld', 22:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:34 INFO - 'MOZ_NO_REMOTE': '1', 22:42:34 INFO - 'NO_EM_RESTART': '1', 22:42:34 INFO - 'PAGER': '/bin/cat', 22:42:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:34 INFO - 'PWD': '/builds/slave/test', 22:42:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:42:34 INFO - 'SHELL': '/bin/bash', 22:42:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFTTw2CIRf/Listeners', 22:42:34 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 22:42:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:42:34 INFO - 'USER': 'cltbld', 22:42:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:42:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:34 INFO - 'XPC_FLAGS': '0x0', 22:42:34 INFO - 'XPC_SERVICE_NAME': '0', 22:42:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:34 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)) 22:42:34 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)) 22:42:34 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)) 22:42:34 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)) 22:42:34 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)) 22:42:34 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)) 22:42:34 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)) 22:42:34 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)) 22:42:34 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)) 22:42:34 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)) 22:42:34 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)) 22:42:34 INFO - Cleaning up... 22:42:34 INFO - Return code: 0 22:42:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eb6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0cad8dea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e980d30>, '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 0x10e7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e978b20>, '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.VTxwpS42iT/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.bFTTw2CIRf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 22:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:42:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VTxwpS42iT/Render', 22:42:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:42:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:42:34 INFO - 'HOME': '/Users/cltbld', 22:42:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:42:34 INFO - 'LOGNAME': 'cltbld', 22:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:34 INFO - 'MOZ_NO_REMOTE': '1', 22:42:34 INFO - 'NO_EM_RESTART': '1', 22:42:34 INFO - 'PAGER': '/bin/cat', 22:42:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:34 INFO - 'PWD': '/builds/slave/test', 22:42:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:42:34 INFO - 'SHELL': '/bin/bash', 22:42:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFTTw2CIRf/Listeners', 22:42:34 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 22:42:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:42:34 INFO - 'USER': 'cltbld', 22:42:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:42:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:34 INFO - 'XPC_FLAGS': '0x0', 22:42:34 INFO - 'XPC_SERVICE_NAME': '0', 22:42:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:42:34 INFO - Cleaning up... 22:42:34 INFO - Return code: 0 22:42:34 INFO - Running post-action listener: _resource_record_post_action 22:42:34 INFO - Running post-action listener: _start_resource_monitoring 22:42:34 INFO - Starting resource monitoring. 22:42:34 INFO - [mozharness: 2016-10-05 05:42:34.941292Z] Finished create-virtualenv step (success) 22:42:34 INFO - [mozharness: 2016-10-05 05:42:34.942270Z] Running install step. 22:42:34 INFO - Running pre-action listener: _resource_record_pre_action 22:42:34 INFO - Running main action method: install 22:42:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:42:35 INFO - Reading from file tmpfile_stdout 22:42:35 INFO - Detecting whether we're running mozinstall >=1.0... 22:42:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:42:35 INFO - Reading from file tmpfile_stdout 22:42:35 INFO - Output received: 22:42:35 INFO - Usage: mozinstall [options] installer 22:42:35 INFO - Options: 22:42:35 INFO - -h, --help show this help message and exit 22:42:35 INFO - -d DEST, --destination=DEST 22:42:35 INFO - Directory to install application into. [default: 22:42:35 INFO - "/builds/slave/test"] 22:42:35 INFO - --app=APP Application being installed. [default: firefox] 22:42:35 INFO - mkdir: /builds/slave/test/build/application 22:42:35 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'] 22:42:35 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 22:43:09 INFO - Reading from file tmpfile_stdout 22:43:09 INFO - Output received: 22:43:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:43:09 INFO - Running post-action listener: _resource_record_post_action 22:43:09 INFO - [mozharness: 2016-10-05 05:43:09.686382Z] Finished install step (success) 22:43:09 INFO - [mozharness: 2016-10-05 05:43:09.686492Z] Running run-tests step. 22:43:09 INFO - Running pre-action listener: _resource_record_pre_action 22:43:09 INFO - Running main action method: run_tests 22:43:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:43:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:43:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:43:09 INFO - 2016-10-04 22:43:09.699 screenresolution[1639:7402] starting screenresolution argv=screenresolution get 22:43:09 INFO - 2016-10-04 22:43:09.701 screenresolution[1639:7402] Display 0: 1600x1200x32@60 22:43:09 INFO - 2016-10-04 22:43:09.706 screenresolution[1640:7404] starting screenresolution argv=screenresolution list 22:43:09 INFO - Available Modes on Display 0 22:43:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:43:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:43:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:43:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:43:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:43:09 INFO - Intel Iris: 22:43:09 INFO - Chipset Model: Intel Iris 22:43:09 INFO - Type: GPU 22:43:09 INFO - Bus: Built-In 22:43:09 INFO - VRAM (Dynamic, Max): 1536 MB 22:43:09 INFO - Vendor: Intel (0x8086) 22:43:09 INFO - Device ID: 0x0a2e 22:43:09 INFO - Revision ID: 0x0009 22:43:09 INFO - Displays: 22:43:09 INFO - Display: 22:43:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:43:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:43:09 INFO - Display Serial Number: 1600x1200 60 22:43:09 INFO - Main Display: Yes 22:43:09 INFO - Mirror: Off 22:43:09 INFO - Online: Yes 22:43:09 INFO - Rotation: Supported 22:43:09 INFO - Return code: 0 22:43:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:43:09 INFO - Python 2.7.3 22:43:09 INFO - Return code: 0 22:43:09 INFO - grabbing minidump binary from tooltool 22:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:43:09 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 0x10e980d30>, '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 0x10e7a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e978b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:43:09 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 22:43:09 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 22:43:09 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 22:43:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:43:10 INFO - Return code: 0 22:43:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:43:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:43:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:43:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:43:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0093', '--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 22:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0093 --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 22:43:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VTxwpS42iT/Render', 22:43:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:43:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:43:10 INFO - 'HOME': '/Users/cltbld', 22:43:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:43:10 INFO - 'LOGNAME': 'cltbld', 22:43:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:43:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:10 INFO - 'MOZ_NO_REMOTE': '1', 22:43:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:43:10 INFO - 'NO_EM_RESTART': '1', 22:43:10 INFO - 'PAGER': '/bin/cat', 22:43:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:43:10 INFO - 'PWD': '/builds/slave/test', 22:43:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:43:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:43:10 INFO - 'SHELL': '/bin/bash', 22:43:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFTTw2CIRf/Listeners', 22:43:10 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 22:43:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:43:10 INFO - 'USER': 'cltbld', 22:43:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:43:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:10 INFO - 'XPC_FLAGS': '0x0', 22:43:10 INFO - 'XPC_SERVICE_NAME': '0', 22:43:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:43:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0093', '--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 22:43:10 INFO - mozversion application_buildid: 20161004195000 22:43:10 INFO - mozversion application_changeset: d3366b063f5231867f2cea79ae229ac4b4e2c63b 22:43:10 INFO - mozversion application_display_name: Nightly 22:43:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:43:10 INFO - mozversion application_name: Firefox 22:43:10 INFO - mozversion application_remotingname: firefox 22:43:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:43:10 INFO - mozversion application_vendor: Mozilla 22:43:10 INFO - mozversion application_version: 52.0a1 22:43:10 INFO - mozversion platform_buildid: 20161004195000 22:43:10 INFO - mozversion platform_changeset: d3366b063f5231867f2cea79ae229ac4b4e2c63b 22:43:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:43:10 INFO - mozversion platform_version: 52.0a1 22:43:10 INFO - using testdate: 1475646190 22:43:10 INFO - actual date: 1475646190 22:43:10 INFO - starting webserver on 'localhost:49273' 22:43:10 INFO - SUITE-START | Running 2 tests 22:43:10 INFO - TEST-START | dromaeo_css 22:43:10 INFO - operating with platform_type : mac_ 22:43:10 INFO - Initialising browser for dromaeo_css test... 22:43:10 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmphVWPIZ/profile http://localhost:49273/getInfo.html) 22:43:13 INFO - PROCESS | 1650 | 2016-10-04 22:43:13.173 plugin-container[1652:7560] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 22:43:13 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:43:13 INFO - PROCESS | 1650 | 2016-10-04 22:43:13.176 plugin-container[1652:7560] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b1b, name = 'com.apple.CFPasteboardClient' 22:43:13 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:43:13 INFO - PROCESS | 1650 | 2016-10-04 22:43:13.176 plugin-container[1652:7560] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 22:43:13 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 22:43:13 INFO - PROCESS | 1650 | colorDepth:24 22:43:13 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 22:43:13 INFO - PROCESS | 1650 | __metrics 22:43:13 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 22:43:13 INFO - TEST-INFO | 1650: exit 0 22:43:13 INFO - Browser initialized. 22:43:13 INFO - Running cycle 1/1 for dromaeo_css test... 22:43:13 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmphVWPIZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:43:16 INFO - PROCESS | 1653 | 2016-10-04 22:43:16.390 plugin-container[1654:7681] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b23, name = 'com.apple.tsm.portname' 22:43:16 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:43:16 INFO - PROCESS | 1653 | 2016-10-04 22:43:16.392 plugin-container[1654:7681] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9203, name = 'com.apple.CFPasteboardClient' 22:43:16 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:43:16 INFO - PROCESS | 1653 | 2016-10-04 22:43:16.392 plugin-container[1654:7681] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 22:43:26 INFO - PROCESS | 1653 | RSS: Main: 240279552 22:43:26 INFO - PROCESS | 1653 | 22:44:15 INFO - PROCESS | 1653 | 1475646255747 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] 22:46:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 22:46:30 INFO - PROCESS | 1653 | RSS: Main: 251670528 22:46:30 INFO - PROCESS | 1653 | 22:49:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 22:49:33 INFO - PROCESS | 1653 | RSS: Main: 265809920 22:49:33 INFO - PROCESS | 1653 | 22:52:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 22:52:36 INFO - PROCESS | 1653 | RSS: Main: 270413824 22:52:36 INFO - PROCESS | 1653 | 22:55:37 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 22:55:38 INFO - PROCESS | 1653 | RSS: Main: 270217216 22:55:38 INFO - PROCESS | 1653 | 22:58:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 22:58:42 INFO - PROCESS | 1653 | RSS: Main: 275554304 22:58:42 INFO - PROCESS | 1653 | 23:01:44 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 23:01:45 INFO - PROCESS | 1653 | RSS: Main: 278274048 23:01:45 INFO - PROCESS | 1653 | 23:01:45 INFO - PROCESS | 1653 | __start_tp_report 23:01:45 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 23:01:45 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 23:01:45 INFO - PROCESS | 1653 | |i|pagename|runs| 23:01:45 INFO - PROCESS | 1653 | |0;dojo.html;2881.4669286182043;3083.8458077096147;3123.3284843758593;3430.4511278195464;3435.519027336173;4745.667803253774;5910.46805787479;5910.497607703345;5946.910796338053;6041.607295525788;5848.239728835246;5943.732532036058;5947.643141411519;6037.637741735488;6076.118962750398;4339.479262488506;4508.864734057984;5284.339457567804;5304.124819404794;5384.542313903323;5296.993571221475;5394.703291318976;5422.566194704434;5428.131498960167;5475.425080366564;5224.529792318672;5279.736013199325;5342.439043900412;5356.276902618136;5382.4886635769735;5249.16013437852;5266.078436273637;5311.62818602698;5352;5381.569474442035;5260.92108618371;5275.446078161776;5311.442298558634;5316.946830531684;5332.866678333034;4634.374359461463;5755.539556835443;5793.783305505849;5953.613015154001;5977.073553599199;6109.205803245594;6156.138140660311;6181.6600086995195;6189.16446279751;6248.718807653621;6344.206974128234;6354.5551811373225;6362;6370.777022804226;6384.52116091295;6025.246844144482;6041.486473649789;6041.6072955258205;6064.666443345658;6065.727042283108;5969.940300597025;6093.2078829751845;6287.779927702509;6302.621842689453;6343.873122537616;6135.601185922901;6182.629042257479;6189.412005859436;6229.127922090911;6233.002719564848;6113.689152827286;6266.874662506724;6304.495640348761;6314.873702525923;6322.71547780351;6085.421884920926;6165;6169.784057557964;6188.44304012632;6210.5652604317265;5812.651240925558;6219.782307619302;6229.968850155811;6244.2819075806865;6249.937500624936;4212.515560710557;5042.722650254272;5049.495050494921;5064.34163558735;5078.238264260317;4409.162259170747;4425.933610995838;4455.75493347869;4489.2592722201125;4519.028408892104;5954.345022047572;5967.970160149258;6009.489193418521;6032.607880487754;6065.181200537871;6217.533684973645;6320.905186422207;6332.525060620472;6338.683065846689;6353.396427339396;5842.094475356326;5896.557758168155;5935.703214839241;6030.939690603125;6060.757569697163;5455.354153235678;5516.641418307878;5522.22688823565;5562.805301814417;5567.944320556823;6346.238451385863;6351.936480635134;6352.396522330371;6371.299157092809;6380.298167201604;5399.244105825109;5423.7830486780085;6146.200993870768;6326.9683651581445;6347.016212487072;4808.831690890942;4922.507749225048;6193.473554747717;6224.968875155595;6293.307736149111;5291.550218231493;6181.35095814933;6211.937880621136;6229.844253893689;6237;5112.3865136183895;5376.413957882356;6126.761967422386;6247.12540244357;6259.906101408392;5747.4252574742195;5970.552208584287;6130.122981477994;6156.753729850935;6194.81415557534;6138.294096178996;6191.473724733268;6201.627902325875;6211.16149319836;6221.5333849960525;6006.549508786771;6054.576179667381;6083.969580152071;6112.8777424452155;6169.722362493609;6145.6927153641245;6184.752609895554;6198.194234749454;6207.81376558704;6211.360171926823;6069.878602428015;6134.141220229082;6137.232845894263;6155.938440615537;6177.949748542668 23:01:45 INFO - PROCESS | 1653 | |1;ext.html;456.9268916973283;481.52329194097837;495.641941081437;503.2627201150314;579.797071025141;32103;39505.80247098768;39759.60240397595;39785;39787.40318895215;33530.66469335312;41225.79387103068;42032.57967420325;42151.57848421515;42245.57754422455;9605.759856003604;9852.655157069505;9861.260405469582;9895.307328487008;9964.252681048914;9630.133288004079;9738.951305243463;9760.755981100458;9795.559199836025;9803.31376803624;9761.560729767141;9768.120869121778;9772.120509154174;9840.606375744961;9853.852192217086;9702.514874256294;9749.171320437772;9754.02459754026;9754.317197796121;9804.411735295906;9679.08048735369;9796.216302695768;9824.361416507903;9828.410295382228;9835.852462213072;38509.807450962566;38740.45038198469;38797.22405551873;38827.8351649451;38869;3520.77114987525;3538.964610353915;4044.1507283470505;4054.2296963576828;4081.6938729595104;30419.543706844415;31136;31485.37029259402;31568.368632627447;31569.684303156904;3223.06531105979;3353.2287573857907;3379.307242015381;3424.298018906118;3424.5890493140982;467466;468616;468937;469586;471315.1473941038;59975.20074397775;60849;60952;61040.38959610436;61066.38933610607;60614.39385606087;61348;61444.38555614387;61478.77042459126;61551.692241538505;16217.918910405373;16234.837651623333;16244.269007894673;16452.588685282964;16503.752443713354;12367;12464.439100240512;12678.556250531186;12705.809412858815;12725.93637031809;16227.513174604781;16661.750073748903;16709.749353759704;16734.49796506107;16735.748963765553;5205.27126202332;5641.956238095965;5774.5169577081415;6278.654673992883;6387.744490220432;737.4837613670452;899.9010108888017;949.0936155971169;963.7264087806122;1067.5409573883148;29821.85089074541;29917.551236731466;30428.695713042587;30686.693133068384;31184.688153118634;1025.1183981775666;1048.9632862849764;1063.2822844579878;1088.8856670049688;1134.1097238667771;13381.53164639233;14754.40982360715;15034.774478382833;15830.366785328459;15941.282642281125;644817;648959;650525;650810;652268.7386563037;58608;58798.82402351929;58867.705661472275;58894;58904;1329.1891945912985;1370.2532119994628;1382.315753701904;1389.2220356600337;1394.5049507424922;26493.470130597667;28303.71696283011;30269.394612107193;30374.088777336714;31091.22271943129;51700.74149629228;52242.738786305825;52288.47711522836;52418.73790631175;52504.73747631237;563793.1810340922;567734;567936;568058;568527;41015.794921025205;41085;41468.963275918344;41494.377584336864;41779;46410.53589464062;47489.65510389587;47505;47856.282155768386;48395.88634966067;33883.83058084793;39541;39720.60279397169;39892.60107399005;42135.578644213165;36952;38397.61602384052;38786.6121338783;39724.20551588894;40085.799571003125;38161.85514434571;38928.02679933024;38972.83081507559;39442.40836387514;41209.58790412178;31237.68762312348;35178.82410588033;35367.64632353746;35564;35713.821430892676;25977.350566235997;26188.85785303601;26225.082122125634;26548.203553893414;26622.201333960013 23:01:45 INFO - PROCESS | 1653 | |2;jquery.html;367.6360403200831;371.45767179917334;376.78899816102995;380.0839975658663;397.0193621754266;19095.809041909575;21259;21695.45761355967;21775.911204439795;21889;20813;20819;20835.479113022146;20928.372148835522;21282.255121070764;5791.913121303184;5799.072148456248;6002.279726432834;6074.5747797654185;6078.726457309432;4107.507099148106;4345.283028300327;5919.674417907014;5976.581639285252;6292.087647291163;6529.412352888239;6627.2710001899995;6629.801105966804;6647.966760166192;6676.933230667704;5583.748731307101;6592.604443733368;6612.471002319803;6615.735370585171;6626.13860198176;5672.262605861253;5695.060315048012;5722.198892155102;5749.425057494259;5754.539636829044;25394.873025634937;25678.614820777704;25686.743132568623;25930.35174120662;26052.218433447026;2258.7741225877444;2273.658951157323;2399.352174912764;2400.879956002193;3025.7276845084048;15511.146886921215;15596.688066238612;15674.529764107096;15774.76337854933;16456;1805.2598434641734;1844.3544759334125;1859.377108668584;1883.969800632315;1906.551960289331;89967.10032899718;120758;121144.39427802892;123142;123570.76429235772;8675.305975521944;9342.95328523353;9917.553710082919;9931.801363972825;10623.256372054037;11610.361430121255;11831.76336473283;12127.151099422956;12280.140390172603;12314.75370492603;7934.722284720007;8055.275025247756;8060.83878322442;8082.232187942136;8095;7332.450066245053;8317.627591447465;8465.492070475791;8599.226069653761;8625;3786.6024067472517;3866.2074274773604;3872.5740168581433;3921.9607803921594;3935.3900145477496;1562.211083402897;1649;1890.3005887821594;1902.2295970132118;1933.690609502501;834.9958250208831;942.9151376376159;946.6321165915186;987.5802783816993;1005.5525291245326;18933.81066189348;20149.697754533692;21414;21817.472776905783;21830.45423864416;888.6045709659269;936.2556767369957;940.2478017585904;942.3262367407336;986.6941248213077;9209.815803683889;10231.744206394751;11027.456156138147;11508.712282193012;11539.96140347356;506741;519244;520527.1393789687;520668;614094.7181056443;101417;139742;143844;144283;153849.2307538455;999.2206079258045;1003.0671475527829;1041.7656027393775;1041.9374837509774;1050.6270274052754;19211.711824322927;19238.03809809476;19598.922059286877;19699;19713.605727885075;45303.563572371524;51423.742881285354;53811.654708632595;57897;58184.254472365894;78238;79717;81074.59462702648;81186;85668;7015.421530155878;7252.129744430491;7377.668004939684;8182.345412366877;8381.539015354214;10416.635417760343;12989.350532473527;13201.933990329986;13270.535531256359;13479;10692.823789383006;10858.837117443403;11342.376169310437;11397.487113079766;11479.196456247982;10460.63387781424;11266.887331126913;11426.2001659883;11655.475503602527;11847.526098955945;9622.855657165008;10362.844557331797;10981.956714112146;11552.537898483966;11775.352355620524;7322.560646361236;7342.265773422829;7497.587632680255;7561.168271490242;7675.5010924289745;8256.339492840678;11173;11398.575178102737;11433.1996760226;11673.241239319417 23:01:45 INFO - PROCESS | 1653 | |3;mootools.html;1383.6886700492391;1521.619595101225;1719.93120275189;1832.8167183281682;1854.2119599170358;8096.91903080969;8371.790705232372;8581.570921453933;9131.771705707351;9147.222486088682;8593.312534997202;8885.289176865852;8918.554072296392;8958.731238062852;9040.367174297802;2327.1040649349993;2329.161501859338;2339.532093581282;2351.447409858682;2353.399883029825;2036.898155092247;2299.41364951937;2357.0807385119815;2387.1883559589737;2397.5564520563753;2351.5061837014246;2356.575816353056;2370.2652177824843;2386.427257458206;2388.5700573896693;2334.9649755253686;2344.941376465585;2347.448349637834;2361.7638236176417;2366.0062773635113;2286.9199578014855;2291.633338665822;2292.1404473322505;2292.942676433086;2300.493891343918;8528.360372972053;8921.598528066188;8994.32542559304;9057.094290570956;9090.590923408463;5264;5339.41266460689;5415.6479828811;5426.647267927572;5437.619366644337;3533.152043509565;3578.874739384135;3702.4816525686424;3712.350338690718;3718.0890681782867;1048.8531605575226;1079.9028087472086;1082.9025387715144;1091.956321747129;1105.9281146725518;11792.941035294769;11795.997340226006;11875.465604047753;11950.820737688942;11964.82052769209;3611.9097022574647;4069.9389509157386;4371.737695738266;4621;4843.95156048435;8918;9533.189678877374;10038.548265328078;10059.346142500714;10119.544620492095;5373.301470808769;5387.568994480511;5387.703676297841;5393.83818485446;5406.107992181324;3622.5109610202285;4590.219662657356;4786.210275304536;4957.3059771632;5163.845084647466;2947.484190266695;3238.9190270243434;3663.7069034477177;3737.5328083989502;3795.791231482295;1290.3677198173016;1298.2340419152556;1301.9153755005893;1307.8365204349457;1313.7832257677376;830.3274347778198;901.2474583722534;916.5279880861361;917.3349321741817;937.4562753602894;5216;5408.891822163535;5746.396628353963;5891.587588868738;6052.57631965767;434.8673654535334;442.4579889635171;446.31045035419703;448.4797634743747;454.0238487252434;3917.5494818095713;3952.6787792353434;3985.880423587297;4007.338789099824;4040.353543433095;10558.313709609005;10902.291351062155;10909.23635345534;10957.17821163416;10959.452027398598;10773.676789696165;10877.619283325046;10880.510377033053;10907.018368346728;10907.618233361794;8258.339332853357;8364.832703346021;8372.1627837217;8383.329333653293;8395.53824539644;5109.667871588484;5659.377468478382;5763.423657634203;5878.177055212359;5925;10176.185905127424;10238.53926573291;10255.538500767632;10262.538185781508;10332.483375831329;10030.949845250727;10268.435236062089;10305.175585953255;10368;10471.267011309135;6978.720851165896;7157.391621712213;7523.473356864967;7525.8494830102;7621.580813055335;8171.346292296483;8230.259276665129;8334.749957501284;8482.872756908775;8537.658493660185;7450.217727138789;7569.772906812805;7570.507916985378;7639.312461878458;7721.150673426031;6514.3811337922825;6930.960355946649;7444.292792184734;7453.403727701662;7469.327760501581;6937.722491100501;6967.442604591519;7069.469789765891;7084.22073571917;7087.291270872872;4984.177610694195;5035.244713292889;5075.593952483719;5093.745312734422;5113.846584602468;4925.21196608541;4985.800567977385;5004.3994720633755;5068.214426763858;5218.321618189611 23:01:45 INFO - PROCESS | 1653 | |4;prototype.html;299.92801727585373;308.11263560944474;308.7267768025297;313.6346156727413;314.8646082184661;4738.620910327174;5606.046972014757;5613.947447297434;5629.859253518664;5662.971685141573;5203.869903252421;5473.397926228122;5479.698616576086;5585.743207778248;5630.915536266959;4141.565135660758;4162.771047592389;4198.727082739612;4223.72545784523;4232.894177645553;3858.4791053207737;4194.580541945811;4197.18154959783;4237.279662457389;4254.957450425502;4156.272652285853;4212.294020921532;4234.153169366124;4245.830166793325;4253.893652658678;3407.4037043517287;3574.249407624376;3717.498137751396;4128.277551428488;4140.3375459926265;2634.6443230163873;3321.136504508821;3389.2884093532607;3550.6449355064547;3552.609212986569;4667.509911459282;5362.544183744387;5407.729613519308;5437.374701909292;5463.289772329612;4055.71609987301;4352.695311328208;4742.217534106868;4786.593139583139;4810.831620893252;5365.919511207335;5589.891429799094;5865.736041878125;5900.586958912878;5939.881202375928;3317.4194515959853;3335.4329763940186;3511.719062474996;3942.7240093193486;3987.8803635890968;5648.971755141239;6006.759729610811;6134;6250.937490625127;6279.37206279373;3309.4043072247227;3941.349677303213;3948.926813422976;3954.9914771733024;3972.3644216925154;3994.141259629194;4018.2967980603275;4027.9194416111513;4029.899252518652;4049.4128351389472;4157;4699.248120300804;4722.1028004679;4736.194846876039;4777.856664300077;5261.605379596545;5487.5609951203805;5683.403242659544;5856.677882716406;5887.705614719247;1311.2919023727272;1360.0683531780762;1365.0717512091874;1365.4469939674448;1385.8544852790515;700.7736461192912;709.1277728394105;819.3404309530885;838.5723281126669;870.1776820904184;5320.547753441001;5322.494363035506;5368.516833485005;5384.461553844662;5425.13197888336;4939.728314942713;5709;5760.423957604206;5880.648030622589;5929.080992446177;5013.899722005613;5030.974845125751;5345.492178243061;5413.400088940889;5580.130656230127;2866.856657167133;3016.502277124294;3146.4179126861145;3155.8106513609255;3185.124090875028;5292;5588.608797384144;5595.692236926927;5811.593188476851;5858.589898707135;5860.443257890493;5991.071383935497;6075;6105.8168254952425;6178.960942888836;4902.749798801283;5082.357174269433;5524.751386187631;5978.671173085522;6017.578769486094;5136.871578210575;5601.523870470893;5871.1486834409625;5946.851328716817;5953.821385358273;5811.622244554091;5838.569550459994;5892.351841297368;5934.43622855828;5937.109433584997;5749.160268713971;6102.542309326729;6108.419700128481;6121.32665406796;6165.4451099399475;3365.3101114272004;3888.650021498079;3893.2992061429213;3900.707446941434;3920.215956808707;5895.7052147391605;5959.135925290895;5975.641461512323;6008.369121242382;6064.939350606437;4918.39325157667;5563.550598628876;5670.489655930986;5754.683492407958;5835.249425172517;5730.283714535683;5742.684152371659;5749.597528172988;5769.365369809234;5778.8266352009505;4661.696989695659;5660.320761508646;5672.780352224291;5685.464924470452;5712.286314105835;5114.823590574263;5151.068349368987;5502.669839809624;5599;5848.356680765028;4838.298446725275;5253.448387919367;5752.9137062943255;5760.942390576208;5814.244148260699 23:01:45 INFO - PROCESS | 1653 | |5;yui.html;628.403017133723;644.916160899083;672.4015626092776;722.2921536893843;794.4716763352369;15033.323500442479;15892.602684932868;15904.125273109974;15909.84090159098;15996.040237585754;14399.712005759879;14490;14493.78259326111;14510.637234069154;14525;668.6355936014859;691.2292793535197;824.7773101262655;826.0376661189722;850.553459433796;828.4904783558098;856.8115014696788;860.1871231686027;861.6424183963647;861.7587075618836;892.2727976698969;908.9500077495735;912.5665308978215;912.8585069314267;913.8263729891299;869.891263592051;891.8662200669886;895.4582477601056;904.4076130134706;905.7509184974119;671.4326394196896;676.8240257533027;677.8847595908658;678.5962352400363;679.0730652659134;14286.642833929234;14437.278136093259;14514.782278265835;14583.343749531297;14590.343434545472;14258.928705356408;14408.927955360261;14427.639309017253;14433.639159021004;14517.564473065719;11633.418329083512;11701.648950531498;11757.35334556599;11776.941115294369;11797.705057373549;3631.6186800385844;3793.430985352192;3816.2939856126704;3916.236333914888;3954.4661470701376;71385;99116;109039.90960090377;111128.4443577777;111745.32382014276;9180;10991.450427478594;11066.225364224427;11334.659960201207;11578.42107894602;21636.026378812676;21752.673709894363;21904.561908761734;21973.67039494409;22131.225407110673;7995.480293781002;8118.391120665974;8121.269085782308;8177.9591102044105;8212.219839115274;4470.418845550058;4534.841280555164;4540.568645978627;4552.772361381918;4587.541245875453;3627.383344831385;3750.8124593770203;3753.6434038766274;3754.0990162360836;3754.0990162360836;603.474976770204;675.7297081167573;683.6615875141737;686.4885660183196;692.1486571517062;548.2051026012218;578.5718568259458;640.7084776426808;657.0833687006599;685.5715178013742;8606.483610983361;9039.68924505943;9227.215686666708;9426.151646351862;9500.95249523748;616.96915154243;621.3444815719369;667.9899801502982;669.8411747676547;671.1107782188619;4415.470143582726;4628.4445866496235;4643.582077613031;4675.983990326288;4686.297055441642;165683;166515;168846.15576922282;173556;177676.11161944107;121405.39297303457;131822;144572;146345;149500.2524987368;84866.15133848706;95696.52151739197;122699.77300226883;124618.37690811488;127953.36023319824;8799.12008799115;8913.28693704515;8932.910670893209;8973.192412682889;9075.13786190311;67784.6610766943;68461;68591.65704171447;69202.65398672974;69999.65000174966;100674;107587.46206268918;107944;109116.45441772741;109473.35789963316;11484.598039068593;11548.191626586058;11585.536578537101;12081.69795755078;12281.570145044881;12739.476019985941;12853.614391568268;13033.608991730263;13074.477020919438;13143.60569182926;11850.229735067192;11989.520419183134;12087.456064477296;12233.143679942319;12544.372781360713;11993.460294286604;12176.75646487083;12202.75594488123;12402.627921162379;12579.811302830281;11848;11926.463309151282;12036.939815300868;12374.443150058089;12420.813687794509;10215.489225538842;10330.793384132425;10421.270511064153;10894;11017.643931451692;8745.344099192458;10010.199184065112;10683.732906677395;11249.606263780728;11503.137264705349 23:01:45 INFO - PROCESS | 1653 | __end_tp_report 23:01:45 INFO - PROCESS | 1653 | __start_cc_report 23:01:45 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,354 23:01:45 INFO - PROCESS | 1653 | __end_cc_report 23:01:45 INFO - PROCESS | 1653 | __startTimestamp1475647305130__endTimestamp 23:01:45 INFO - PROCESS | 1653 | 23:01:45 INFO - PROCESS | 1653 | ------- Summary: start ------- 23:01:45 INFO - PROCESS | 1653 | Number of tests: 6 23:01:45 INFO - PROCESS | 1653 | 23:01:45 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5756.81 Median:6054.58 stddev:690.97 (11.4%) stddev-sans-first:655.24 23:01:45 INFO - PROCESS | 1653 | Values: 2881.5 3083.8 3123.3 3430.5 3435.5 4745.7 5910.5 5910.5 5946.9 6041.6 5848.2 5943.7 5947.6 6037.6 6076.1 4339.5 4508.9 5284.3 5304.1 5384.5 5297.0 5394.7 5422.6 5428.1 5475.4 5224.5 5279.7 5342.4 5356.3 5382.5 5249.2 5266.1 5311.6 5352.0 5381.6 5260.9 5275.4 5311.4 5316.9 5332.9 4634.4 5755.5 5793.8 5953.6 5977.1 6109.2 6156.1 6181.7 6189.2 6248.7 6344.2 6354.6 6362.0 6370.8 6384.5 6025.2 6041.5 6041.6 6064.7 6065.7 5969.9 6093.2 6287.8 6302.6 6343.9 6135.6 6182.6 6189.4 6229.1 6233.0 6113.7 6266.9 6304.5 6314.9 6322.7 6085.4 6165.0 6169.8 6188.4 6210.6 5812.7 6219.8 6230.0 6244.3 6249.9 4212.5 5042.7 5049.5 5064.3 5078.2 4409.2 4425.9 4455.8 4489.3 4519.0 5954.3 5968.0 6009.5 6032.6 6065.2 6217.5 6320.9 6332.5 6338.7 6353.4 5842.1 5896.6 5935.7 6030.9 6060.8 5455.4 5516.6 5522.2 5562.8 5567.9 6346.2 6351.9 6352.4 6371.3 6380.3 5399.2 5423.8 6146.2 6327.0 6347.0 4808.8 4922.5 6193.5 6225.0 6293.3 5291.6 6181.4 6211.9 6229.8 6237.0 5112.4 5376.4 6126.8 6247.1 6259.9 5747.4 5970.6 6130.1 6156.8 6194.8 6138.3 6191.5 6201.6 6211.2 6221.5 6006.5 6054.6 6084.0 6112.9 6169.7 6145.7 6184.8 6198.2 6207.8 6211.4 6069.9 6134.1 6137.2 6155.9 6177.9 23:01:45 INFO - PROCESS | 1653 | 23:01:45 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:70013.38 Median:41050.40 stddev:151357.30 (368.7%) stddev-sans-first:151691.80 23:01:45 INFO - PROCESS | 1653 | Values: 456.9 481.5 495.6 503.3 579.8 32103.0 39505.8 39759.6 39785.0 39787.4 33530.7 41225.8 42032.6 42151.6 42245.6 9605.8 9852.7 9861.3 9895.3 9964.3 9630.1 9739.0 9760.8 9795.6 9803.3 9761.6 9768.1 9772.1 9840.6 9853.9 9702.5 9749.2 9754.0 9754.3 9804.4 9679.1 9796.2 9824.4 9828.4 9835.9 38509.8 38740.5 38797.2 38827.8 38869.0 3520.8 3539.0 4044.2 4054.2 4081.7 30419.5 31136.0 31485.4 31568.4 31569.7 3223.1 3353.2 3379.3 3424.3 3424.6 467466.0 468616.0 468937.0 469586.0 471315.1 59975.2 60849.0 60952.0 61040.4 61066.4 60614.4 61348.0 61444.4 61478.8 61551.7 16217.9 16234.8 16244.3 16452.6 16503.8 12367.0 12464.4 12678.6 12705.8 12725.9 16227.5 16661.8 16709.7 16734.5 16735.7 5205.3 5642.0 5774.5 6278.7 6387.7 737.5 899.9 949.1 963.7 1067.5 29821.9 29917.6 30428.7 30686.7 31184.7 1025.1 1049.0 1063.3 1088.9 1134.1 13381.5 14754.4 15034.8 15830.4 15941.3 644817.0 648959.0 650525.0 650810.0 652268.7 58608.0 58798.8 58867.7 58894.0 58904.0 1329.2 1370.3 1382.3 1389.2 1394.5 26493.5 28303.7 30269.4 30374.1 31091.2 51700.7 52242.7 52288.5 52418.7 52504.7 563793.2 567734.0 567936.0 568058.0 568527.0 41015.8 41085.0 41469.0 41494.4 41779.0 46410.5 47489.7 47505.0 47856.3 48395.9 33883.8 39541.0 39720.6 39892.6 42135.6 36952.0 38397.6 38786.6 39724.2 40085.8 38161.9 38928.0 38972.8 39442.4 41209.6 31237.7 35178.8 35367.6 35564.0 35713.8 25977.4 26188.9 26225.1 26548.2 26622.2 23:01:45 INFO - PROCESS | 1653 | 23:01:45 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:33639.77 Median:14538.97 stddev:90694.38 (623.8%) stddev-sans-first:90914.39 23:01:45 INFO - PROCESS | 1653 | Values: 367.6 371.5 376.8 380.1 397.0 19095.8 21259.0 21695.5 21775.9 21889.0 20813.0 20819.0 20835.5 20928.4 21282.3 5791.9 5799.1 6002.3 6074.6 6078.7 4107.5 4345.3 5919.7 5976.6 6292.1 6529.4 6627.3 6629.8 6648.0 6676.9 5583.7 6592.6 6612.5 6615.7 6626.1 5672.3 5695.1 5722.2 5749.4 5754.5 25394.9 25678.6 25686.7 25930.4 26052.2 2258.8 2273.7 2399.4 2400.9 3025.7 15511.1 15596.7 15674.5 15774.8 16456.0 1805.3 1844.4 1859.4 1884.0 1906.6 89967.1 120758.0 121144.4 123142.0 123570.8 8675.3 9343.0 9917.6 9931.8 10623.3 11610.4 11831.8 12127.2 12280.1 12314.8 7934.7 8055.3 8060.8 8082.2 8095.0 7332.5 8317.6 8465.5 8599.2 8625.0 3786.6 3866.2 3872.6 3922.0 3935.4 1562.2 1649.0 1890.3 1902.2 1933.7 835.0 942.9 946.6 987.6 1005.6 18933.8 20149.7 21414.0 21817.5 21830.5 888.6 936.3 940.2 942.3 986.7 9209.8 10231.7 11027.5 11508.7 11540.0 506741.0 519244.0 520527.1 520668.0 614094.7 101417.0 139742.0 143844.0 144283.0 153849.2 999.2 1003.1 1041.8 1041.9 1050.6 19211.7 19238.0 19598.9 19699.0 19713.6 45303.6 51423.7 53811.7 57897.0 58184.3 78238.0 79717.0 81074.6 81186.0 85668.0 7015.4 7252.1 7377.7 8182.3 8381.5 10416.6 12989.4 13201.9 13270.5 13479.0 10692.8 10858.8 11342.4 11397.5 11479.2 10460.6 11266.9 11426.2 11655.5 11847.5 9622.9 10362.8 10982.0 11552.5 11775.4 7322.6 7342.3 7497.6 7561.2 7675.5 8256.3 11173.0 11398.6 11433.2 11673.2 23:01:45 INFO - PROCESS | 1653 | 23:01:45 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5707.38 Median:451.25 stddev:3280.83 (727.0%) stddev-sans-first:3273.94 23:01:45 INFO - PROCESS | 1653 | Values: 1383.7 1521.6 1719.9 1832.8 1854.2 8096.9 8371.8 8581.6 9131.8 9147.2 8593.3 8885.3 8918.6 8958.7 9040.4 2327.1 2329.2 2339.5 2351.4 2353.4 2036.9 2299.4 2357.1 2387.2 2397.6 2351.5 2356.6 2370.3 2386.4 2388.6 2335.0 2344.9 2347.4 2361.8 2366.0 2286.9 2291.6 2292.1 2292.9 2300.5 8528.4 8921.6 8994.3 9057.1 9090.6 5264.0 5339.4 5415.6 5426.6 5437.6 3533.2 3578.9 3702.5 3712.4 3718.1 1048.9 1079.9 1082.9 1092.0 1105.9 11792.9 11796.0 11875.5 11950.8 11964.8 3611.9 4069.9 4371.7 4621.0 4844.0 8918.0 9533.2 10038.5 10059.3 10119.5 5373.3 5387.6 5387.7 5393.8 5406.1 3622.5 4590.2 4786.2 4957.3 5163.8 2947.5 3238.9 3663.7 3737.5 3795.8 1290.4 1298.2 1301.9 1307.8 1313.8 830.3 901.2 916.5 917.3 937.5 5216.0 5408.9 5746.4 5891.6 6052.6 434.9 442.5 446.3 448.5 454.0 3917.5 3952.7 3985.9 4007.3 4040.4 10558.3 10902.3 10909.2 10957.2 10959.5 10773.7 10877.6 10880.5 10907.0 10907.6 8258.3 8364.8 8372.2 8383.3 8395.5 5109.7 5659.4 5763.4 5878.2 5925.0 10176.2 10238.5 10255.5 10262.5 10332.5 10030.9 10268.4 10305.2 10368.0 10471.3 6978.7 7157.4 7523.5 7525.8 7621.6 8171.3 8230.3 8334.7 8482.9 8537.7 7450.2 7569.8 7570.5 7639.3 7721.2 6514.4 6931.0 7444.3 7453.4 7469.3 6937.7 6967.4 7069.5 7084.2 7087.3 4984.2 5035.2 5075.6 5093.7 5113.8 4925.2 4985.8 5004.4 5068.2 5218.3 23:01:45 INFO - PROCESS | 1653 | 23:01:45 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4666.89 Median:5364.23 stddev:1466.37 (27.3%) stddev-sans-first:1433.38 23:01:45 INFO - PROCESS | 1653 | Values: 299.9 308.1 308.7 313.6 314.9 4738.6 5606.0 5613.9 5629.9 5663.0 5203.9 5473.4 5479.7 5585.7 5630.9 4141.6 4162.8 4198.7 4223.7 4232.9 3858.5 4194.6 4197.2 4237.3 4255.0 4156.3 4212.3 4234.2 4245.8 4253.9 3407.4 3574.2 3717.5 4128.3 4140.3 2634.6 3321.1 3389.3 3550.6 3552.6 4667.5 5362.5 5407.7 5437.4 5463.3 4055.7 4352.7 4742.2 4786.6 4810.8 5365.9 5589.9 5865.7 5900.6 5939.9 3317.4 3335.4 3511.7 3942.7 3987.9 5649.0 6006.8 6134.0 6250.9 6279.4 3309.4 3941.3 3948.9 3955.0 3972.4 3994.1 4018.3 4027.9 4029.9 4049.4 4157.0 4699.2 4722.1 4736.2 4777.9 5261.6 5487.6 5683.4 5856.7 5887.7 1311.3 1360.1 1365.1 1365.4 1385.9 700.8 709.1 819.3 838.6 870.2 5320.5 5322.5 5368.5 5384.5 5425.1 4939.7 5709.0 5760.4 5880.6 5929.1 5013.9 5031.0 5345.5 5413.4 5580.1 2866.9 3016.5 3146.4 3155.8 3185.1 5292.0 5588.6 5595.7 5811.6 5858.6 5860.4 5991.1 6075.0 6105.8 6179.0 4902.7 5082.4 5524.8 5978.7 6017.6 5136.9 5601.5 5871.1 5946.9 5953.8 5811.6 5838.6 5892.4 5934.4 5937.1 5749.2 6102.5 6108.4 6121.3 6165.4 3365.3 3888.7 3893.3 3900.7 3920.2 5895.7 5959.1 5975.6 6008.4 6064.9 4918.4 5563.6 5670.5 5754.7 5835.2 5730.3 5742.7 5749.6 5769.4 5778.8 4661.7 5660.3 5672.8 5685.5 5712.3 5114.8 5151.1 5502.7 5599.0 5848.4 4838.3 5253.4 5752.9 5760.9 5814.2 23:01:45 INFO - PROCESS | 1653 | 23:01:45 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:25892.72 Median:3691.22 stddev:43055.37 (1166.4%) stddev-sans-first:43134.37 23:01:45 INFO - PROCESS | 1653 | Values: 628.4 644.9 672.4 722.3 794.5 15033.3 15892.6 15904.1 15909.8 15996.0 14399.7 14490.0 14493.8 14510.6 14525.0 668.6 691.2 824.8 826.0 850.6 828.5 856.8 860.2 861.6 861.8 892.3 909.0 912.6 912.9 913.8 869.9 891.9 895.5 904.4 905.8 671.4 676.8 677.9 678.6 679.1 14286.6 14437.3 14514.8 14583.3 14590.3 14258.9 14408.9 14427.6 14433.6 14517.6 11633.4 11701.6 11757.4 11776.9 11797.7 3631.6 3793.4 3816.3 3916.2 3954.5 71385.0 99116.0 109039.9 111128.4 111745.3 9180.0 10991.5 11066.2 11334.7 11578.4 21636.0 21752.7 21904.6 21973.7 22131.2 7995.5 8118.4 8121.3 8178.0 8212.2 4470.4 4534.8 4540.6 4552.8 4587.5 3627.4 3750.8 3753.6 3754.1 3754.1 603.5 675.7 683.7 686.5 692.1 548.2 578.6 640.7 657.1 685.6 8606.5 9039.7 9227.2 9426.2 9501.0 617.0 621.3 668.0 669.8 671.1 4415.5 4628.4 4643.6 4676.0 4686.3 165683.0 166515.0 168846.2 173556.0 177676.1 121405.4 131822.0 144572.0 146345.0 149500.3 84866.2 95696.5 122699.8 124618.4 127953.4 8799.1 8913.3 8932.9 8973.2 9075.1 67784.7 68461.0 68591.7 69202.7 69999.7 100674.0 107587.5 107944.0 109116.5 109473.4 11484.6 11548.2 11585.5 12081.7 12281.6 12739.5 12853.6 13033.6 13074.5 13143.6 11850.2 11989.5 12087.5 12233.1 12544.4 11993.5 12176.8 12202.8 12402.6 12579.8 11848.0 11926.5 12036.9 12374.4 12420.8 10215.5 10330.8 10421.3 10894.0 11017.6 8745.3 10010.2 10683.7 11249.6 11503.1 23:01:45 INFO - PROCESS | 1653 | -------- Summary: end -------- 23:01:45 INFO - PROCESS | 1653 | 23:01:45 INFO - TEST-INFO | 1653: exit 0 23:01:45 INFO - TEST-OK | dromaeo_css | took 1115527ms 23:01:45 INFO - TEST-START | kraken 23:01:45 INFO - operating with platform_type : mac_ 23:01:45 INFO - Initialising browser for kraken test... 23:01:45 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpd4oghq/profile http://localhost:49273/getInfo.html) 23:01:48 INFO - PROCESS | 1664 | 2016-10-04 23:01:48.518 plugin-container[1665:9814] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.tsm.portname' 23:01:48 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:01:48 INFO - PROCESS | 1664 | 2016-10-04 23:01:48.521 plugin-container[1665:9814] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f1b, name = 'com.apple.CFPasteboardClient' 23:01:48 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:01:48 INFO - PROCESS | 1664 | 2016-10-04 23:01:48.521 plugin-container[1665:9814] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:01:48 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 23:01:48 INFO - PROCESS | 1664 | colorDepth:24 23:01:48 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 23:01:48 INFO - PROCESS | 1664 | __metrics 23:01:48 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 23:01:49 INFO - TEST-INFO | 1664: exit 0 23:01:49 INFO - Browser initialized. 23:01:49 INFO - Running cycle 1/1 for kraken test... 23:01:49 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpd4oghq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:01:51 INFO - PROCESS | 1666 | 2016-10-04 23:01:51.793 plugin-container[1667:9936] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b27, name = 'com.apple.tsm.portname' 23:01:51 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:01:51 INFO - PROCESS | 1666 | 2016-10-04 23:01:51.795 plugin-container[1667:9936] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 23:01:51 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:01:51 INFO - PROCESS | 1666 | 2016-10-04 23:01:51.795 plugin-container[1667:9936] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:02:01 INFO - PROCESS | 1666 | RSS: Main: 239898624 23:02:01 INFO - PROCESS | 1666 | 23:02:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 23:02:05 INFO - PROCESS | 1666 | RSS: Main: 253521920 23:02:05 INFO - PROCESS | 1666 | 23:02:08 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 23:02:08 INFO - PROCESS | 1666 | RSS: Main: 260964352 23:02:08 INFO - PROCESS | 1666 | 23:02:12 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 23:02:12 INFO - PROCESS | 1666 | RSS: Main: 261816320 23:02:12 INFO - PROCESS | 1666 | 23:02:14 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 23:02:15 INFO - PROCESS | 1666 | RSS: Main: 263036928 23:02:15 INFO - PROCESS | 1666 | 23:02:17 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:02:17 INFO - PROCESS | 1666 | RSS: Main: 263426048 23:02:17 INFO - PROCESS | 1666 | 23:02:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 23:02:21 INFO - PROCESS | 1666 | RSS: Main: 265412608 23:02:21 INFO - PROCESS | 1666 | 23:02:24 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 23:02:24 INFO - PROCESS | 1666 | RSS: Main: 265297920 23:02:24 INFO - PROCESS | 1666 | 23:02:27 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 23:02:28 INFO - PROCESS | 1666 | RSS: Main: 265859072 23:02:28 INFO - PROCESS | 1666 | 23:02:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:02:30 INFO - PROCESS | 1666 | RSS: Main: 265584640 23:02:30 INFO - PROCESS | 1666 | 23:02:32 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:02:33 INFO - PROCESS | 1666 | RSS: Main: 265854976 23:02:33 INFO - PROCESS | 1666 | 23:02:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:02:35 INFO - PROCESS | 1666 | RSS: Main: 265572352 23:02:35 INFO - PROCESS | 1666 | 23:02:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:02:39 INFO - PROCESS | 1666 | RSS: Main: 265777152 23:02:39 INFO - PROCESS | 1666 | 23:02:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:02:43 INFO - PROCESS | 1666 | RSS: Main: 265953280 23:02:43 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 23:02:45 INFO - PROCESS | 1666 | RSS: Main: 267780096 23:02:45 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | __start_tp_report 23:02:45 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 23:02:45 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 23:02:45 INFO - PROCESS | 1666 | |i|pagename|runs| 23:02:45 INFO - PROCESS | 1666 | |0;ai-astar;105;116;117;122;171;131;114;135;171;96 23:02:45 INFO - PROCESS | 1666 | |1;audio-beat-detection;145;115;112;150;114;116;114;116;143;118 23:02:45 INFO - PROCESS | 1666 | |2;audio-dft;198;201;210;249;201;201;196;195;197;191 23:02:45 INFO - PROCESS | 1666 | |3;audio-fft;72;59;58;85;60;59;59;60;76;59 23:02:45 INFO - PROCESS | 1666 | |4;audio-oscillator;88;69;87;60;67;101;126;104;69;88 23:02:45 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;91;89;91;81;91;87;91;88;89;93 23:02:45 INFO - PROCESS | 1666 | |6;imaging-darkroom;99;109;100;100;100;100;106;99;100;101 23:02:45 INFO - PROCESS | 1666 | |7;imaging-desaturate;91;94;90;93;93;90;92;99;92;98 23:02:45 INFO - PROCESS | 1666 | |8;json-parse-financial;83;84;57;58;59;57;58;58;56;73 23:02:45 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;72;99;107;69;81;93;107;102;100;85 23:02:45 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;87;93;92;89;88;86;90;89;89;92 23:02:45 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;145;149;146;167;171;168;191;162;190;149 23:02:45 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;231;237;174;179;172;165;231;182;174;173 23:02:45 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;69;95;91;90;63;86;90;89;92;75 23:02:45 INFO - PROCESS | 1666 | __end_tp_report 23:02:45 INFO - PROCESS | 1666 | __start_cc_report 23:02:45 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,940 23:02:45 INFO - PROCESS | 1666 | __end_cc_report 23:02:45 INFO - PROCESS | 1666 | __startTimestamp1475647365610__endTimestamp 23:02:45 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | ------- Summary: start ------- 23:02:45 INFO - PROCESS | 1666 | Number of tests: 14 23:02:45 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:127.80 Median:133.00 stddev:25.40 (19.1%) stddev-sans-first:25.56 23:02:45 INFO - PROCESS | 1666 | Values: 105.0 116.0 117.0 122.0 171.0 131.0 114.0 135.0 171.0 96.0 23:02:45 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:117.00 stddev:15.15 (12.9%) stddev-sans-first:14.10 23:02:45 INFO - PROCESS | 1666 | Values: 145.0 115.0 112.0 150.0 114.0 116.0 114.0 116.0 143.0 118.0 23:02:45 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:203.90 Median:201.00 stddev:16.62 (8.3%) stddev-sans-first:17.49 23:02:45 INFO - PROCESS | 1666 | Values: 198.0 201.0 210.0 249.0 201.0 201.0 196.0 195.0 197.0 191.0 23:02:45 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:64.70 Median:60.00 stddev:9.50 (15.8%) stddev-sans-first:9.70 23:02:45 INFO - PROCESS | 1666 | Values: 72.0 59.0 58.0 85.0 60.0 59.0 59.0 60.0 76.0 59.0 23:02:45 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:85.90 Median:69.00 stddev:20.47 (29.7%) stddev-sans-first:21.70 23:02:45 INFO - PROCESS | 1666 | Values: 88.0 69.0 87.0 60.0 67.0 101.0 126.0 104.0 69.0 88.0 23:02:45 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:89.10 Median:91.00 stddev:3.35 (3.7%) stddev-sans-first:3.48 23:02:45 INFO - PROCESS | 1666 | Values: 91.0 89.0 91.0 81.0 91.0 87.0 91.0 88.0 89.0 93.0 23:02:45 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:101.40 Median:103.50 stddev:3.34 (3.2%) stddev-sans-first:3.43 23:02:45 INFO - PROCESS | 1666 | Values: 99.0 109.0 100.0 100.0 100.0 100.0 106.0 99.0 100.0 101.0 23:02:45 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:93.20 Median:93.00 stddev:3.08 (3.3%) stddev-sans-first:3.17 23:02:45 INFO - PROCESS | 1666 | Values: 91.0 94.0 90.0 93.0 93.0 90.0 92.0 99.0 92.0 98.0 23:02:45 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:58.50 stddev:11.24 (19.2%) stddev-sans-first:9.67 23:02:45 INFO - PROCESS | 1666 | Values: 83.0 84.0 57.0 58.0 59.0 57.0 58.0 58.0 56.0 73.0 23:02:45 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:91.50 Median:76.50 stddev:13.99 (18.3%) stddev-sans-first:12.93 23:02:45 INFO - PROCESS | 1666 | Values: 72.0 99.0 107.0 69.0 81.0 93.0 107.0 102.0 100.0 85.0 23:02:45 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:89.50 stddev:2.27 (2.5%) stddev-sans-first:2.22 23:02:45 INFO - PROCESS | 1666 | Values: 87.0 93.0 92.0 89.0 88.0 86.0 90.0 89.0 89.0 92.0 23:02:45 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:163.80 Median:167.50 stddev:17.05 (10.2%) stddev-sans-first:16.68 23:02:45 INFO - PROCESS | 1666 | Values: 145.0 149.0 146.0 167.0 171.0 168.0 191.0 162.0 190.0 149.0 23:02:45 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.80 Median:180.50 stddev:28.82 (16.0%) stddev-sans-first:26.85 23:02:45 INFO - PROCESS | 1666 | Values: 231.0 237.0 174.0 179.0 172.0 165.0 231.0 182.0 174.0 173.0 23:02:45 INFO - PROCESS | 1666 | 23:02:45 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.00 Median:90.00 stddev:10.96 (12.2%) stddev-sans-first:10.20 23:02:45 INFO - PROCESS | 1666 | Values: 69.0 95.0 91.0 90.0 63.0 86.0 90.0 89.0 92.0 75.0 23:02:45 INFO - PROCESS | 1666 | -------- Summary: end -------- 23:02:45 INFO - PROCESS | 1666 | 23:02:46 INFO - TEST-INFO | 1666: exit 0 23:02:46 INFO - TEST-OK | kraken | took 60653ms 23:02:46 INFO - SUITE-END | took 1176s 23:02:46 INFO - Completed test suite (00:19:36) 23:02:46 INFO - javascript benchmark 23:02:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7369.220144640749, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2881.4669286182043, 3083.8458077096147, 3123.3284843758593, 3430.4511278195464, 3435.519027336173, 4745.667803253774, 5910.46805787479, 5910.497607703345, 5946.910796338053, 6041.607295525788, 5848.239728835246, 5943.732532036058, 5947.643141411519, 6037.637741735488, 6076.118962750398, 4339.479262488506, 4508.864734057984, 5284.339457567804, 5304.124819404794, 5384.542313903323, 5296.993571221475, 5394.703291318976, 5422.566194704434, 5428.131498960167, 5475.425080366564, 5224.529792318672, 5279.736013199325, 5342.439043900412, 5356.276902618136, 5382.4886635769735, 5249.16013437852, 5266.078436273637, 5311.62818602698, 5352.0, 5381.569474442035, 5260.92108618371, 5275.446078161776, 5311.442298558634, 5316.946830531684, 5332.866678333034, 4634.374359461463, 5755.539556835443, 5793.783305505849, 5953.613015154001, 5977.073553599199, 6109.205803245594, 6156.138140660311, 6181.6600086995195, 6189.16446279751, 6248.718807653621, 6344.206974128234, 6354.5551811373225, 6362.0, 6370.777022804226, 6384.52116091295, 6025.246844144482, 6041.486473649789, 6041.6072955258205, 6064.666443345658, 6065.727042283108, 5969.940300597025, 6093.2078829751845, 6287.779927702509, 6302.621842689453, 6343.873122537616, 6135.601185922901, 6182.629042257479, 6189.412005859436, 6229.127922090911, 6233.002719564848, 6113.689152827286, 6266.874662506724, 6304.495640348761, 6314.873702525923, 6322.71547780351, 6085.421884920926, 6165.0, 6169.784057557964, 6188.44304012632, 6210.5652604317265, 5812.651240925558, 6219.782307619302, 6229.968850155811, 6244.2819075806865, 6249.937500624936, 4212.515560710557, 5042.722650254272, 5049.495050494921, 5064.34163558735, 5078.238264260317, 4409.162259170747, 4425.933610995838, 4455.75493347869, 4489.2592722201125, 4519.028408892104, 5954.345022047572, 5967.970160149258, 6009.489193418521, 6032.607880487754, 6065.181200537871, 6217.533684973645, 6320.905186422207, 6332.525060620472, 6338.683065846689, 6353.396427339396, 5842.094475356326, 5896.557758168155, 5935.703214839241, 6030.939690603125, 6060.757569697163, 5455.354153235678, 5516.641418307878, 5522.22688823565, 5562.805301814417, 5567.944320556823, 6346.238451385863, 6351.936480635134, 6352.396522330371, 6371.299157092809, 6380.298167201604, 5399.244105825109, 5423.7830486780085, 6146.200993870768, 6326.9683651581445, 6347.016212487072, 4808.831690890942, 4922.507749225048, 6193.473554747717, 6224.968875155595, 6293.307736149111, 5291.550218231493, 6181.35095814933, 6211.937880621136, 6229.844253893689, 6237.0, 5112.3865136183895, 5376.413957882356, 6126.761967422386, 6247.12540244357, 6259.906101408392, 5747.4252574742195, 5970.552208584287, 6130.122981477994, 6156.753729850935, 6194.81415557534, 6138.294096178996, 6191.473724733268, 6201.627902325875, 6211.16149319836, 6221.5333849960525, 6006.549508786771, 6054.576179667381, 6083.969580152071, 6112.8777424452155, 6169.722362493609, 6145.6927153641245, 6184.752609895554, 6198.194234749454, 6207.81376558704, 6211.360171926823, 6069.878602428015, 6134.141220229082, 6137.232845894263, 6155.938440615537, 6177.949748542668], "value": 5712.2449567225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.9268916973283, 481.52329194097837, 495.641941081437, 503.2627201150314, 579.797071025141, 32103.0, 39505.80247098768, 39759.60240397595, 39785.0, 39787.40318895215, 33530.66469335312, 41225.79387103068, 42032.57967420325, 42151.57848421515, 42245.57754422455, 9605.759856003604, 9852.655157069505, 9861.260405469582, 9895.307328487008, 9964.252681048914, 9630.133288004079, 9738.951305243463, 9760.755981100458, 9795.559199836025, 9803.31376803624, 9761.560729767141, 9768.120869121778, 9772.120509154174, 9840.606375744961, 9853.852192217086, 9702.514874256294, 9749.171320437772, 9754.02459754026, 9754.317197796121, 9804.411735295906, 9679.08048735369, 9796.216302695768, 9824.361416507903, 9828.410295382228, 9835.852462213072, 38509.807450962566, 38740.45038198469, 38797.22405551873, 38827.8351649451, 38869.0, 3520.77114987525, 3538.964610353915, 4044.1507283470505, 4054.2296963576828, 4081.6938729595104, 30419.543706844415, 31136.0, 31485.37029259402, 31568.368632627447, 31569.684303156904, 3223.06531105979, 3353.2287573857907, 3379.307242015381, 3424.298018906118, 3424.5890493140982, 467466.0, 468616.0, 468937.0, 469586.0, 471315.1473941038, 59975.20074397775, 60849.0, 60952.0, 61040.38959610436, 61066.38933610607, 60614.39385606087, 61348.0, 61444.38555614387, 61478.77042459126, 61551.692241538505, 16217.918910405373, 16234.837651623333, 16244.269007894673, 16452.588685282964, 16503.752443713354, 12367.0, 12464.439100240512, 12678.556250531186, 12705.809412858815, 12725.93637031809, 16227.513174604781, 16661.750073748903, 16709.749353759704, 16734.49796506107, 16735.748963765553, 5205.27126202332, 5641.956238095965, 5774.5169577081415, 6278.654673992883, 6387.744490220432, 737.4837613670452, 899.9010108888017, 949.0936155971169, 963.7264087806122, 1067.5409573883148, 29821.85089074541, 29917.551236731466, 30428.695713042587, 30686.693133068384, 31184.688153118634, 1025.1183981775666, 1048.9632862849764, 1063.2822844579878, 1088.8856670049688, 1134.1097238667771, 13381.53164639233, 14754.40982360715, 15034.774478382833, 15830.366785328459, 15941.282642281125, 644817.0, 648959.0, 650525.0, 650810.0, 652268.7386563037, 58608.0, 58798.82402351929, 58867.705661472275, 58894.0, 58904.0, 1329.1891945912985, 1370.2532119994628, 1382.315753701904, 1389.2220356600337, 1394.5049507424922, 26493.470130597667, 28303.71696283011, 30269.394612107193, 30374.088777336714, 31091.22271943129, 51700.74149629228, 52242.738786305825, 52288.47711522836, 52418.73790631175, 52504.73747631237, 563793.1810340922, 567734.0, 567936.0, 568058.0, 568527.0, 41015.794921025205, 41085.0, 41468.963275918344, 41494.377584336864, 41779.0, 46410.53589464062, 47489.65510389587, 47505.0, 47856.282155768386, 48395.88634966067, 33883.83058084793, 39541.0, 39720.60279397169, 39892.60107399005, 42135.578644213165, 36952.0, 38397.61602384052, 38786.6121338783, 39724.20551588894, 40085.799571003125, 38161.85514434571, 38928.02679933024, 38972.83081507559, 39442.40836387514, 41209.58790412178, 31237.68762312348, 35178.82410588033, 35367.64632353746, 35564.0, 35713.821430892676, 25977.350566235997, 26188.85785303601, 26225.082122125634, 26548.203553893414, 26622.201333960013], "value": 20109.664355920933, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.6360403200831, 371.45767179917334, 376.78899816102995, 380.0839975658663, 397.0193621754266, 19095.809041909575, 21259.0, 21695.45761355967, 21775.911204439795, 21889.0, 20813.0, 20819.0, 20835.479113022146, 20928.372148835522, 21282.255121070764, 5791.913121303184, 5799.072148456248, 6002.279726432834, 6074.5747797654185, 6078.726457309432, 4107.507099148106, 4345.283028300327, 5919.674417907014, 5976.581639285252, 6292.087647291163, 6529.412352888239, 6627.2710001899995, 6629.801105966804, 6647.966760166192, 6676.933230667704, 5583.748731307101, 6592.604443733368, 6612.471002319803, 6615.735370585171, 6626.13860198176, 5672.262605861253, 5695.060315048012, 5722.198892155102, 5749.425057494259, 5754.539636829044, 25394.873025634937, 25678.614820777704, 25686.743132568623, 25930.35174120662, 26052.218433447026, 2258.7741225877444, 2273.658951157323, 2399.352174912764, 2400.879956002193, 3025.7276845084048, 15511.146886921215, 15596.688066238612, 15674.529764107096, 15774.76337854933, 16456.0, 1805.2598434641734, 1844.3544759334125, 1859.377108668584, 1883.969800632315, 1906.551960289331, 89967.10032899718, 120758.0, 121144.39427802892, 123142.0, 123570.76429235772, 8675.305975521944, 9342.95328523353, 9917.553710082919, 9931.801363972825, 10623.256372054037, 11610.361430121255, 11831.76336473283, 12127.151099422956, 12280.140390172603, 12314.75370492603, 7934.722284720007, 8055.275025247756, 8060.83878322442, 8082.232187942136, 8095.0, 7332.450066245053, 8317.627591447465, 8465.492070475791, 8599.226069653761, 8625.0, 3786.6024067472517, 3866.2074274773604, 3872.5740168581433, 3921.9607803921594, 3935.3900145477496, 1562.211083402897, 1649.0, 1890.3005887821594, 1902.2295970132118, 1933.690609502501, 834.9958250208831, 942.9151376376159, 946.6321165915186, 987.5802783816993, 1005.5525291245326, 18933.81066189348, 20149.697754533692, 21414.0, 21817.472776905783, 21830.45423864416, 888.6045709659269, 936.2556767369957, 940.2478017585904, 942.3262367407336, 986.6941248213077, 9209.815803683889, 10231.744206394751, 11027.456156138147, 11508.712282193012, 11539.96140347356, 506741.0, 519244.0, 520527.1393789687, 520668.0, 614094.7181056443, 101417.0, 139742.0, 143844.0, 144283.0, 153849.2307538455, 999.2206079258045, 1003.0671475527829, 1041.7656027393775, 1041.9374837509774, 1050.6270274052754, 19211.711824322927, 19238.03809809476, 19598.922059286877, 19699.0, 19713.605727885075, 45303.563572371524, 51423.742881285354, 53811.654708632595, 57897.0, 58184.254472365894, 78238.0, 79717.0, 81074.59462702648, 81186.0, 85668.0, 7015.421530155878, 7252.129744430491, 7377.668004939684, 8182.345412366877, 8381.539015354214, 10416.635417760343, 12989.350532473527, 13201.933990329986, 13270.535531256359, 13479.0, 10692.823789383006, 10858.837117443403, 11342.376169310437, 11397.487113079766, 11479.196456247982, 10460.63387781424, 11266.887331126913, 11426.2001659883, 11655.475503602527, 11847.526098955945, 9622.855657165008, 10362.844557331797, 10981.956714112146, 11552.537898483966, 11775.352355620524, 7322.560646361236, 7342.265773422829, 7497.587632680255, 7561.168271490242, 7675.5010924289745, 8256.339492840678, 11173.0, 11398.575178102737, 11433.1996760226, 11673.241239319417], "value": 9566.80425640774, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.6886700492391, 1521.619595101225, 1719.93120275189, 1832.8167183281682, 1854.2119599170358, 8096.91903080969, 8371.790705232372, 8581.570921453933, 9131.771705707351, 9147.222486088682, 8593.312534997202, 8885.289176865852, 8918.554072296392, 8958.731238062852, 9040.367174297802, 2327.1040649349993, 2329.161501859338, 2339.532093581282, 2351.447409858682, 2353.399883029825, 2036.898155092247, 2299.41364951937, 2357.0807385119815, 2387.1883559589737, 2397.5564520563753, 2351.5061837014246, 2356.575816353056, 2370.2652177824843, 2386.427257458206, 2388.5700573896693, 2334.9649755253686, 2344.941376465585, 2347.448349637834, 2361.7638236176417, 2366.0062773635113, 2286.9199578014855, 2291.633338665822, 2292.1404473322505, 2292.942676433086, 2300.493891343918, 8528.360372972053, 8921.598528066188, 8994.32542559304, 9057.094290570956, 9090.590923408463, 5264.0, 5339.41266460689, 5415.6479828811, 5426.647267927572, 5437.619366644337, 3533.152043509565, 3578.874739384135, 3702.4816525686424, 3712.350338690718, 3718.0890681782867, 1048.8531605575226, 1079.9028087472086, 1082.9025387715144, 1091.956321747129, 1105.9281146725518, 11792.941035294769, 11795.997340226006, 11875.465604047753, 11950.820737688942, 11964.82052769209, 3611.9097022574647, 4069.9389509157386, 4371.737695738266, 4621.0, 4843.95156048435, 8918.0, 9533.189678877374, 10038.548265328078, 10059.346142500714, 10119.544620492095, 5373.301470808769, 5387.568994480511, 5387.703676297841, 5393.83818485446, 5406.107992181324, 3622.5109610202285, 4590.219662657356, 4786.210275304536, 4957.3059771632, 5163.845084647466, 2947.484190266695, 3238.9190270243434, 3663.7069034477177, 3737.5328083989502, 3795.791231482295, 1290.3677198173016, 1298.2340419152556, 1301.9153755005893, 1307.8365204349457, 1313.7832257677376, 830.3274347778198, 901.2474583722534, 916.5279880861361, 917.3349321741817, 937.4562753602894, 5216.0, 5408.891822163535, 5746.396628353963, 5891.587588868738, 6052.57631965767, 434.8673654535334, 442.4579889635171, 446.31045035419703, 448.4797634743747, 454.0238487252434, 3917.5494818095713, 3952.6787792353434, 3985.880423587297, 4007.338789099824, 4040.353543433095, 10558.313709609005, 10902.291351062155, 10909.23635345534, 10957.17821163416, 10959.452027398598, 10773.676789696165, 10877.619283325046, 10880.510377033053, 10907.018368346728, 10907.618233361794, 8258.339332853357, 8364.832703346021, 8372.1627837217, 8383.329333653293, 8395.53824539644, 5109.667871588484, 5659.377468478382, 5763.423657634203, 5878.177055212359, 5925.0, 10176.185905127424, 10238.53926573291, 10255.538500767632, 10262.538185781508, 10332.483375831329, 10030.949845250727, 10268.435236062089, 10305.175585953255, 10368.0, 10471.267011309135, 6978.720851165896, 7157.391621712213, 7523.473356864967, 7525.8494830102, 7621.580813055335, 8171.346292296483, 8230.259276665129, 8334.749957501284, 8482.872756908775, 8537.658493660185, 7450.217727138789, 7569.772906812805, 7570.507916985378, 7639.312461878458, 7721.150673426031, 6514.3811337922825, 6930.960355946649, 7444.292792184734, 7453.403727701662, 7469.327760501581, 6937.722491100501, 6967.442604591519, 7069.469789765891, 7084.22073571917, 7087.291270872872, 4984.177610694195, 5035.244713292889, 5075.593952483719, 5093.745312734422, 5113.846584602468, 4925.21196608541, 4985.800567977385, 5004.3994720633755, 5068.214426763858, 5218.321618189611], "value": 4488.56593836016, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.92801727585373, 308.11263560944474, 308.7267768025297, 313.6346156727413, 314.8646082184661, 4738.620910327174, 5606.046972014757, 5613.947447297434, 5629.859253518664, 5662.971685141573, 5203.869903252421, 5473.397926228122, 5479.698616576086, 5585.743207778248, 5630.915536266959, 4141.565135660758, 4162.771047592389, 4198.727082739612, 4223.72545784523, 4232.894177645553, 3858.4791053207737, 4194.580541945811, 4197.18154959783, 4237.279662457389, 4254.957450425502, 4156.272652285853, 4212.294020921532, 4234.153169366124, 4245.830166793325, 4253.893652658678, 3407.4037043517287, 3574.249407624376, 3717.498137751396, 4128.277551428488, 4140.3375459926265, 2634.6443230163873, 3321.136504508821, 3389.2884093532607, 3550.6449355064547, 3552.609212986569, 4667.509911459282, 5362.544183744387, 5407.729613519308, 5437.374701909292, 5463.289772329612, 4055.71609987301, 4352.695311328208, 4742.217534106868, 4786.593139583139, 4810.831620893252, 5365.919511207335, 5589.891429799094, 5865.736041878125, 5900.586958912878, 5939.881202375928, 3317.4194515959853, 3335.4329763940186, 3511.719062474996, 3942.7240093193486, 3987.8803635890968, 5648.971755141239, 6006.759729610811, 6134.0, 6250.937490625127, 6279.37206279373, 3309.4043072247227, 3941.349677303213, 3948.926813422976, 3954.9914771733024, 3972.3644216925154, 3994.141259629194, 4018.2967980603275, 4027.9194416111513, 4029.899252518652, 4049.4128351389472, 4157.0, 4699.248120300804, 4722.1028004679, 4736.194846876039, 4777.856664300077, 5261.605379596545, 5487.5609951203805, 5683.403242659544, 5856.677882716406, 5887.705614719247, 1311.2919023727272, 1360.0683531780762, 1365.0717512091874, 1365.4469939674448, 1385.8544852790515, 700.7736461192912, 709.1277728394105, 819.3404309530885, 838.5723281126669, 870.1776820904184, 5320.547753441001, 5322.494363035506, 5368.516833485005, 5384.461553844662, 5425.13197888336, 4939.728314942713, 5709.0, 5760.423957604206, 5880.648030622589, 5929.080992446177, 5013.899722005613, 5030.974845125751, 5345.492178243061, 5413.400088940889, 5580.130656230127, 2866.856657167133, 3016.502277124294, 3146.4179126861145, 3155.8106513609255, 3185.124090875028, 5292.0, 5588.608797384144, 5595.692236926927, 5811.593188476851, 5858.589898707135, 5860.443257890493, 5991.071383935497, 6075.0, 6105.8168254952425, 6178.960942888836, 4902.749798801283, 5082.357174269433, 5524.751386187631, 5978.671173085522, 6017.578769486094, 5136.871578210575, 5601.523870470893, 5871.1486834409625, 5946.851328716817, 5953.821385358273, 5811.622244554091, 5838.569550459994, 5892.351841297368, 5934.43622855828, 5937.109433584997, 5749.160268713971, 6102.542309326729, 6108.419700128481, 6121.32665406796, 6165.4451099399475, 3365.3101114272004, 3888.650021498079, 3893.2992061429213, 3900.707446941434, 3920.215956808707, 5895.7052147391605, 5959.135925290895, 5975.641461512323, 6008.369121242382, 6064.939350606437, 4918.39325157667, 5563.550598628876, 5670.489655930986, 5754.683492407958, 5835.249425172517, 5730.283714535683, 5742.684152371659, 5749.597528172988, 5769.365369809234, 5778.8266352009505, 4661.696989695659, 5660.320761508646, 5672.780352224291, 5685.464924470452, 5712.286314105835, 5114.823590574263, 5151.068349368987, 5502.669839809624, 5599.0, 5848.356680765028, 4838.298446725275, 5253.448387919367, 5752.9137062943255, 5760.942390576208, 5814.244148260699], "value": 4185.650428494279, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.403017133723, 644.916160899083, 672.4015626092776, 722.2921536893843, 794.4716763352369, 15033.323500442479, 15892.602684932868, 15904.125273109974, 15909.84090159098, 15996.040237585754, 14399.712005759879, 14490.0, 14493.78259326111, 14510.637234069154, 14525.0, 668.6355936014859, 691.2292793535197, 824.7773101262655, 826.0376661189722, 850.553459433796, 828.4904783558098, 856.8115014696788, 860.1871231686027, 861.6424183963647, 861.7587075618836, 892.2727976698969, 908.9500077495735, 912.5665308978215, 912.8585069314267, 913.8263729891299, 869.891263592051, 891.8662200669886, 895.4582477601056, 904.4076130134706, 905.7509184974119, 671.4326394196896, 676.8240257533027, 677.8847595908658, 678.5962352400363, 679.0730652659134, 14286.642833929234, 14437.278136093259, 14514.782278265835, 14583.343749531297, 14590.343434545472, 14258.928705356408, 14408.927955360261, 14427.639309017253, 14433.639159021004, 14517.564473065719, 11633.418329083512, 11701.648950531498, 11757.35334556599, 11776.941115294369, 11797.705057373549, 3631.6186800385844, 3793.430985352192, 3816.2939856126704, 3916.236333914888, 3954.4661470701376, 71385.0, 99116.0, 109039.90960090377, 111128.4443577777, 111745.32382014276, 9180.0, 10991.450427478594, 11066.225364224427, 11334.659960201207, 11578.42107894602, 21636.026378812676, 21752.673709894363, 21904.561908761734, 21973.67039494409, 22131.225407110673, 7995.480293781002, 8118.391120665974, 8121.269085782308, 8177.9591102044105, 8212.219839115274, 4470.418845550058, 4534.841280555164, 4540.568645978627, 4552.772361381918, 4587.541245875453, 3627.383344831385, 3750.8124593770203, 3753.6434038766274, 3754.0990162360836, 3754.0990162360836, 603.474976770204, 675.7297081167573, 683.6615875141737, 686.4885660183196, 692.1486571517062, 548.2051026012218, 578.5718568259458, 640.7084776426808, 657.0833687006599, 685.5715178013742, 8606.483610983361, 9039.68924505943, 9227.215686666708, 9426.151646351862, 9500.95249523748, 616.96915154243, 621.3444815719369, 667.9899801502982, 669.8411747676547, 671.1107782188619, 4415.470143582726, 4628.4445866496235, 4643.582077613031, 4675.983990326288, 4686.297055441642, 165683.0, 166515.0, 168846.15576922282, 173556.0, 177676.11161944107, 121405.39297303457, 131822.0, 144572.0, 146345.0, 149500.2524987368, 84866.15133848706, 95696.52151739197, 122699.77300226883, 124618.37690811488, 127953.36023319824, 8799.12008799115, 8913.28693704515, 8932.910670893209, 8973.192412682889, 9075.13786190311, 67784.6610766943, 68461.0, 68591.65704171447, 69202.65398672974, 69999.65000174966, 100674.0, 107587.46206268918, 107944.0, 109116.45441772741, 109473.35789963316, 11484.598039068593, 11548.191626586058, 11585.536578537101, 12081.69795755078, 12281.570145044881, 12739.476019985941, 12853.614391568268, 13033.608991730263, 13074.477020919438, 13143.60569182926, 11850.229735067192, 11989.520419183134, 12087.456064477296, 12233.143679942319, 12544.372781360713, 11993.460294286604, 12176.75646487083, 12202.75594488123, 12402.627921162379, 12579.811302830281, 11848.0, 11926.463309151282, 12036.939815300868, 12374.443150058089, 12420.813687794509, 10215.489225538842, 10330.793384132425, 10421.270511064153, 10894.0, 11017.643931451692, 8745.344099192458, 10010.199184065112, 10683.732906677395, 11249.606263780728, 11503.137264705349], "value": 7755.935176901486, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 117.0, 122.0, 171.0, 131.0, 114.0, 135.0, 171.0, 96.0], "value": 127.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 115.0, 112.0, 150.0, 114.0, 116.0, 114.0, 116.0, 143.0, 118.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 201.0, 210.0, 249.0, 201.0, 201.0, 196.0, 195.0, 197.0, 191.0], "value": 203.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 59.0, 58.0, 85.0, 60.0, 59.0, 59.0, 60.0, 76.0, 59.0], "value": 64.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 87.0, 60.0, 67.0, 101.0, 126.0, 104.0, 69.0, 88.0], "value": 85.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 91.0, 81.0, 91.0, 87.0, 91.0, 88.0, 89.0, 93.0], "value": 89.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 109.0, 100.0, 100.0, 100.0, 100.0, 106.0, 99.0, 100.0, 101.0], "value": 101.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 90.0, 93.0, 93.0, 90.0, 92.0, 99.0, 92.0, 98.0], "value": 93.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 57.0, 58.0, 59.0, 57.0, 58.0, 58.0, 56.0, 73.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 99.0, 107.0, 69.0, 81.0, 93.0, 107.0, 102.0, 100.0, 85.0], "value": 91.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 93.0, 92.0, 89.0, 88.0, 86.0, 90.0, 89.0, 89.0, 92.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 149.0, 146.0, 167.0, 171.0, 168.0, 191.0, 162.0, 190.0, 149.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [231.0, 237.0, 174.0, 179.0, 172.0, 165.0, 231.0, 182.0, 174.0, 173.0], "value": 191.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 95.0, 91.0, 90.0, 63.0, 86.0, 90.0, 89.0, 92.0, 75.0], "value": 84.0, "unit": "score"}]}]} 23:02:46 INFO - Return code: 0 23:02:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:02:46 ERROR - # TBPL SUCCESS # 23:02:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:02:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:02:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:02:46 INFO - 2016-10-04 23:02:46.913 screenresolution[1671:10313] starting screenresolution argv=screenresolution get 23:02:46 INFO - 2016-10-04 23:02:46.915 screenresolution[1671:10313] Display 0: 1600x1200x32@60 23:02:46 INFO - 2016-10-04 23:02:46.921 screenresolution[1672:10316] starting screenresolution argv=screenresolution list 23:02:46 INFO - Available Modes on Display 0 23:02:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:02:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:02:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:02:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:02:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:02:47 INFO - Intel Iris: 23:02:47 INFO - Chipset Model: Intel Iris 23:02:47 INFO - Type: GPU 23:02:47 INFO - Bus: Built-In 23:02:47 INFO - VRAM (Dynamic, Max): 1536 MB 23:02:47 INFO - Vendor: Intel (0x8086) 23:02:47 INFO - Device ID: 0x0a2e 23:02:47 INFO - Revision ID: 0x0009 23:02:47 INFO - Displays: 23:02:47 INFO - Display: 23:02:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:02:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:02:47 INFO - Display Serial Number: 1600x1200 60 23:02:47 INFO - Main Display: Yes 23:02:47 INFO - Mirror: Off 23:02:47 INFO - Online: Yes 23:02:47 INFO - Rotation: Supported 23:02:47 INFO - Return code: 0 23:02:47 INFO - Running post-action listener: _resource_record_post_action 23:02:47 INFO - [mozharness: 2016-10-05 06:02:47.157304Z] Finished run-tests step (success) 23:02:47 INFO - Running post-run listener: _resource_record_post_run 23:02:47 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 39270912; Write bytes: 711185920; Read time: 385; Write time: 2301 23:02:47 INFO - TinderboxPrint: CPU usage
54.5% 23:02:47 INFO - TinderboxPrint: I/O read bytes / time
39,270,912 / 385 23:02:47 INFO - TinderboxPrint: I/O write bytes / time
711,185,920 / 2,301 23:02:47 INFO - TinderboxPrint: CPU idle
2,204.6 (45.5%) 23:02:47 INFO - TinderboxPrint: CPU system
979.6 (20.2%) 23:02:47 INFO - TinderboxPrint: CPU user
1,661.5 (34.3%) 23:02:47 INFO - TinderboxPrint: Swap in / out
447,045,632 / 0 23:02:47 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393957888; Write bytes: 387581952; Read time: 29350; Write time: 688 23:02:47 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 38300160; Write bytes: 300355072; Read time: 370; Write time: 1570 23:02:47 INFO - Running post-run listener: _upload_blobber_files 23:02:47 INFO - Blob upload gear active. 23:02:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:02:47 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 23:02:47 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:02:47 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:02:48 INFO - (blobuploader) - INFO - Open directory for files ... 23:02:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:02:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:02:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:49 INFO - (blobuploader) - INFO - Done attempting. 23:02:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:02:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:02:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:50 INFO - (blobuploader) - INFO - Done attempting. 23:02:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:02:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:02:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:52 INFO - (blobuploader) - INFO - Done attempting. 23:02:52 INFO - (blobuploader) - INFO - Iteration through files over. 23:02:52 INFO - Return code: 0 23:02:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:02:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:02:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6637fb0407a3ac48da9dea4722c131a8b00ecd788aec1c9bec8ea9f4ae2aa7d5eee2457c36ab6580590db5fe768c5fc05e2d35c8d7fdcb050f71b18583628992", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c8579570f27812ea04606aacd6c80f8aee129340f59b66825b174852aa102bfcca8878c714cc4ec93c97251ce137f4ec923890369480f09db97a28636381a9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b568cfcacad1fec41ce3ec70429a23095a648137becbdc72601d78ba93685fae4651df4667b2aa844e102f634acb037a80815f0ad918fae2033c9b7cc4e9ee7a"} 23:02:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:02:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:02:52 INFO - Contents: 23:02:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6637fb0407a3ac48da9dea4722c131a8b00ecd788aec1c9bec8ea9f4ae2aa7d5eee2457c36ab6580590db5fe768c5fc05e2d35c8d7fdcb050f71b18583628992", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c8579570f27812ea04606aacd6c80f8aee129340f59b66825b174852aa102bfcca8878c714cc4ec93c97251ce137f4ec923890369480f09db97a28636381a9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b568cfcacad1fec41ce3ec70429a23095a648137becbdc72601d78ba93685fae4651df4667b2aa844e102f634acb037a80815f0ad918fae2033c9b7cc4e9ee7a"} 23:02:52 INFO - Running post-run listener: copy_logs_to_upload_dir 23:02:52 INFO - Copying logs to upload dir... 23:02:52 INFO - mkdir: /builds/slave/test/build/upload/logs 23:02:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.144298 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-04 23:02:52.991035) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 23:02:52.995870) ========= 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.VTxwpS42iT/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.bFTTw2CIRf/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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/Fx-Team/sha512/6637fb0407a3ac48da9dea4722c131a8b00ecd788aec1c9bec8ea9f4ae2aa7d5eee2457c36ab6580590db5fe768c5fc05e2d35c8d7fdcb050f71b18583628992", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c8579570f27812ea04606aacd6c80f8aee129340f59b66825b174852aa102bfcca8878c714cc4ec93c97251ce137f4ec923890369480f09db97a28636381a9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b568cfcacad1fec41ce3ec70429a23095a648137becbdc72601d78ba93685fae4651df4667b2aa844e102f634acb037a80815f0ad918fae2033c9b7cc4e9ee7a"} build_url:https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/aSDF6x4ARz6QgsGmxcIn1Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6637fb0407a3ac48da9dea4722c131a8b00ecd788aec1c9bec8ea9f4ae2aa7d5eee2457c36ab6580590db5fe768c5fc05e2d35c8d7fdcb050f71b18583628992", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c8579570f27812ea04606aacd6c80f8aee129340f59b66825b174852aa102bfcca8878c714cc4ec93c97251ce137f4ec923890369480f09db97a28636381a9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b568cfcacad1fec41ce3ec70429a23095a648137becbdc72601d78ba93685fae4651df4667b2aa844e102f634acb037a80815f0ad918fae2033c9b7cc4e9ee7a"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 23:02:53.106448) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 23:02:53.106745) ========= 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.VTxwpS42iT/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.bFTTw2CIRf/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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.005121 ========= master_lag: 0.26 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 23:02:53.376777) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 23:02:53.377094) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 23:02:53.378972) ========= ========= Total master_lag: 3.08 =========