builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0341 starttime: 1488383777.29 results: success (0) buildid: 20170301065222 builduid: be78747dd9bd46d9b165551816d70a3a revision: 95d5cceb04c19391e691937194f25baaf0ee4dcf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:17.291020) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:17.291686) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:17.292063) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:17.349840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:17.350300) ========= 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.4rAm67G4tf/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.mpNWEj3Qkg/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 --2017-03-01 07:56:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2017-03-01 07:56:18 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.640451 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:18.015048) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:18.015424) ========= 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.4rAm67G4tf/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.mpNWEj3Qkg/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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.020653 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:18.065318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-01 07:56:18.065785) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 95d5cceb04c19391e691937194f25baaf0ee4dcf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 95d5cceb04c19391e691937194f25baaf0ee4dcf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4rAm67G4tf/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.mpNWEj3Qkg/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 2017-03-01 07:56:18,323 truncating revision to first 12 chars 2017-03-01 07:56:18,323 Setting DEBUG logging. 2017-03-01 07:56:18,324 attempt 1/10 2017-03-01 07:56:18,324 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/95d5cceb04c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-01 07:56:19,665 unpacking tar archive at: mozilla-aurora-95d5cceb04c1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.617558 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-01 07:56:19.709222) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:19.709607) ========= script_repo_revision: 95d5cceb04c19391e691937194f25baaf0ee4dcf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:19.710105) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:19.710425) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:19.730372) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-03-01 07:56:19.730778) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4rAm67G4tf/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.mpNWEj3Qkg/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:56:20 INFO - MultiFileLogger online at 20170301 07:56:20 in /builds/slave/test 07:56:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:56:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:56:20 INFO - {'append_to_log': False, 07:56:20 INFO - 'base_work_dir': '/builds/slave/test', 07:56:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:56:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:56:20 INFO - 'branch': 'Mozilla-Aurora', 07:56:20 INFO - 'buildbot_json_path': 'buildprops.json', 07:56:20 INFO - 'config_files': ('talos/mac_config.py',), 07:56:20 INFO - 'default_actions': ('clobber', 07:56:20 INFO - 'read-buildbot-config', 07:56:20 INFO - 'download-and-extract', 07:56:20 INFO - 'populate-webroot', 07:56:20 INFO - 'create-virtualenv', 07:56:20 INFO - 'install', 07:56:20 INFO - 'run-tests'), 07:56:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:56:20 INFO - 'download_minidump_stackwalk': True, 07:56:20 INFO - 'download_symbols': 'ondemand', 07:56:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:56:20 INFO - 'tooltool.py': '/tools/tooltool.py', 07:56:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:56:20 INFO - '/tools/misc-python/virtualenv.py')}, 07:56:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:56:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:56:20 INFO - 'installer_path': 'installer.exe', 07:56:20 INFO - 'log_level': 'info', 07:56:20 INFO - 'log_name': 'talos', 07:56:20 INFO - 'log_to_console': True, 07:56:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:56:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:56:20 INFO - 'opt_config_files': (), 07:56:20 INFO - 'pip_index': False, 07:56:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:56:20 INFO - 'cmd': ('bash', 07:56:20 INFO - '-c', 07:56:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:56:20 INFO - 'enabled': True, 07:56:20 INFO - 'halt_on_failure': False, 07:56:20 INFO - 'name': 'check_screen_resolution'},), 07:56:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:56:20 INFO - 'cmd': ('bash', 07:56:20 INFO - '-c', 07:56:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:56:20 INFO - 'enabled': True, 07:56:20 INFO - 'halt_on_failure': False, 07:56:20 INFO - 'name': 'check_screen_resolution'},), 07:56:20 INFO - 'run_cmd_checks_enabled': True, 07:56:20 INFO - 'sps_profile': False, 07:56:20 INFO - 'sps_profile_interval': 0, 07:56:20 INFO - 'suite': 'dromaeojs-e10s', 07:56:20 INFO - 'system_bits': '32', 07:56:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:56:20 INFO - 'title': 't-yosemite-r7-0341', 07:56:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:56:20 INFO - 'use_talos_json': True, 07:56:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:56:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:56:20 INFO - 'work_dir': 'build'} 07:56:20 INFO - [mozharness: 2017-03-01 15:56:20.108801Z] Running clobber step. 07:56:20 INFO - Running pre-action listener: _resource_record_pre_action 07:56:20 INFO - Running main action method: clobber 07:56:20 INFO - rmtree: /builds/slave/test/build 07:56:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:56:22 INFO - Running post-action listener: _resource_record_post_action 07:56:22 INFO - [mozharness: 2017-03-01 15:56:22.081297Z] Finished clobber step (success) 07:56:22 INFO - [mozharness: 2017-03-01 15:56:22.081471Z] Running read-buildbot-config step. 07:56:22 INFO - Running pre-action listener: _resource_record_pre_action 07:56:22 INFO - Running main action method: read_buildbot_config 07:56:22 INFO - Using buildbot properties: 07:56:22 INFO - { 07:56:22 INFO - "project": "", 07:56:22 INFO - "product": "firefox", 07:56:22 INFO - "script_repo_revision": "production", 07:56:22 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 07:56:22 INFO - "repository": "", 07:56:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 07:56:22 INFO - "buildid": "20170301065222", 07:56:22 INFO - "pgo_build": "False", 07:56:22 INFO - "basedir": "/builds/slave/test", 07:56:22 INFO - "buildnumber": 74, 07:56:22 INFO - "slavename": "t-yosemite-r7-0341", 07:56:22 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 07:56:22 INFO - "platform": "yosemite_r7", 07:56:22 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:56:22 INFO - "branch": "mozilla-aurora", 07:56:22 INFO - "repo_path": "releases/mozilla-aurora", 07:56:22 INFO - "revision": "95d5cceb04c19391e691937194f25baaf0ee4dcf", 07:56:22 INFO - "stage_platform": "macosx64", 07:56:22 INFO - "builduid": "be78747dd9bd46d9b165551816d70a3a", 07:56:22 INFO - "slavebuilddir": "test" 07:56:22 INFO - } 07:56:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 07:56:22 INFO - Running post-action listener: _resource_record_post_action 07:56:22 INFO - [mozharness: 2017-03-01 15:56:22.084875Z] Finished read-buildbot-config step (success) 07:56:22 INFO - [mozharness: 2017-03-01 15:56:22.084990Z] Running download-and-extract step. 07:56:22 INFO - Running pre-action listener: _resource_record_pre_action 07:56:22 INFO - Running main action method: download_and_extract 07:56:22 INFO - mkdir: /builds/slave/test/build/tests 07:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:22 INFO - trying https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 07:56:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 07:56:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 07:56:23 INFO - Downloaded 1199 bytes. 07:56:23 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 07:56:23 INFO - Using the following test package requirements: 07:56:23 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 07:56:23 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:56:23 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 07:56:23 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:56:23 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 07:56:23 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:56:23 INFO - u'jsshell-mac.zip'], 07:56:23 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:56:23 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 07:56:23 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 07:56:23 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:56:23 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 07:56:23 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:56:23 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 07:56:23 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:56:23 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 07:56:23 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:56:23 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 07:56:23 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:56:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 07:56:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:56:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 07:56:24 INFO - Expected file size: 16357790 07:56:24 INFO - Obtained file size: 16357790 07:56:30 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:56:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 07:56:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:56:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 07:56:31 INFO - Expected file size: 16357790 07:56:31 INFO - Obtained file size: 16357790 07:56:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 07:56:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:56:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 07:56:39 INFO - Expected file size: 14403472 07:56:39 INFO - Obtained file size: 14403472 07:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:39 INFO - trying https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:56:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 07:56:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 07:56:41 INFO - Downloaded 73900891 bytes. 07:56:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:56:41 INFO - mkdir: /builds/slave/test/properties 07:56:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:56:41 INFO - Writing to file /builds/slave/test/properties/build_url 07:56:41 INFO - Contents: 07:56:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:56:42 INFO - Running post-action listener: _resource_record_post_action 07:56:42 INFO - Running post-action listener: set_extra_try_arguments 07:56:42 INFO - [mozharness: 2017-03-01 15:56:42.154845Z] Finished download-and-extract step (success) 07:56:42 INFO - [mozharness: 2017-03-01 15:56:42.155002Z] Running populate-webroot step. 07:56:42 INFO - Running pre-action listener: _resource_record_pre_action 07:56:42 INFO - Running main action method: populate_webroot 07:56:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:56:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:56:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:56:42 INFO - '--tppagecycles', 07:56:42 INFO - '7'], 07:56:42 INFO - 'tests': ['tsvgm']}}, 07:56:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:56:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:56:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:56:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:56:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:56:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:56:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:56:42 INFO - 'talos_options': ['--disable-e10s'], 07:56:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:56:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:56:42 INFO - 'talos_options': ['--disable-e10s'], 07:56:42 INFO - 'tests': ['damp', 'tps']}, 07:56:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:56:42 INFO - 'tests': ['damp', 'tps']}, 07:56:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:56:42 INFO - 'tests': ['dromaeo_dom']}, 07:56:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:56:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:56:42 INFO - 'tests': ['basic_compositor_video']}, 07:56:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:56:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:56:42 INFO - 'tests': ['a11yr', 07:56:42 INFO - 'ts_paint', 07:56:42 INFO - 'tpaint', 07:56:42 INFO - 'sessionrestore', 07:56:42 INFO - 'sessionrestore_no_auto_restore', 07:56:42 INFO - 'tabpaint']}, 07:56:42 INFO - 'other-e10s': {'tests': ['a11yr', 07:56:42 INFO - 'ts_paint', 07:56:42 INFO - 'tpaint', 07:56:42 INFO - 'sessionrestore', 07:56:42 INFO - 'sessionrestore_no_auto_restore', 07:56:42 INFO - 'tabpaint']}, 07:56:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:56:42 INFO - 'ts_paint', 07:56:42 INFO - 'tpaint', 07:56:42 INFO - 'sessionrestore', 07:56:42 INFO - 'sessionrestore_no_auto_restore', 07:56:42 INFO - 'tabpaint']}, 07:56:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:56:42 INFO - 'ts_paint', 07:56:42 INFO - 'tpaint', 07:56:42 INFO - 'sessionrestore', 07:56:42 INFO - 'sessionrestore_no_auto_restore', 07:56:42 INFO - 'tabpaint']}, 07:56:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:56:42 INFO - 'tests': ['a11yr', 07:56:42 INFO - 'ts_paint', 07:56:42 INFO - 'tpaint', 07:56:42 INFO - 'sessionrestore', 07:56:42 INFO - 'sessionrestore_no_auto_restore', 07:56:42 INFO - 'tabpaint']}, 07:56:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:56:42 INFO - 'tests': ['a11yr', 07:56:42 INFO - 'ts_paint', 07:56:42 INFO - 'tpaint', 07:56:42 INFO - 'sessionrestore', 07:56:42 INFO - 'sessionrestore_no_auto_restore', 07:56:42 INFO - 'tabpaint']}, 07:56:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:56:42 INFO - 'tests': ['tsvgx', 07:56:42 INFO - 'tsvgr_opacity', 07:56:42 INFO - 'tart', 07:56:42 INFO - 'tscrollx', 07:56:42 INFO - 'cart', 07:56:42 INFO - 'tsvg_static']}, 07:56:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:56:42 INFO - 'tsvgr_opacity', 07:56:42 INFO - 'tart', 07:56:42 INFO - 'tscrollx', 07:56:42 INFO - 'cart', 07:56:42 INFO - 'tsvg_static']}, 07:56:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:56:42 INFO - 'talos_options': ['--disable-e10s'], 07:56:42 INFO - 'tests': ['tp5o']}, 07:56:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:56:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:56:42 INFO - 'talos_options': ['--disable-e10s', 07:56:42 INFO - '--xperf_path', 07:56:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:42 INFO - 'tests': ['tp5n']}, 07:56:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:56:42 INFO - 'talos_options': ['--xperf_path', 07:56:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:42 INFO - 'tests': ['tp5n']}}, 07:56:42 INFO - 'talos.zip': {'path': '', 07:56:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:56:42 INFO - Running post-action listener: _resource_record_post_action 07:56:42 INFO - [mozharness: 2017-03-01 15:56:42.173471Z] Finished populate-webroot step (success) 07:56:42 INFO - [mozharness: 2017-03-01 15:56:42.173601Z] Running create-virtualenv step. 07:56:42 INFO - Running pre-action listener: _resource_record_pre_action 07:56:42 INFO - Running main action method: create_virtualenv 07:56:42 INFO - Creating virtualenv /builds/slave/test/build/venv 07:56:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:56:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:56:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:56:42 INFO - Using real prefix '/tools/python27' 07:56:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:56:43 INFO - Installing distribute.............................................................................................................................................................................................done. 07:56:45 INFO - Installing pip.................done. 07:56:45 INFO - Return code: 0 07:56:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:56:46 INFO - Reading from file tmpfile_stdout 07:56:46 INFO - Output received: 07:56:46 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:56:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:46 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 0x10553eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9cb597330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531cd30>, '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 0x105243db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105311be8>, '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.4rAm67G4tf/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.mpNWEj3Qkg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:56:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4rAm67G4tf/Render', 07:56:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:46 INFO - 'HOME': '/Users/cltbld', 07:56:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:46 INFO - 'LOGNAME': 'cltbld', 07:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:46 INFO - 'MOZ_NO_REMOTE': '1', 07:56:46 INFO - 'NO_EM_RESTART': '1', 07:56:46 INFO - 'PAGER': '/bin/cat', 07:56:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:46 INFO - 'PWD': '/builds/slave/test', 07:56:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:46 INFO - 'SHELL': '/bin/bash', 07:56:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mpNWEj3Qkg/Listeners', 07:56:46 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 07:56:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:46 INFO - 'USER': 'cltbld', 07:56:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:46 INFO - 'XPC_FLAGS': '0x0', 07:56:46 INFO - 'XPC_SERVICE_NAME': '0', 07:56:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:56:46 INFO - Cleaning up... 07:56:46 INFO - Return code: 0 07:56:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:46 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 0x10553eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9cb597330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531cd30>, '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 0x105243db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105311be8>, '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.4rAm67G4tf/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.mpNWEj3Qkg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:56:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4rAm67G4tf/Render', 07:56:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:46 INFO - 'HOME': '/Users/cltbld', 07:56:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:46 INFO - 'LOGNAME': 'cltbld', 07:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:46 INFO - 'MOZ_NO_REMOTE': '1', 07:56:46 INFO - 'NO_EM_RESTART': '1', 07:56:46 INFO - 'PAGER': '/bin/cat', 07:56:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:46 INFO - 'PWD': '/builds/slave/test', 07:56:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:46 INFO - 'SHELL': '/bin/bash', 07:56:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mpNWEj3Qkg/Listeners', 07:56:46 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 07:56:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:46 INFO - 'USER': 'cltbld', 07:56:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:46 INFO - 'XPC_FLAGS': '0x0', 07:56:46 INFO - 'XPC_SERVICE_NAME': '0', 07:56:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:46 INFO - Downloading/unpacking psutil>=3.1.1 07:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:56:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:50 INFO - Installing collected packages: psutil 07:56:50 INFO - Running setup.py install for psutil 07:56:50 INFO - building 'psutil._psutil_osx' extension 07:56:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:56:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:56:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:56:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:56:51 INFO - building 'psutil._psutil_posix' extension 07:56:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:56:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:56:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:56:51 INFO - ^ 07:56:51 INFO - 1 warning generated. 07:56:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:56:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:51 INFO - Successfully installed psutil 07:56:51 INFO - Cleaning up... 07:56:51 INFO - Return code: 0 07:56:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:51 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 0x10553eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9cb597330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531cd30>, '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 0x105243db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105311be8>, '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.4rAm67G4tf/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.mpNWEj3Qkg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:56:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:56:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:56:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4rAm67G4tf/Render', 07:56:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:51 INFO - 'HOME': '/Users/cltbld', 07:56:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:51 INFO - 'LOGNAME': 'cltbld', 07:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:51 INFO - 'MOZ_NO_REMOTE': '1', 07:56:51 INFO - 'NO_EM_RESTART': '1', 07:56:51 INFO - 'PAGER': '/bin/cat', 07:56:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:51 INFO - 'PWD': '/builds/slave/test', 07:56:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:51 INFO - 'SHELL': '/bin/bash', 07:56:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mpNWEj3Qkg/Listeners', 07:56:51 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 07:56:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:51 INFO - 'USER': 'cltbld', 07:56:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:51 INFO - 'XPC_FLAGS': '0x0', 07:56:51 INFO - 'XPC_SERVICE_NAME': '0', 07:56:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:56:54 INFO - Installing collected packages: mozsystemmonitor 07:56:54 INFO - Running setup.py install for mozsystemmonitor 07:56:54 INFO - Successfully installed mozsystemmonitor 07:56:54 INFO - Cleaning up... 07:56:54 INFO - Return code: 0 07:56:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:54 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 0x10553eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9cb597330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531cd30>, '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 0x105243db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105311be8>, '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.4rAm67G4tf/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.mpNWEj3Qkg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:56:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4rAm67G4tf/Render', 07:56:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:54 INFO - 'HOME': '/Users/cltbld', 07:56:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:54 INFO - 'LOGNAME': 'cltbld', 07:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:54 INFO - 'MOZ_NO_REMOTE': '1', 07:56:54 INFO - 'NO_EM_RESTART': '1', 07:56:54 INFO - 'PAGER': '/bin/cat', 07:56:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:54 INFO - 'PWD': '/builds/slave/test', 07:56:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:54 INFO - 'SHELL': '/bin/bash', 07:56:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mpNWEj3Qkg/Listeners', 07:56:54 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 07:56:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:54 INFO - 'USER': 'cltbld', 07:56:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:54 INFO - 'XPC_FLAGS': '0x0', 07:56:54 INFO - 'XPC_SERVICE_NAME': '0', 07:56:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:54 INFO - Downloading/unpacking jsonschema==2.5.1 07:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:56:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:57 INFO - Downloading functools32-3.2.3-2.tar.gz 07:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:56:57 INFO - warning: no files found matching '*.txt' 07:56:57 INFO - no previously-included directories found matching 'build' 07:56:57 INFO - no previously-included directories found matching 'dist' 07:56:57 INFO - no previously-included directories found matching '.git*' 07:56:57 INFO - Installing collected packages: jsonschema, functools32 07:56:57 INFO - Running setup.py install for functools32 07:56:58 INFO - warning: no files found matching '*.txt' 07:56:58 INFO - no previously-included directories found matching 'build' 07:56:58 INFO - no previously-included directories found matching 'dist' 07:56:58 INFO - no previously-included directories found matching '.git*' 07:56:58 INFO - Successfully installed jsonschema functools32 07:56:58 INFO - Cleaning up... 07:56:58 INFO - Return code: 0 07:56:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:58 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 0x10553eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9cb597330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531cd30>, '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 0x105243db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105311be8>, '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.4rAm67G4tf/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.mpNWEj3Qkg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:56:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:56:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4rAm67G4tf/Render', 07:56:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:58 INFO - 'HOME': '/Users/cltbld', 07:56:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:58 INFO - 'LOGNAME': 'cltbld', 07:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:58 INFO - 'MOZ_NO_REMOTE': '1', 07:56:58 INFO - 'NO_EM_RESTART': '1', 07:56:58 INFO - 'PAGER': '/bin/cat', 07:56:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:58 INFO - 'PWD': '/builds/slave/test', 07:56:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:58 INFO - 'SHELL': '/bin/bash', 07:56:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mpNWEj3Qkg/Listeners', 07:56:58 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 07:56:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:58 INFO - 'USER': 'cltbld', 07:56:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:58 INFO - 'XPC_FLAGS': '0x0', 07:56:58 INFO - 'XPC_SERVICE_NAME': '0', 07:56:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:56:58 INFO - Cleaning up... 07:56:58 INFO - Return code: 0 07:56:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:58 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 0x10553eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9cb597330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531cd30>, '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 0x105243db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105311be8>, '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.4rAm67G4tf/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.mpNWEj3Qkg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:56:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:56:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4rAm67G4tf/Render', 07:56:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:58 INFO - 'HOME': '/Users/cltbld', 07:56:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:58 INFO - 'LOGNAME': 'cltbld', 07:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:58 INFO - 'MOZ_NO_REMOTE': '1', 07:56:58 INFO - 'NO_EM_RESTART': '1', 07:56:58 INFO - 'PAGER': '/bin/cat', 07:56:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:58 INFO - 'PWD': '/builds/slave/test', 07:56:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:58 INFO - 'SHELL': '/bin/bash', 07:56:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mpNWEj3Qkg/Listeners', 07:56:58 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 07:56:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:58 INFO - 'USER': 'cltbld', 07:56:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:58 INFO - 'XPC_FLAGS': '0x0', 07:56:58 INFO - 'XPC_SERVICE_NAME': '0', 07:56:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:58 INFO - Downloading/unpacking blobuploader==1.2.4 07:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:01 INFO - Downloading blobuploader-1.2.4.tar.gz 07:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:57:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:57:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:02 INFO - Downloading docopt-0.6.1.tar.gz 07:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:57:02 INFO - Installing collected packages: blobuploader, requests, docopt 07:57:02 INFO - Running setup.py install for blobuploader 07:57:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:57:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:57:02 INFO - Running setup.py install for requests 07:57:03 INFO - Running setup.py install for docopt 07:57:03 INFO - Successfully installed blobuploader requests docopt 07:57:03 INFO - Cleaning up... 07:57:03 INFO - Return code: 0 07:57:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:03 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 0x10553eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9cb597330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531cd30>, '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 0x105243db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105311be8>, '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.4rAm67G4tf/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.mpNWEj3Qkg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:57:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:57:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4rAm67G4tf/Render', 07:57:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:03 INFO - 'HOME': '/Users/cltbld', 07:57:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:03 INFO - 'LOGNAME': 'cltbld', 07:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:03 INFO - 'MOZ_NO_REMOTE': '1', 07:57:03 INFO - 'NO_EM_RESTART': '1', 07:57:03 INFO - 'PAGER': '/bin/cat', 07:57:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:03 INFO - 'PWD': '/builds/slave/test', 07:57:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:03 INFO - 'SHELL': '/bin/bash', 07:57:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mpNWEj3Qkg/Listeners', 07:57:03 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 07:57:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:03 INFO - 'USER': 'cltbld', 07:57:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:03 INFO - 'XPC_FLAGS': '0x0', 07:57:03 INFO - 'XPC_SERVICE_NAME': '0', 07:57:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:57:03 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-JCCRVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:57:03 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-nAKW0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:57:03 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-o8JyQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:57:04 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-xerGAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:57:04 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-bKFH9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:57:04 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-FZ3rtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:57:04 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-1JdTNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:57:04 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-wXJgWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:57:04 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-9EFlHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:57:04 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-YPSwmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:57:04 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-fZ6UHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:57:04 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-FKr4ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:57:05 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Ytz4Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:57:05 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-unekIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:05 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-J8dbiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:57:05 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-elQOLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:57:05 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-7c5nrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:57:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:57:05 INFO - Running setup.py install for manifestparser 07:57:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:57:05 INFO - Running setup.py install for mozcrash 07:57:05 INFO - Running setup.py install for mozdebug 07:57:05 INFO - Running setup.py install for mozdevice 07:57:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:57:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:57:06 INFO - Running setup.py install for mozfile 07:57:06 INFO - Running setup.py install for mozhttpd 07:57:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:57:06 INFO - Running setup.py install for mozinfo 07:57:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:57:06 INFO - Running setup.py install for mozInstall 07:57:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:57:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:57:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:57:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:57:06 INFO - Running setup.py install for mozleak 07:57:06 INFO - Running setup.py install for mozlog 07:57:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:57:07 INFO - Running setup.py install for moznetwork 07:57:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:57:07 INFO - Running setup.py install for mozprocess 07:57:07 INFO - Running setup.py install for mozprofile 07:57:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:57:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:57:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:57:07 INFO - Running setup.py install for mozrunner 07:57:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:57:07 INFO - Running setup.py install for mozscreenshot 07:57:07 INFO - Running setup.py install for moztest 07:57:07 INFO - Running setup.py install for mozversion 07:57:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:57:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:57:08 INFO - Cleaning up... 07:57:08 INFO - Return code: 0 07:57:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:08 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 0x10553eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9cb597330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531cd30>, '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 0x105243db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105311be8>, '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.4rAm67G4tf/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.mpNWEj3Qkg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:57:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4rAm67G4tf/Render', 07:57:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:08 INFO - 'HOME': '/Users/cltbld', 07:57:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:08 INFO - 'LOGNAME': 'cltbld', 07:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:08 INFO - 'MOZ_NO_REMOTE': '1', 07:57:08 INFO - 'NO_EM_RESTART': '1', 07:57:08 INFO - 'PAGER': '/bin/cat', 07:57:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:08 INFO - 'PWD': '/builds/slave/test', 07:57:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:08 INFO - 'SHELL': '/bin/bash', 07:57:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mpNWEj3Qkg/Listeners', 07:57:08 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 07:57:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:08 INFO - 'USER': 'cltbld', 07:57:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:08 INFO - 'XPC_FLAGS': '0x0', 07:57:08 INFO - 'XPC_SERVICE_NAME': '0', 07:57:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:57:08 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-7us050-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:57:08 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-098ojX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:57:08 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-GdC2dU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:57:08 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-IZaG6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:57:08 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-r7Y8_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:57:08 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-UY4jLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:57:08 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-rfvnb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:57:09 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Sbk5VS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:57:09 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-l5PsBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:57:09 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-lnY8GU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:57:09 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-iM5y9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:57:09 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-bF_pIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:57:09 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-RorNeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:57:09 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-hPiU9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:09 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-qGct9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:57:09 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-uSPRrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:57:10 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-WSl8Er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:57:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:12 INFO - Downloading blessings-1.6.tar.gz 07:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:57:12 INFO - Installing collected packages: blessings 07:57:12 INFO - Running setup.py install for blessings 07:57:13 INFO - Successfully installed blessings 07:57:13 INFO - Cleaning up... 07:57:13 INFO - Return code: 0 07:57:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:57:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:57:13 INFO - Reading from file tmpfile_stdout 07:57:13 INFO - Current package versions: 07:57:13 INFO - blessings == 1.6 07:57:13 INFO - blobuploader == 1.2.4 07:57:13 INFO - docopt == 0.6.1 07:57:13 INFO - functools32 == 3.2.3-2 07:57:13 INFO - jsonschema == 2.5.1 07:57:13 INFO - manifestparser == 1.1 07:57:13 INFO - mozInstall == 1.12 07:57:13 INFO - mozcrash == 1.0 07:57:13 INFO - mozdebug == 0.1 07:57:13 INFO - mozdevice == 0.49 07:57:13 INFO - mozfile == 1.2 07:57:13 INFO - mozhttpd == 0.7 07:57:13 INFO - mozinfo == 0.9 07:57:13 INFO - mozleak == 0.1 07:57:13 INFO - mozlog == 3.4 07:57:13 INFO - moznetwork == 0.27 07:57:13 INFO - mozprocess == 0.24 07:57:13 INFO - mozprofile == 0.28 07:57:13 INFO - mozrunner == 6.13 07:57:13 INFO - mozscreenshot == 0.1 07:57:13 INFO - mozsystemmonitor == 0.3 07:57:13 INFO - moztest == 0.8 07:57:13 INFO - mozversion == 1.4 07:57:13 INFO - psutil == 3.1.1 07:57:13 INFO - requests == 1.2.3 07:57:13 INFO - wsgiref == 0.1.2 07:57:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:13 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 0x10553eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9cb597330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531cd30>, '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 0x105243db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105311be8>, '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.4rAm67G4tf/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.mpNWEj3Qkg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:57:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:57:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4rAm67G4tf/Render', 07:57:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:13 INFO - 'HOME': '/Users/cltbld', 07:57:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:13 INFO - 'LOGNAME': 'cltbld', 07:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:13 INFO - 'MOZ_NO_REMOTE': '1', 07:57:13 INFO - 'NO_EM_RESTART': '1', 07:57:13 INFO - 'PAGER': '/bin/cat', 07:57:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:13 INFO - 'PWD': '/builds/slave/test', 07:57:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:13 INFO - 'SHELL': '/bin/bash', 07:57:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mpNWEj3Qkg/Listeners', 07:57:13 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 07:57:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:13 INFO - 'USER': 'cltbld', 07:57:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:13 INFO - 'XPC_FLAGS': '0x0', 07:57:13 INFO - 'XPC_SERVICE_NAME': '0', 07:57:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:57:13 INFO - Cleaning up... 07:57:13 INFO - Return code: 0 07:57:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:13 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 0x10553eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9cb597330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10531cd30>, '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 0x105243db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105311be8>, '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.4rAm67G4tf/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.mpNWEj3Qkg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:57:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:57:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4rAm67G4tf/Render', 07:57:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:13 INFO - 'HOME': '/Users/cltbld', 07:57:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:13 INFO - 'LOGNAME': 'cltbld', 07:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:13 INFO - 'MOZ_NO_REMOTE': '1', 07:57:13 INFO - 'NO_EM_RESTART': '1', 07:57:13 INFO - 'PAGER': '/bin/cat', 07:57:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:13 INFO - 'PWD': '/builds/slave/test', 07:57:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:13 INFO - 'SHELL': '/bin/bash', 07:57:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mpNWEj3Qkg/Listeners', 07:57:13 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 07:57:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:13 INFO - 'USER': 'cltbld', 07:57:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:13 INFO - 'XPC_FLAGS': '0x0', 07:57:13 INFO - 'XPC_SERVICE_NAME': '0', 07:57:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:57:13 INFO - Cleaning up... 07:57:13 INFO - Return code: 0 07:57:13 INFO - Running post-action listener: _resource_record_post_action 07:57:13 INFO - Running post-action listener: _start_resource_monitoring 07:57:13 INFO - Starting resource monitoring. 07:57:13 INFO - [mozharness: 2017-03-01 15:57:13.988547Z] Finished create-virtualenv step (success) 07:57:13 INFO - [mozharness: 2017-03-01 15:57:13.989478Z] Running install step. 07:57:13 INFO - Running pre-action listener: _resource_record_pre_action 07:57:13 INFO - Running main action method: install 07:57:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:57:14 INFO - Reading from file tmpfile_stdout 07:57:14 INFO - Detecting whether we're running mozinstall >=1.0... 07:57:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:57:14 INFO - Reading from file tmpfile_stdout 07:57:14 INFO - Output received: 07:57:14 INFO - Usage: mozinstall [options] installer 07:57:14 INFO - Options: 07:57:14 INFO - -h, --help show this help message and exit 07:57:14 INFO - -d DEST, --destination=DEST 07:57:14 INFO - Directory to install application into. [default: 07:57:14 INFO - "/builds/slave/test"] 07:57:14 INFO - --app=APP Application being installed. [default: firefox] 07:57:14 INFO - mkdir: /builds/slave/test/build/application 07:57:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:57:34 INFO - Reading from file tmpfile_stdout 07:57:34 INFO - Output received: 07:57:34 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:57:34 INFO - Running post-action listener: _resource_record_post_action 07:57:34 INFO - [mozharness: 2017-03-01 15:57:34.162557Z] Finished install step (success) 07:57:34 INFO - [mozharness: 2017-03-01 15:57:34.162681Z] Running run-tests step. 07:57:34 INFO - Running pre-action listener: _resource_record_pre_action 07:57:34 INFO - Running main action method: run_tests 07:57:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:57:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:57:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:57:34 INFO - 2017-03-01 07:57:34.177 screenresolution[1909:15036] starting screenresolution argv=screenresolution get 07:57:34 INFO - 2017-03-01 07:57:34.179 screenresolution[1909:15036] Display 0: 1600x1200x32@60 07:57:34 INFO - 2017-03-01 07:57:34.185 screenresolution[1910:15039] starting screenresolution argv=screenresolution list 07:57:34 INFO - Available Modes on Display 0 07:57:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:57:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:57:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:57:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:57:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:57:34 INFO - Intel Iris: 07:57:34 INFO - Chipset Model: Intel Iris 07:57:34 INFO - Type: GPU 07:57:34 INFO - Bus: Built-In 07:57:34 INFO - VRAM (Dynamic, Max): 1536 MB 07:57:34 INFO - Vendor: Intel (0x8086) 07:57:34 INFO - Device ID: 0x0a2e 07:57:34 INFO - Revision ID: 0x0009 07:57:34 INFO - Displays: 07:57:34 INFO - Display: 07:57:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:57:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:57:34 INFO - Display Serial Number: 1600x1200 60 07:57:34 INFO - Main Display: Yes 07:57:34 INFO - Mirror: Off 07:57:34 INFO - Online: Yes 07:57:34 INFO - Rotation: Supported 07:57:34 INFO - Return code: 0 07:57:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:57:34 INFO - Python 2.7.3 07:57:34 INFO - Return code: 0 07:57:34 INFO - grabbing minidump binary from tooltool 07:57: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')]} 07:57:34 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 0x10531cd30>, '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 0x105243db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105311be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:57:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:57:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:57:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:57:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:57:34 INFO - Return code: 0 07:57:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:57:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:57:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:57:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:57:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:57:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0341', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0341 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:57:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4rAm67G4tf/Render', 07:57:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:34 INFO - 'HOME': '/Users/cltbld', 07:57:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:34 INFO - 'LOGNAME': 'cltbld', 07:57:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:57:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:34 INFO - 'MOZ_NO_REMOTE': '1', 07:57:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:57:34 INFO - 'NO_EM_RESTART': '1', 07:57:34 INFO - 'PAGER': '/bin/cat', 07:57:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:34 INFO - 'PWD': '/builds/slave/test', 07:57:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:57:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:34 INFO - 'SHELL': '/bin/bash', 07:57:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mpNWEj3Qkg/Listeners', 07:57:34 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 07:57:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:34 INFO - 'USER': 'cltbld', 07:57:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:34 INFO - 'XPC_FLAGS': '0x0', 07:57:34 INFO - 'XPC_SERVICE_NAME': '0', 07:57:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0341', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:57:34 INFO - mozversion application_buildid: 20170301065222 07:57:34 INFO - mozversion application_changeset: 95d5cceb04c19391e691937194f25baaf0ee4dcf 07:57:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:57:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:57:34 INFO - mozversion application_name: Firefox 07:57:34 INFO - mozversion application_remotingname: firefox-dev 07:57:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:57:34 INFO - mozversion application_vendor: Mozilla 07:57:34 INFO - mozversion application_version: 53.0a2 07:57:34 INFO - mozversion platform_buildid: 20170301065222 07:57:34 INFO - mozversion platform_changeset: 95d5cceb04c19391e691937194f25baaf0ee4dcf 07:57:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:57:34 INFO - mozversion platform_version: 53.0a2 07:57:34 INFO - using testdate: 1488383854 07:57:34 INFO - actual date: 1488383854 07:57:34 INFO - starting webserver on 'localhost:49726' 07:57:34 INFO - SUITE-START | Running 2 tests 07:57:34 INFO - TEST-START | dromaeo_css 07:57:34 INFO - operating with platform_type : mac_ 07:57:34 INFO - Initialising browser for dromaeo_css test... 07:57:34 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpOKwCAL/profile http://localhost:49726/getInfo.html) 07:57:35 INFO - PROCESS | 1920 | 1488383855373 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 07:57:35 INFO - PROCESS | 1920 | 1488383855374 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 07:57:35 INFO - PROCESS | 1920 | 1488383855416 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:57:37 INFO - PROCESS | 1920 | 2017-03-01 07:57:37.701 plugin-container[1922:15209] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x494f, name = 'com.apple.tsm.portname' 07:57:37 INFO - PROCESS | 1920 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:57:37 INFO - PROCESS | 1920 | 2017-03-01 07:57:37.704 plugin-container[1922:15209] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 07:57:37 INFO - PROCESS | 1920 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:57:37 INFO - PROCESS | 1920 | 2017-03-01 07:57:37.704 plugin-container[1922:15209] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:57:37 INFO - PROCESS | 1920 | __metrics Screen width/height:1600/1200 07:57:37 INFO - PROCESS | 1920 | colorDepth:24 07:57:37 INFO - PROCESS | 1920 | Browser inner width/height: 1024/689 07:57:37 INFO - PROCESS | 1920 | __metrics 07:57:37 ERROR - PROCESS | 1920 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 07:57:37 INFO - PROCESS | 1920 | 1488383857895 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:57:38 INFO - TEST-INFO | 1920: exit 0 07:57:38 INFO - Browser initialized. 07:57:38 INFO - Running cycle 1/1 for dromaeo_css test... 07:57:38 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpOKwCAL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:39 INFO - PROCESS | 1923 | 1488383859104 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 07:57:39 INFO - PROCESS | 1923 | 1488383859105 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:57:41 INFO - PROCESS | 1923 | 2017-03-01 07:57:41.223 plugin-container[1924:15337] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8633, name = 'com.apple.tsm.portname' 07:57:41 INFO - PROCESS | 1923 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:57:41 INFO - PROCESS | 1923 | 2017-03-01 07:57:41.224 plugin-container[1924:15337] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 07:57:41 INFO - PROCESS | 1923 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:57:41 INFO - PROCESS | 1923 | 2017-03-01 07:57:41.224 plugin-container[1924:15337] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:57:50 INFO - PROCESS | 1923 | RSS: Main: 218537984 07:57:50 INFO - PROCESS | 1923 | 08:00:52 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49726/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49726/tests/dromaeo/cssquery-ext.html) 08:00:54 INFO - PROCESS | 1923 | RSS: Main: 237801472 08:00:54 INFO - PROCESS | 1923 | 08:02:39 INFO - PROCESS | 1923 | ************************* 08:02:39 INFO - PROCESS | 1923 | A coding exception was thrown and uncaught in a Task. 08:02:39 INFO - PROCESS | 1923 | 08:02:39 ERROR - PROCESS | 1923 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:02:39 INFO - PROCESS | 1923 | Full stack: 08:02:39 INFO - PROCESS | 1923 | ************************* 08:03:57 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49726/tests/dromaeo/cssquery-ext.html (next: http://localhost:49726/tests/dromaeo/cssquery-jquery.html) 08:03:57 INFO - PROCESS | 1923 | RSS: Main: 247205888 08:03:57 INFO - PROCESS | 1923 | 08:06:59 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49726/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49726/tests/dromaeo/cssquery-mootools.html) 08:07:00 INFO - PROCESS | 1923 | RSS: Main: 254980096 08:07:00 INFO - PROCESS | 1923 | 08:10:02 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49726/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49726/tests/dromaeo/cssquery-prototype.html) 08:10:02 INFO - PROCESS | 1923 | RSS: Main: 251478016 08:10:02 INFO - PROCESS | 1923 | 08:13:05 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49726/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49726/tests/dromaeo/cssquery-yui.html) 08:13:06 INFO - PROCESS | 1923 | RSS: Main: 255926272 08:13:06 INFO - PROCESS | 1923 | 08:16:08 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49726/tests/dromaeo/cssquery-yui.html (next: http://localhost:49726/tests/dromaeo/cssquery-dojo.html) 08:16:09 INFO - PROCESS | 1923 | RSS: Main: 256892928 08:16:09 INFO - PROCESS | 1923 | 08:16:09 INFO - PROCESS | 1923 | __start_tp_report 08:16:09 INFO - PROCESS | 1923 | _x_x_mozilla_page_load 08:16:09 INFO - PROCESS | 1923 | _x_x_mozilla_page_load_details 08:16:09 INFO - PROCESS | 1923 | |i|pagename|runs| 08:16:09 INFO - PROCESS | 1923 | |0;dojo.html;2915;3197.968020319797;3329.0845017620136;3342.9164270893225;3357.764956453048;5511.862203444916;5525.613207075507;5551.861203469915;5593.580481463886;5609.1305847593585;5570.220169176318;5620.831375058755;5623.915641265385;5648.802291919784;5664.433556644333;5052.671576347544;5127.333446651949;5158.896822063556;5200.973995130038;5224.660397074197;5171.250168725533;5180.663256888291;5201.68789872607;5212.947870521303;5219.9478005220035;5039.874003149914;5088.618353623475;5211.296474975887;5216.217567364888;5259.789608415659;4277.738067270132;4287.678424118204;4956.504349565051;5099.7960081596875;5105.770240339175;5044.39467263927;5128.051310507531;5137.280780690707;5159.942211846563;5192.506711862367;5454.372747134091;5533.142362933751;5577.609567330289;5653.971730141323;5678.829635110953;5516.786307012451;5688.345840228344;6051.939480605181;6105.786297479612;6169.568130230886;6184.5052395808225;6186.257649082139;6190.133381326618;6202.441780239755;6213.03697926822;5714.971425142848;5716.199732037559;5725.198472213893;5725.742341594597;5759.222504961818;6141.355157708465;6171.382861713792;6190.133381326618;6190.783322583688;6236.6258024518675;6046.123312119718;6084.969575152184;6092.482139018233;6106.877862442815;6134.171886795315;6128.877422451526;6191.504679625709;6193.102000209944;6203.689815509297;6209.534284928558;5973.074173503114;5991.880162396815;6026.879462410728;6050.727717252734;6170.753169873245;6147.538934579924;6151.7539298428455;6152.692365381713;6155.599886007395;6179.196704428396;4932.802687892516;4933.161362568372;4938.827141050046;4941.03649788295;4942.308076869242;4308.418363520885;4337.609615134653;4418.072204836956;4420.955790442119;4430.224710675683;5607.719614019283;5629.634073785191;5671.064274394678;5685.090385538294;5769.249997500298;6178.62928224308;6220.533459990519;6238.344973777688;6250.531210159165;6260.467860231931;5515.09001014828;5566.582506311962;5640.266765320482;5664.773409063674;5690.772369105272;5379.246905433242;5388;5389.380221274603;5405.864853378697;5433;6267.903116954515;6270.874582508324;6286.9371306288185;6289.528285378615;6304.275008373912;6093.9085913712215;6098.176746139215;6120.632762034292;6123.069106197319;6225.875482490415;6180;6214.533909956862;6226.844328891814;6240.4071613196675;6267;6024.3674414187635;6096.603720758137;6101.694915254308;6114.38856114385;6119.877602448015;6046.3046749624355;6106.73370229429;6132.8773424532155;6200.193974783249;6201.81394558164;5951.196588460502;6046.153538504701;6060.575759696779;6100;6109.144719739329;5903.557233207613;5985.491233245223;6003.8198854034445;6049.153118563493;6053.697315134314;4460.397846290709;5638.774449021993;5709.857253568528;5797.623154494944;5813.128030795415;4846.418429788448;5905.114232865105;5912.408759124053;5963.0459126539545;6067.423594758491;5870.823875283749;5884.558658100746;5889.116632505158;5894.646321220741;5900.970495147497 08:16:09 INFO - PROCESS | 1923 | |1;ext.html;446.283714638006;456.9885752856178;474.1276052064201;491.373498789044;497.65910351409264;35297.823510882445;39266.60733392665;39323.21353572927;39337.40993885094;39385;41522.792386038025;41586.79206603971;41729.58270417295;42002;42132.57867421325;8408.915910840875;8634.395592308509;9131.269498440142;9386.765330866714;9401.858972115424;11204.775904481905;11497.770044599103;11528.769424611502;11626.767464650744;11633.418329083554;11474.368909709963;11522.366269855154;11525;11531.365774882379;11552.768944621102;11179.273347232403;11378.601748938789;11407;11422.14333924959;11446.656600302003;11272.267302625303;11328;11338;11352.978231959163;11357.772844543062;40284.798576006935;40427.59572404297;40479.7976010121;40480.59519404827;40528.1894362114;3815.828287727059;3935.152972983728;3959.208158368338;3979.2240513099955;4137.710360274752;27170.45659086827;29269;30127.548086778716;30976;31126.910558130356;3072.969270307313;3149.3543823516125;3213;3229.83850807461;3310.536524886518;456195;459658;461276;462178;463918.6804065992;61902.69048654818;62203.688981554806;62314.376856231764;62421.37578624247;62453;65977.34022659712;66205.33794662089;66343;66548.33451665519;66602;16190.028598283905;16524;16755;16782.58043548921;16803.579910502336;11477.770444591062;11798.174127810971;12666.556670516487;12811.359432028548;12919.935400323126;17043;17196.914015429844;17285.481435556703;17392.3043078278;17562.560935976704;6472.644004579794;6515;6941.826454338581;7411.814109742415;7762.146163921964;856.5631527920805;875.2778957360204;878.6173233052823;885.2784980241083;912.4388501071793;25063.87468062648;29297.414051718846;29363.706362936526;29425.411491770046;29941;1016.6035246253966;1038.5689938675516;1066.4774260612398;1083.8807731149568;1091.9235653504338;11785.764284714258;13615.863841361459;14869.479568215276;15353;15477.5356739298;530021;602514;606104;609092;610325;59019.40980590225;59148.40851591429;59246.70376648089;59369.40630593725;59744.40255597475;1394.3516264936852;1430.399232322427;1453.0772959171002;1454.7963285140302;1458.941642334316;28607.427851442437;29518.55722164212;29559.408811824072;29778.702212977594;30094.69905300919;50117;50484.747576261885;50651;50655.74672126616;50750.74624626853;436467;436681;439464;439670;441528;24346.391340216636;25045.373865652775;25093;39067.21865562729;39420.40869387019;40909.36362545465;40988.1802363957;41819.581804181566;42149;42620;34868.9539313821;34956.30087398289;35031.64968350284;35772.28455430929;35902.281954360245;34741.82629086838;34835.825820870734;35777.64222357743;35849.46225806667;35992.100197495274;33429.66570334265;33744.49383259302;34214.48678269778;34344.313113738084;34779.478307824895;29761.10716678503;31511.84244078765;31615.051548453583;31618.841905790323;31731.206719831265;23642.290731278088;23700.170494032627;23725.050997960578;23977;24113.638295425233 08:16:09 INFO - PROCESS | 1923 | |2;jquery.html;387.9088414222657;390.7870210735149;397.63616291093643;402.4908490759189;417.0075220974081;13941.372638231278;15376.846231537682;19982;20750.377488675345;20843.791562084374;19987.600247995033;20160.294389696362;20444.897775511137;20469.283575074838;20606.69089963648;4780.952190478086;4920.483349248331;5528.668279903219;5547.861303467405;5549.139883318092;4880.682755620891;5635.802746903859;5773.134029895507;5776.682282474462;5783.479486846183;5476.91784623231;5656.321241451032;5690.317161940573;5702.7433765480655;5705.971470142644;5441.7279136043435;5702.087665973424;5710.7430165642645;5714.371419143891;5718.9428105719035;4935.3090567320605;4954.083494553519;4987.576056035241;4993.425756038066;4998.150314446553;19538.218471261134;24463.633045504153;24474.877625611756;24837.254882353558;24916.5016699665;2224.343818573525;2611.8824652890667;2653.8805753741126;2675.692295386036;2699.0688212566633;14630.853691463055;14973.775393369107;15076.472323468626;15391.692166156727;15710;1698.371602507068;1808.6834803909264;1810.1582764014665;1812.2116879157609;1813.07533158089;111499.88500115057;112976;114750.42624786822;120339;137708;11663.125265605113;11757.470913808898;11928.46321915516;11940.641780746591;12064.276143431422;15201.01193422424;15262.542123736306;15285.38858445672;15294.00588961714;15307.846921530865;8018.919810801934;8349.165083491602;8592.613332400057;8730.126987301219;8831.514266715392;8440;8447.676888855614;8461.196186362286;8610.311175105977;8618.569071546397;4701.529847015271;4725.385699858996;4726.787294571753;4758.500357462417;4788.162071637449;2034.2574960139739;2063.535704466513;2072.968905466419;2074.3258441006733;2078;1011.9930668984408;1022.6829682798208;1028.3726926574784;1047.9161667066617;1062.0866055192528;16169;17023.659526809643;19177.616447670967;19854.404367868698;20021.399358019284;979.3829887171037;991.3704797453669;1032.912202462799;1045.9644951497962;1083.268793564341;10075.244356673278;10548.156147508334;10556;10563.47182640865;10721.35671859691;624504;713168;717932;729689;732477;145415;148517;148916;148929.51070489374;151354.48645513624;433.71808324588636;457.66819056184664;458.8256462544212;463.16861234084223;1020.7193021919031;10937.45312734376;10992.340459572451;11165.665030049111;11392.829107563559;11811.881881181078;44430.88922776956;55724.72137639286;62641.20803693997;64387.67806160939;64466;63933;69396;83077.5809771938;86477;88080.5595972016;6290.685465726787;7077.469189810682;8428.915710843059;8513.914860851311;8745.825083498421;9317.580708867981;12441.813372799596;12733.681657958625;13309.800352994907;13363.198208107544;9039.59321830506;10431.791364172826;10760;11184.832227516756;11535.826962595736;10479;10864.45677716127;11141;11542.307461552333;11567.710807229887;11059.115270778479;11407.144464165387;11487.023602993504;11694.941525292319;11702.2978621283;8174.100848906734;8333.83332333362;8399.286060684666;8640.092790257184;8691.86962195555;10676.252662313875;10804.027637512347;10947.507362168562;11121.221514493907;11291.491882865126 08:16:09 INFO - PROCESS | 1923 | |3;mootools.html;1248.544281337311;1310.1091257944597;1427.6145440730998;1441.8486058963808;1455.7161353536062;7561.697532098709;7835.294823465902;8167;8544.829103417927;8568.314534837205;8074.394420418463;8240.175982401757;8328.541930193836;8427.410081294312;8442.620082096306;2337.906483740648;2374.513224788923;2376.6316220985773;2378.0725517048363;2382.95234095318;1747.7503584936767;2101.075526768217;2182.8035476807086;2207.6909232707435;2389.223502361731;2263.7736226377315;2335.8364914455997;2341.1922886604093;2359.917402890899;2360.728516220631;2325.2791634593245;2343.484433424644;2353.752855950126;2360.893759780814;2362.208660098869;2333.5449587330477;2339.6724458575814;2388.1880160745254;2402.1712509184304;2409.1929203716777;8444.61999210037;8473.70342038032;8474.576271186477;8534.914650853536;8569.828603427959;5098.668586541863;5224.8693782655355;5248.160294352885;5257.973710131463;5268.947310526884;2937.970620293791;3310.2386451116377;3526.2771131917893;3547.8580856765698;3575.6781889630056;1137.3346592243547;1168.6902970712767;1218.6770505815966;1218.798898181799;1237.8143278508296;10787.784244315148;10863.130949524098;10927.562897484091;10931.578894743712;10932.305492648653;3889.086064774776;4617.746023968714;4748.8337908173735;4755.762211889391;4804.087223427608;7059.329363710439;8422.694482355244;8641.481511109228;8662.177093176138;8714.651413943371;5153.613478989016;5173.81891633791;5173.948260517422;5177;5179.04187725272;4601.401817763736;4781.95218047822;4821.108095002436;4836.927446088312;4865.489123642037;3790.6967442604528;3811.1805961718364;3856.2094770571966;3883.514560679915;3905.6484916357663;1100.3287994323457;1140.4297851074464;1165.2717051842599;1191.0412118244724;1203.807390817465;692.6432887063166;897.2059727141527;899.59967814322;906.7415786500816;910.2172131966504;5535.169724541351;5589.557924931403;5652.434756524314;5692.288463942007;5824.88350232993;955.6082006377352;982.4792859784326;1000.5547531348626;1003.7440452684518;1021.213665477578;3567.4827150063616;3651.507046548682;3677.44838274261;3740.551133863954;3884.7280690351404;8183.345332373396;10088.092071713581;10227.59089636421;10252.23108266883;10270.6405275815;10021;10084.294099413117;10122.949385253174;10196.99999999985;10202.846957295647;6798.912174052128;7880.566568838769;7941.523508589503;8015.839683206304;8044.31623312025;5089.720065396291;5306.495882891119;5454.836354909359;5576.944230557805;5612.887742245214;9008.819823603622;9097;9204.355695101278;9317.068293170629;9321.347505674537;9262.490563019099;9352.579133938852;9400.623975040922;9474.95262523683;9650.95174524123;6786.457083433214;6843.863122737418;6879.6560171992205;6901.482388820959;6909.516333856582;7813.882791758015;7816.804579885548;7907.367410607023;7920.683172673259;7922.405819563671;7050.294970502909;7130.073090498409;7177.784666460015;7193.388561972291;7299.452541059336;7038.472114591528;7076.716931322895;7086.0433841432805;7105.8578828422105;7127.928720712934;6252.781152659635;6364.172657554488;6373.171487706569;6441.355864413708;6501.804945851632;3982.4623675803396;4316.330968699856;4939.777710003131;5052.646314757932;5112.514311140436;4444.377787109743;4967.7019378837385;5003.699778013331;5119.820806271762;5153.072446959583 08:16:09 INFO - PROCESS | 1923 | |4;prototype.html;352.1355073295059;359.9622039685833;367.5827935293441;368.4841222288795;370.9591944886064;5196.960607878421;5320.494553017457;5451.100568406213;5456.3179602549635;5465.561766042788;4286.635635970946;4861.270809378595;5260.395054568726;5383.87337001885;5400.594955378352;3747.6883090918095;3838.8272527736317;3933.7639741615594;4273.145370925812;4284.443022407083;4119.8352065917325;4124.381342798574;4273.594008569181;4284.2648727265505;4297.376880352347;3482.9477557836526;4159.857673298254;4177.16456708658;4196.307609244471;4208.789560521977;3848.499695039627;4215.409842622035;4224.176285624305;4242.512111107231;4267.253230684618;3288.1122097033667;3529.4882242075014;3550.680438760498;3697.8890633281044;3765.1528406108405;4692.601128904047;4974.751262436864;5021.347224860781;5259.3951695555115;5334.786608535654;3875.7286989910435;3933.9803300983313;4622.0293738314995;4940.1601727706375;4965.950340496621;4666;4937.716193789604;5428.348598168205;5757.466714645542;5789.681567513785;3654.2326111516613;4072.246634372621;4092.4475195848477;4132.690048246393;4157.648764151662;4973.502649735034;5206;5519.282493275889;5563.527100196488;5989.3112292086535;4022.35642297231;4155.877912963543;4166.83332666696;4205.5794420557695;4258.829646814154;4120.464339635888;4251.893702657459;4288.335308027261;4304.956950430455;4322.7190232634775;4258.445667331402;4266.424032755538;4558.475775285819;4596.770566275354;4871.634627402959;5530.142827861688;5779.410662067881;5817.360090390139;5831.7667293307795;5858.8535286617325;1056.9365838049587;1285.7878450055637;1318.2156616812981;1381.7581923163407;1407.394820227312;878.5519385113638;956.6651671914914;985.4136788610765;991.8859331176862;995.348047029197;4642.605378542794;4690.507496712864;4791.904161916742;5006.574441172468;5106.617003724736;4459.9777001115435;5573.164025396223;5591.608587398843;5612.007737253298;5656.773729050874;4515.841945531891;4854.563089321978;4910.029432193472;5058.698292277005;5090.905455327123;2587.974120258811;2775.6114144019853;2908.2695796001344;2924.5905573219766;2989.0733872499595;5284.048871203144;5484.725763711798;5869.706514674334;5891.499222566044;5917.260342457193;5267.71027593486;5591.552675785927;5621.959937411592;5871.653157700155;6007.3992600739575;5285.889963107714;6173.84565385869;6212.968935155295;6234.098599927066;6241.938870392044;5057.6459647824295;5471.316085489314;5663.9716801415725;6053.878922421615;6075.058365953284;5205.557527610195;5774.740136693775;5935.109733540004;5945;5945.613535120204;5715.428257229129;6011.549133814894;6193.783217587363;6225.937740622717;6243.937560624336;3876.4960555127655;3952.3478626026385;3990.3415936370175;4017.5580686123917;4019.879403617896;5717.3996730342715;5917.3490915998345;5970.4923931947815;6006.819795406145;6018.668973206516;4748.815544849408;5554.1946417770005;5698.743556540048;5763.982606087836;5881.17663527098;4626.791794369195;4918.458969513279;5786.363500014911;5786.437661831366;5833.912491312549;4673.299005149119;5092.516210959953;5593.860153496195;5669.943300566942;5691;4355.1725172217175;5329.880725047783;5728.455796699307;5731.7103651678035;5789.363170051375;5078.949210507848;5087.3386459759995;5197.506236907639;5650.3219613646625;5654.038813401649 08:16:09 INFO - PROCESS | 1923 | |5;yui.html;705.947053970952;708.9397401220896;775.7750252426797;823.6664151018838;830;15026.323815428304;15254.771178432333;15551.377944882219;15710.764338534917;15807.604809879758;14310.928445357784;14331.28343582822;14354.712905741879;14626.926865365658;14638.048526845747;867.111211008718;875.483464755794;880.9779755506099;881.9206271435602;882.6028287270753;683.4054372695762;699.9720011199546;844.7803571071535;861.6682577207757;866.9956650216772;900.8198360327928;914.5335878701877;921.6866265469739;926.2497377124517;928.1461055828654;907.3693782820942;916.615021690888;917.2341095185528;919.5126582911101;919.6827094652334;683.0846665468297;684.4832151725465;684.6234570985938;686.5503095472474;687.3744892148121;15167.24163791806;15279.694406111927;15301.61745956349;15315;15794.36822527109;14190.43238270468;14491.347889345005;14789.630259243497;14792.630184245372;14848.851511484854;11520.596779112691;11764.058875290042;11792.705182370424;11838.704032399173;11864.58473953416;3492.406290930548;3616.385214513539;3635.8727444539577;3734.533183352081;3736.9252614947823;106568.46715766449;112419.43790281078;113667;115159;116417.25374119396;11023.83464248037;11209.887901121048;11381.146414018982;11417.086633069335;11498.540058397737;19011.524711882037;20510.282140125324;20529.48676283105;20818.063187156615;24108;6658.500612454085;6967.407770339578;7779.338756205672;7785.844283114306;7971.641276142587;3719.386301260262;4073.368627862686;4148.605882441163;4224.091820258659;4293.635041021548;3517.786363704518;3562.412201986695;3613.3134704406602;3619.746617736786;3623.2391197848747;539.8839249561363;569.7607005057886;645.3417514135649;650.9218893732782;666.6966530228734;588.341058015026;660.9140811694546;681.6455443169623;696.554205308603;698.5668885291051;9548.570314335871;10255.282130250811;10268.07587317145;10468.738281543023;10517.263791534671;555.4565436939367;576.2364866551835;606.5178183344252;644.8503877547994;693.8404167041608;4818.975905120452;4973.751312434364;4990.950090499121;4994.225894986283;5003.649744517848;76860.61569692228;92751.60872586917;97050.51474742581;98437.50781246048;100175;51650;80283.59858200671;84420;87142;89570;73991;74252.62873685597;74697;75835.62082189663;76180.61909690416;10574.41840698769;10723.540558956942;10768.138548915911;10903.454827258764;11069;43367;45686.77156614196;47385.34151304688;47955.801104972656;49846;62992;64175.679121604095;64348;66102.33897660962;66673;12292.446839892405;12444.253344799341;12455.377231138587;12495.437705303464;12584.433700483318;13756.587302380945;13830.723385532434;14392.85607143957;14407.495737649131;14414.063085899803;12946.93526532399;13299.268540229994;13451.529196478075;13608.115472494255;13917.37371818291;12478.875211248134;13262.003370937364;13428;13739;13858.65353366174;12574.182678125893;13279.468821247428;13540.59378218655;13661.248631325372;13666.18002919828;9975.152112070555;10603.575856965635;10632.787344252916;11079.5568177272;11619.6514104577;9430.245580353418;10010.998900109931;10661.307015043998;10662.413567253876;10944.288621239593 08:16:09 INFO - PROCESS | 1923 | __end_tp_report 08:16:09 INFO - PROCESS | 1923 | __start_cc_report 08:16:09 INFO - PROCESS | 1923 | _x_x_mozilla_cycle_collect,392 08:16:09 INFO - PROCESS | 1923 | __end_cc_report 08:16:09 INFO - PROCESS | 1923 | __startTimestamp1488384969219__endTimestamp 08:16:09 INFO - PROCESS | 1923 | 08:16:09 INFO - PROCESS | 1923 | ------- Summary: start ------- 08:16:09 INFO - PROCESS | 1923 | Number of tests: 6 08:16:09 INFO - PROCESS | 1923 | 08:16:09 INFO - PROCESS | 1923 | [#0] dojo.html Cycles:165 Average:5640.90 Median:5813.13 stddev:659.19 (11.3%) stddev-sans-first:625.57 08:16:09 INFO - PROCESS | 1923 | Values: 2915.0 3198.0 3329.1 3342.9 3357.8 5511.9 5525.6 5551.9 5593.6 5609.1 5570.2 5620.8 5623.9 5648.8 5664.4 5052.7 5127.3 5158.9 5201.0 5224.7 5171.3 5180.7 5201.7 5212.9 5219.9 5039.9 5088.6 5211.3 5216.2 5259.8 4277.7 4287.7 4956.5 5099.8 5105.8 5044.4 5128.1 5137.3 5159.9 5192.5 5454.4 5533.1 5577.6 5654.0 5678.8 5516.8 5688.3 6051.9 6105.8 6169.6 6184.5 6186.3 6190.1 6202.4 6213.0 5715.0 5716.2 5725.2 5725.7 5759.2 6141.4 6171.4 6190.1 6190.8 6236.6 6046.1 6085.0 6092.5 6106.9 6134.2 6128.9 6191.5 6193.1 6203.7 6209.5 5973.1 5991.9 6026.9 6050.7 6170.8 6147.5 6151.8 6152.7 6155.6 6179.2 4932.8 4933.2 4938.8 4941.0 4942.3 4308.4 4337.6 4418.1 4421.0 4430.2 5607.7 5629.6 5671.1 5685.1 5769.2 6178.6 6220.5 6238.3 6250.5 6260.5 5515.1 5566.6 5640.3 5664.8 5690.8 5379.2 5388.0 5389.4 5405.9 5433.0 6267.9 6270.9 6286.9 6289.5 6304.3 6093.9 6098.2 6120.6 6123.1 6225.9 6180.0 6214.5 6226.8 6240.4 6267.0 6024.4 6096.6 6101.7 6114.4 6119.9 6046.3 6106.7 6132.9 6200.2 6201.8 5951.2 6046.2 6060.6 6100.0 6109.1 5903.6 5985.5 6003.8 6049.2 6053.7 4460.4 5638.8 5709.9 5797.6 5813.1 4846.4 5905.1 5912.4 5963.0 6067.4 5870.8 5884.6 5889.1 5894.6 5901.0 08:16:09 INFO - PROCESS | 1923 | 08:16:09 INFO - PROCESS | 1923 | [#1] ext.html Cycles:180 Average:63985.97 Median:34912.63 stddev:133666.78 (382.9%) stddev-sans-first:133956.61 08:16:09 INFO - PROCESS | 1923 | Values: 446.3 457.0 474.1 491.4 497.7 35297.8 39266.6 39323.2 39337.4 39385.0 41522.8 41586.8 41729.6 42002.0 42132.6 8408.9 8634.4 9131.3 9386.8 9401.9 11204.8 11497.8 11528.8 11626.8 11633.4 11474.4 11522.4 11525.0 11531.4 11552.8 11179.3 11378.6 11407.0 11422.1 11446.7 11272.3 11328.0 11338.0 11353.0 11357.8 40284.8 40427.6 40479.8 40480.6 40528.2 3815.8 3935.2 3959.2 3979.2 4137.7 27170.5 29269.0 30127.5 30976.0 31126.9 3073.0 3149.4 3213.0 3229.8 3310.5 456195.0 459658.0 461276.0 462178.0 463918.7 61902.7 62203.7 62314.4 62421.4 62453.0 65977.3 66205.3 66343.0 66548.3 66602.0 16190.0 16524.0 16755.0 16782.6 16803.6 11477.8 11798.2 12666.6 12811.4 12919.9 17043.0 17196.9 17285.5 17392.3 17562.6 6472.6 6515.0 6941.8 7411.8 7762.1 856.6 875.3 878.6 885.3 912.4 25063.9 29297.4 29363.7 29425.4 29941.0 1016.6 1038.6 1066.5 1083.9 1091.9 11785.8 13615.9 14869.5 15353.0 15477.5 530021.0 602514.0 606104.0 609092.0 610325.0 59019.4 59148.4 59246.7 59369.4 59744.4 1394.4 1430.4 1453.1 1454.8 1458.9 28607.4 29518.6 29559.4 29778.7 30094.7 50117.0 50484.7 50651.0 50655.7 50750.7 436467.0 436681.0 439464.0 439670.0 441528.0 24346.4 25045.4 25093.0 39067.2 39420.4 40909.4 40988.2 41819.6 42149.0 42620.0 34869.0 34956.3 35031.6 35772.3 35902.3 34741.8 34835.8 35777.6 35849.5 35992.1 33429.7 33744.5 34214.5 34344.3 34779.5 29761.1 31511.8 31615.1 31618.8 31731.2 23642.3 23700.2 23725.1 23977.0 24113.6 08:16:09 INFO - PROCESS | 1923 | 08:16:09 INFO - PROCESS | 1923 | [#2] jquery.html Cycles:180 Average:38438.41 Median:11414.19 stddev:117366.49 (1028.3%) stddev-sans-first:117660.96 08:16:09 INFO - PROCESS | 1923 | Values: 387.9 390.8 397.6 402.5 417.0 13941.4 15376.8 19982.0 20750.4 20843.8 19987.6 20160.3 20444.9 20469.3 20606.7 4781.0 4920.5 5528.7 5547.9 5549.1 4880.7 5635.8 5773.1 5776.7 5783.5 5476.9 5656.3 5690.3 5702.7 5706.0 5441.7 5702.1 5710.7 5714.4 5718.9 4935.3 4954.1 4987.6 4993.4 4998.2 19538.2 24463.6 24474.9 24837.3 24916.5 2224.3 2611.9 2653.9 2675.7 2699.1 14630.9 14973.8 15076.5 15391.7 15710.0 1698.4 1808.7 1810.2 1812.2 1813.1 111499.9 112976.0 114750.4 120339.0 137708.0 11663.1 11757.5 11928.5 11940.6 12064.3 15201.0 15262.5 15285.4 15294.0 15307.8 8018.9 8349.2 8592.6 8730.1 8831.5 8440.0 8447.7 8461.2 8610.3 8618.6 4701.5 4725.4 4726.8 4758.5 4788.2 2034.3 2063.5 2073.0 2074.3 2078.0 1012.0 1022.7 1028.4 1047.9 1062.1 16169.0 17023.7 19177.6 19854.4 20021.4 979.4 991.4 1032.9 1046.0 1083.3 10075.2 10548.2 10556.0 10563.5 10721.4 624504.0 713168.0 717932.0 729689.0 732477.0 145415.0 148517.0 148916.0 148929.5 151354.5 433.7 457.7 458.8 463.2 1020.7 10937.5 10992.3 11165.7 11392.8 11811.9 44430.9 55724.7 62641.2 64387.7 64466.0 63933.0 69396.0 83077.6 86477.0 88080.6 6290.7 7077.5 8428.9 8513.9 8745.8 9317.6 12441.8 12733.7 13309.8 13363.2 9039.6 10431.8 10760.0 11184.8 11535.8 10479.0 10864.5 11141.0 11542.3 11567.7 11059.1 11407.1 11487.0 11694.9 11702.3 8174.1 8333.8 8399.3 8640.1 8691.9 10676.3 10804.0 10947.5 11121.2 11291.5 08:16:09 INFO - PROCESS | 1923 | 08:16:09 INFO - PROCESS | 1923 | [#3] mootools.html Cycles:180 Average:5396.89 Median:5105.59 stddev:2943.16 (57.6%) stddev-sans-first:2934.90 08:16:09 INFO - PROCESS | 1923 | Values: 1248.5 1310.1 1427.6 1441.8 1455.7 7561.7 7835.3 8167.0 8544.8 8568.3 8074.4 8240.2 8328.5 8427.4 8442.6 2337.9 2374.5 2376.6 2378.1 2383.0 1747.8 2101.1 2182.8 2207.7 2389.2 2263.8 2335.8 2341.2 2359.9 2360.7 2325.3 2343.5 2353.8 2360.9 2362.2 2333.5 2339.7 2388.2 2402.2 2409.2 8444.6 8473.7 8474.6 8534.9 8569.8 5098.7 5224.9 5248.2 5258.0 5268.9 2938.0 3310.2 3526.3 3547.9 3575.7 1137.3 1168.7 1218.7 1218.8 1237.8 10787.8 10863.1 10927.6 10931.6 10932.3 3889.1 4617.7 4748.8 4755.8 4804.1 7059.3 8422.7 8641.5 8662.2 8714.7 5153.6 5173.8 5173.9 5177.0 5179.0 4601.4 4782.0 4821.1 4836.9 4865.5 3790.7 3811.2 3856.2 3883.5 3905.6 1100.3 1140.4 1165.3 1191.0 1203.8 692.6 897.2 899.6 906.7 910.2 5535.2 5589.6 5652.4 5692.3 5824.9 955.6 982.5 1000.6 1003.7 1021.2 3567.5 3651.5 3677.4 3740.6 3884.7 8183.3 10088.1 10227.6 10252.2 10270.6 10021.0 10084.3 10122.9 10197.0 10202.8 6798.9 7880.6 7941.5 8015.8 8044.3 5089.7 5306.5 5454.8 5576.9 5612.9 9008.8 9097.0 9204.4 9317.1 9321.3 9262.5 9352.6 9400.6 9475.0 9651.0 6786.5 6843.9 6879.7 6901.5 6909.5 7813.9 7816.8 7907.4 7920.7 7922.4 7050.3 7130.1 7177.8 7193.4 7299.5 7038.5 7076.7 7086.0 7105.9 7127.9 6252.8 6364.2 6373.2 6441.4 6501.8 3982.5 4316.3 4939.8 5052.6 5112.5 4444.4 4967.7 5003.7 5119.8 5153.1 08:16:09 INFO - PROCESS | 1923 | 08:16:09 INFO - PROCESS | 1923 | [#4] prototype.html Cycles:180 Average:4604.73 Median:5039.50 stddev:1394.61 (27.7%) stddev-sans-first:1361.51 08:16:09 INFO - PROCESS | 1923 | Values: 352.1 360.0 367.6 368.5 371.0 5197.0 5320.5 5451.1 5456.3 5465.6 4286.6 4861.3 5260.4 5383.9 5400.6 3747.7 3838.8 3933.8 4273.1 4284.4 4119.8 4124.4 4273.6 4284.3 4297.4 3482.9 4159.9 4177.2 4196.3 4208.8 3848.5 4215.4 4224.2 4242.5 4267.3 3288.1 3529.5 3550.7 3697.9 3765.2 4692.6 4974.8 5021.3 5259.4 5334.8 3875.7 3934.0 4622.0 4940.2 4966.0 4666.0 4937.7 5428.3 5757.5 5789.7 3654.2 4072.2 4092.4 4132.7 4157.6 4973.5 5206.0 5519.3 5563.5 5989.3 4022.4 4155.9 4166.8 4205.6 4258.8 4120.5 4251.9 4288.3 4305.0 4322.7 4258.4 4266.4 4558.5 4596.8 4871.6 5530.1 5779.4 5817.4 5831.8 5858.9 1056.9 1285.8 1318.2 1381.8 1407.4 878.6 956.7 985.4 991.9 995.3 4642.6 4690.5 4791.9 5006.6 5106.6 4460.0 5573.2 5591.6 5612.0 5656.8 4515.8 4854.6 4910.0 5058.7 5090.9 2588.0 2775.6 2908.3 2924.6 2989.1 5284.0 5484.7 5869.7 5891.5 5917.3 5267.7 5591.6 5622.0 5871.7 6007.4 5285.9 6173.8 6213.0 6234.1 6241.9 5057.6 5471.3 5664.0 6053.9 6075.1 5205.6 5774.7 5935.1 5945.0 5945.6 5715.4 6011.5 6193.8 6225.9 6243.9 3876.5 3952.3 3990.3 4017.6 4019.9 5717.4 5917.3 5970.5 6006.8 6018.7 4748.8 5554.2 5698.7 5764.0 5881.2 4626.8 4918.5 5786.4 5786.4 5833.9 4673.3 5092.5 5593.9 5669.9 5691.0 4355.2 5329.9 5728.5 5731.7 5789.4 5078.9 5087.3 5197.5 5650.3 5654.0 08:16:09 INFO - PROCESS | 1923 | 08:16:09 INFO - PROCESS | 1923 | [#5] yui.html Cycles:180 Average:19851.41 Median:3677.63 stddev:28347.73 (770.8%) stddev-sans-first:28390.81 08:16:09 INFO - PROCESS | 1923 | Values: 705.9 708.9 775.8 823.7 830.0 15026.3 15254.8 15551.4 15710.8 15807.6 14310.9 14331.3 14354.7 14626.9 14638.0 867.1 875.5 881.0 881.9 882.6 683.4 700.0 844.8 861.7 867.0 900.8 914.5 921.7 926.2 928.1 907.4 916.6 917.2 919.5 919.7 683.1 684.5 684.6 686.6 687.4 15167.2 15279.7 15301.6 15315.0 15794.4 14190.4 14491.3 14789.6 14792.6 14848.9 11520.6 11764.1 11792.7 11838.7 11864.6 3492.4 3616.4 3635.9 3734.5 3736.9 106568.5 112419.4 113667.0 115159.0 116417.3 11023.8 11209.9 11381.1 11417.1 11498.5 19011.5 20510.3 20529.5 20818.1 24108.0 6658.5 6967.4 7779.3 7785.8 7971.6 3719.4 4073.4 4148.6 4224.1 4293.6 3517.8 3562.4 3613.3 3619.7 3623.2 539.9 569.8 645.3 650.9 666.7 588.3 660.9 681.6 696.6 698.6 9548.6 10255.3 10268.1 10468.7 10517.3 555.5 576.2 606.5 644.9 693.8 4819.0 4973.8 4991.0 4994.2 5003.6 76860.6 92751.6 97050.5 98437.5 100175.0 51650.0 80283.6 84420.0 87142.0 89570.0 73991.0 74252.6 74697.0 75835.6 76180.6 10574.4 10723.5 10768.1 10903.5 11069.0 43367.0 45686.8 47385.3 47955.8 49846.0 62992.0 64175.7 64348.0 66102.3 66673.0 12292.4 12444.3 12455.4 12495.4 12584.4 13756.6 13830.7 14392.9 14407.5 14414.1 12946.9 13299.3 13451.5 13608.1 13917.4 12478.9 13262.0 13428.0 13739.0 13858.7 12574.2 13279.5 13540.6 13661.2 13666.2 9975.2 10603.6 10632.8 11079.6 11619.7 9430.2 10011.0 10661.3 10662.4 10944.3 08:16:09 INFO - PROCESS | 1923 | -------- Summary: end -------- 08:16:09 INFO - PROCESS | 1923 | 08:16:09 INFO - PROCESS | 1923 | 1488384969244 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 08:16:09 INFO - TEST-INFO | 1923: exit 0 08:16:09 INFO - TEST-OK | dromaeo_css | took 1115228ms 08:16:09 INFO - TEST-START | kraken 08:16:10 INFO - operating with platform_type : mac_ 08:16:10 INFO - Initialising browser for kraken test... 08:16:10 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpro63nw/profile http://localhost:49726/getInfo.html) 08:16:10 INFO - PROCESS | 1928 | 1488384970512 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 08:16:10 INFO - PROCESS | 1928 | 1488384970513 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 08:16:10 INFO - PROCESS | 1928 | 1488384970548 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 08:16:12 INFO - PROCESS | 1928 | 2017-03-01 08:16:12.795 plugin-container[1929:17372] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 08:16:12 INFO - PROCESS | 1928 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:16:12 INFO - PROCESS | 1928 | 2017-03-01 08:16:12.798 plugin-container[1929:17372] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a4b, name = 'com.apple.CFPasteboardClient' 08:16:12 INFO - PROCESS | 1928 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:16:12 INFO - PROCESS | 1928 | 2017-03-01 08:16:12.798 plugin-container[1929:17372] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:16:12 INFO - PROCESS | 1928 | __metrics Screen width/height:1600/1200 08:16:12 INFO - PROCESS | 1928 | colorDepth:24 08:16:12 INFO - PROCESS | 1928 | Browser inner width/height: 1024/689 08:16:12 INFO - PROCESS | 1928 | __metrics 08:16:12 ERROR - PROCESS | 1928 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 08:16:12 INFO - PROCESS | 1928 | 1488384972950 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 08:16:13 INFO - TEST-INFO | 1928: exit 0 08:16:13 INFO - Browser initialized. 08:16:13 INFO - Running cycle 1/1 for kraken test... 08:16:13 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpro63nw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:13 INFO - PROCESS | 1930 | 1488384973947 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 08:16:13 INFO - PROCESS | 1930 | 1488384973948 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 08:16:15 INFO - PROCESS | 1930 | 2017-03-01 08:16:15.965 plugin-container[1931:17499] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 08:16:15 INFO - PROCESS | 1930 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:16:15 INFO - PROCESS | 1930 | 2017-03-01 08:16:15.966 plugin-container[1931:17499] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 08:16:15 INFO - PROCESS | 1930 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:16:15 INFO - PROCESS | 1930 | 2017-03-01 08:16:15.966 plugin-container[1931:17499] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:16:25 INFO - PROCESS | 1930 | RSS: Main: 219013120 08:16:25 INFO - PROCESS | 1930 | 08:16:28 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:49726/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49726/tests/kraken/driver.html?testName=audio-beat-detection) 08:16:29 INFO - PROCESS | 1930 | RSS: Main: 233345024 08:16:29 INFO - PROCESS | 1930 | 08:16:32 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:49726/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49726/tests/kraken/driver.html?testName=audio-dft) 08:16:32 INFO - PROCESS | 1930 | RSS: Main: 241426432 08:16:32 INFO - PROCESS | 1930 | 08:16:36 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:49726/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49726/tests/kraken/driver.html?testName=audio-fft) 08:16:36 INFO - PROCESS | 1930 | RSS: Main: 245157888 08:16:36 INFO - PROCESS | 1930 | 08:16:38 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:49726/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49726/tests/kraken/driver.html?testName=audio-oscillator) 08:16:39 INFO - PROCESS | 1930 | RSS: Main: 245469184 08:16:39 INFO - PROCESS | 1930 | 08:16:41 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:49726/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49726/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:16:42 INFO - PROCESS | 1930 | RSS: Main: 245465088 08:16:42 INFO - PROCESS | 1930 | 08:16:45 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:49726/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49726/tests/kraken/driver.html?testName=imaging-darkroom) 08:16:45 INFO - PROCESS | 1930 | RSS: Main: 250224640 08:16:45 INFO - PROCESS | 1930 | 08:16:49 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:49726/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49726/tests/kraken/driver.html?testName=imaging-desaturate) 08:16:49 INFO - PROCESS | 1930 | RSS: Main: 250150912 08:16:49 INFO - PROCESS | 1930 | 08:16:52 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:49726/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49726/tests/kraken/driver.html?testName=json-parse-financial) 08:16:53 INFO - PROCESS | 1930 | RSS: Main: 250068992 08:16:53 INFO - PROCESS | 1930 | 08:16:54 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:49726/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49726/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:16:55 INFO - PROCESS | 1930 | RSS: Main: 249729024 08:16:55 INFO - PROCESS | 1930 | 08:16:57 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:49726/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49726/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:16:58 INFO - PROCESS | 1930 | RSS: Main: 249696256 08:16:58 INFO - PROCESS | 1930 | 08:17:00 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:49726/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49726/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:17:00 INFO - PROCESS | 1930 | RSS: Main: 249737216 08:17:00 INFO - PROCESS | 1930 | 08:17:03 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:49726/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49726/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:17:04 INFO - PROCESS | 1930 | RSS: Main: 250073088 08:17:04 INFO - PROCESS | 1930 | 08:17:07 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:49726/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49726/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:17:08 INFO - PROCESS | 1930 | RSS: Main: 249950208 08:17:08 INFO - PROCESS | 1930 | 08:17:09 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:49726/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49726/tests/kraken/driver.html?testName=ai-astar) 08:17:10 INFO - PROCESS | 1930 | RSS: Main: 251797504 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | __start_tp_report 08:17:10 INFO - PROCESS | 1930 | _x_x_mozilla_page_load 08:17:10 INFO - PROCESS | 1930 | _x_x_mozilla_page_load_details 08:17:10 INFO - PROCESS | 1930 | |i|pagename|runs| 08:17:10 INFO - PROCESS | 1930 | |0;ai-astar;105;116;121;119;118;119;118;118;117;118 08:17:10 INFO - PROCESS | 1930 | |1;audio-beat-detection;133;111;111;142;115;103;99;97;113;152 08:17:10 INFO - PROCESS | 1930 | |2;audio-dft;197;200;212;239;180;270;274;203;195;194 08:17:10 INFO - PROCESS | 1930 | |3;audio-fft;82;60;61;78;70;85;82;81;64;75 08:17:10 INFO - PROCESS | 1930 | |4;audio-oscillator;85;58;84;91;100;106;107;71;71;84 08:17:10 INFO - PROCESS | 1930 | |5;imaging-gaussian-blur;107;110;135;82;118;115;136;129;89;101 08:17:10 INFO - PROCESS | 1930 | |6;imaging-darkroom;98;96;146;98;145;133;152;148;96;124 08:17:10 INFO - PROCESS | 1930 | |7;imaging-desaturate;92;94;96;92;103;93;96;98;93;102 08:17:10 INFO - PROCESS | 1930 | |8;json-parse-financial;59;58;59;63;63;62;62;62;62;62 08:17:10 INFO - PROCESS | 1930 | |9;json-stringify-tinderbox;74;69;70;80;70;69;69;72;71;71 08:17:10 INFO - PROCESS | 1930 | |10;stanford-crypto-aes;84;85;85;86;84;84;87;89;85;74 08:17:10 INFO - PROCESS | 1930 | |11;stanford-crypto-ccm;136;145;149;156;157;153;158;157;212;159 08:17:10 INFO - PROCESS | 1930 | |12;stanford-crypto-pbkdf2;167;173;166;167;169;177;233;241;170;167 08:17:10 INFO - PROCESS | 1930 | |13;stanford-crypto-sha256-iterative;67;67;66;67;68;66;68;67;65;66 08:17:10 INFO - PROCESS | 1930 | __end_tp_report 08:17:10 INFO - PROCESS | 1930 | __start_cc_report 08:17:10 INFO - PROCESS | 1930 | _x_x_mozilla_cycle_collect,978 08:17:10 INFO - PROCESS | 1930 | __end_cc_report 08:17:10 INFO - PROCESS | 1930 | __startTimestamp1488385030209__endTimestamp 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | ------- Summary: start ------- 08:17:10 INFO - PROCESS | 1930 | Number of tests: 14 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | [#0] ai-astar Cycles:10 Average:116.90 Median:118.00 stddev:4.38 (3.7%) stddev-sans-first:1.39 08:17:10 INFO - PROCESS | 1930 | Values: 105.0 116.0 121.0 119.0 118.0 119.0 118.0 118.0 117.0 118.0 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | [#1] audio-beat-detection Cycles:10 Average:117.60 Median:137.50 stddev:18.60 (13.5%) stddev-sans-first:18.88 08:17:10 INFO - PROCESS | 1930 | Values: 133.0 111.0 111.0 142.0 115.0 103.0 99.0 97.0 113.0 152.0 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | [#2] audio-dft Cycles:10 Average:216.40 Median:207.50 stddev:33.05 (15.9%) stddev-sans-first:34.30 08:17:10 INFO - PROCESS | 1930 | Values: 197.0 200.0 212.0 239.0 180.0 270.0 274.0 203.0 195.0 194.0 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | [#3] audio-fft Cycles:10 Average:73.80 Median:79.50 stddev:9.40 (11.8%) stddev-sans-first:9.49 08:17:10 INFO - PROCESS | 1930 | Values: 82.0 60.0 61.0 78.0 70.0 85.0 82.0 81.0 64.0 75.0 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | [#4] audio-oscillator Cycles:10 Average:85.70 Median:77.50 stddev:16.00 (20.6%) stddev-sans-first:16.97 08:17:10 INFO - PROCESS | 1930 | Values: 85.0 58.0 84.0 91.0 100.0 106.0 107.0 71.0 71.0 84.0 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | [#5] imaging-gaussian-blur Cycles:10 Average:112.20 Median:132.00 stddev:18.31 (13.9%) stddev-sans-first:19.32 08:17:10 INFO - PROCESS | 1930 | Values: 107.0 110.0 135.0 82.0 118.0 115.0 136.0 129.0 89.0 101.0 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | [#6] imaging-darkroom Cycles:10 Average:123.60 Median:124.00 stddev:24.23 (19.5%) stddev-sans-first:23.86 08:17:10 INFO - PROCESS | 1930 | Values: 98.0 96.0 146.0 98.0 145.0 133.0 152.0 148.0 96.0 124.0 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:93.50 stddev:3.98 (4.3%) stddev-sans-first:3.97 08:17:10 INFO - PROCESS | 1930 | Values: 92.0 94.0 96.0 92.0 103.0 93.0 96.0 98.0 93.0 102.0 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:62.00 stddev:1.81 (2.9%) stddev-sans-first:1.74 08:17:10 INFO - PROCESS | 1930 | Values: 59.0 58.0 59.0 63.0 63.0 62.0 62.0 62.0 62.0 62.0 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:71.00 stddev:3.37 (4.8%) stddev-sans-first:3.46 08:17:10 INFO - PROCESS | 1930 | Values: 74.0 69.0 70.0 80.0 70.0 69.0 69.0 72.0 71.0 71.0 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:85.00 stddev:3.95 (4.6%) stddev-sans-first:4.18 08:17:10 INFO - PROCESS | 1930 | Values: 84.0 85.0 85.0 86.0 84.0 84.0 87.0 89.0 85.0 74.0 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | [#11] stanford-crypto-ccm Cycles:10 Average:158.20 Median:157.00 stddev:20.23 (12.9%) stddev-sans-first:19.79 08:17:10 INFO - PROCESS | 1930 | Values: 136.0 145.0 149.0 156.0 157.0 153.0 158.0 157.0 212.0 159.0 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.00 Median:171.50 stddev:28.72 (16.7%) stddev-sans-first:29.87 08:17:10 INFO - PROCESS | 1930 | Values: 167.0 173.0 166.0 167.0 169.0 177.0 233.0 241.0 170.0 167.0 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 08:17:10 INFO - PROCESS | 1930 | Values: 67.0 67.0 66.0 67.0 68.0 66.0 68.0 67.0 65.0 66.0 08:17:10 INFO - PROCESS | 1930 | -------- Summary: end -------- 08:17:10 INFO - PROCESS | 1930 | 08:17:10 INFO - PROCESS | 1930 | 1488385030233 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 08:17:11 INFO - TEST-INFO | 1930: exit 0 08:17:11 INFO - TEST-OK | kraken | took 61079ms 08:17:11 INFO - SUITE-END | took 1176s 08:17:11 INFO - Completed test suite (00:19:36) 08:17:11 INFO - javascript benchmark 08:17:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7222.667509996419, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2915.0, 3197.968020319797, 3329.0845017620136, 3342.9164270893225, 3357.764956453048, 5511.862203444916, 5525.613207075507, 5551.861203469915, 5593.580481463886, 5609.1305847593585, 5570.220169176318, 5620.831375058755, 5623.915641265385, 5648.802291919784, 5664.433556644333, 5052.671576347544, 5127.333446651949, 5158.896822063556, 5200.973995130038, 5224.660397074197, 5171.250168725533, 5180.663256888291, 5201.68789872607, 5212.947870521303, 5219.9478005220035, 5039.874003149914, 5088.618353623475, 5211.296474975887, 5216.217567364888, 5259.789608415659, 4277.738067270132, 4287.678424118204, 4956.504349565051, 5099.7960081596875, 5105.770240339175, 5044.39467263927, 5128.051310507531, 5137.280780690707, 5159.942211846563, 5192.506711862367, 5454.372747134091, 5533.142362933751, 5577.609567330289, 5653.971730141323, 5678.829635110953, 5516.786307012451, 5688.345840228344, 6051.939480605181, 6105.786297479612, 6169.568130230886, 6184.5052395808225, 6186.257649082139, 6190.133381326618, 6202.441780239755, 6213.03697926822, 5714.971425142848, 5716.199732037559, 5725.198472213893, 5725.742341594597, 5759.222504961818, 6141.355157708465, 6171.382861713792, 6190.133381326618, 6190.783322583688, 6236.6258024518675, 6046.123312119718, 6084.969575152184, 6092.482139018233, 6106.877862442815, 6134.171886795315, 6128.877422451526, 6191.504679625709, 6193.102000209944, 6203.689815509297, 6209.534284928558, 5973.074173503114, 5991.880162396815, 6026.879462410728, 6050.727717252734, 6170.753169873245, 6147.538934579924, 6151.7539298428455, 6152.692365381713, 6155.599886007395, 6179.196704428396, 4932.802687892516, 4933.161362568372, 4938.827141050046, 4941.03649788295, 4942.308076869242, 4308.418363520885, 4337.609615134653, 4418.072204836956, 4420.955790442119, 4430.224710675683, 5607.719614019283, 5629.634073785191, 5671.064274394678, 5685.090385538294, 5769.249997500298, 6178.62928224308, 6220.533459990519, 6238.344973777688, 6250.531210159165, 6260.467860231931, 5515.09001014828, 5566.582506311962, 5640.266765320482, 5664.773409063674, 5690.772369105272, 5379.246905433242, 5388.0, 5389.380221274603, 5405.864853378697, 5433.0, 6267.903116954515, 6270.874582508324, 6286.9371306288185, 6289.528285378615, 6304.275008373912, 6093.9085913712215, 6098.176746139215, 6120.632762034292, 6123.069106197319, 6225.875482490415, 6180.0, 6214.533909956862, 6226.844328891814, 6240.4071613196675, 6267.0, 6024.3674414187635, 6096.603720758137, 6101.694915254308, 6114.38856114385, 6119.877602448015, 6046.3046749624355, 6106.73370229429, 6132.8773424532155, 6200.193974783249, 6201.81394558164, 5951.196588460502, 6046.153538504701, 6060.575759696779, 6100.0, 6109.144719739329, 5903.557233207613, 5985.491233245223, 6003.8198854034445, 6049.153118563493, 6053.697315134314, 4460.397846290709, 5638.774449021993, 5709.857253568528, 5797.623154494944, 5813.128030795415, 4846.418429788448, 5905.114232865105, 5912.408759124053, 5963.0459126539545, 6067.423594758491, 5870.823875283749, 5884.558658100746, 5889.116632505158, 5894.646321220741, 5900.970495147497], "value": 5597.473597135919, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.283714638006, 456.9885752856178, 474.1276052064201, 491.373498789044, 497.65910351409264, 35297.823510882445, 39266.60733392665, 39323.21353572927, 39337.40993885094, 39385.0, 41522.792386038025, 41586.79206603971, 41729.58270417295, 42002.0, 42132.57867421325, 8408.915910840875, 8634.395592308509, 9131.269498440142, 9386.765330866714, 9401.858972115424, 11204.775904481905, 11497.770044599103, 11528.769424611502, 11626.767464650744, 11633.418329083554, 11474.368909709963, 11522.366269855154, 11525.0, 11531.365774882379, 11552.768944621102, 11179.273347232403, 11378.601748938789, 11407.0, 11422.14333924959, 11446.656600302003, 11272.267302625303, 11328.0, 11338.0, 11352.978231959163, 11357.772844543062, 40284.798576006935, 40427.59572404297, 40479.7976010121, 40480.59519404827, 40528.1894362114, 3815.828287727059, 3935.152972983728, 3959.208158368338, 3979.2240513099955, 4137.710360274752, 27170.45659086827, 29269.0, 30127.548086778716, 30976.0, 31126.910558130356, 3072.969270307313, 3149.3543823516125, 3213.0, 3229.83850807461, 3310.536524886518, 456195.0, 459658.0, 461276.0, 462178.0, 463918.6804065992, 61902.69048654818, 62203.688981554806, 62314.376856231764, 62421.37578624247, 62453.0, 65977.34022659712, 66205.33794662089, 66343.0, 66548.33451665519, 66602.0, 16190.028598283905, 16524.0, 16755.0, 16782.58043548921, 16803.579910502336, 11477.770444591062, 11798.174127810971, 12666.556670516487, 12811.359432028548, 12919.935400323126, 17043.0, 17196.914015429844, 17285.481435556703, 17392.3043078278, 17562.560935976704, 6472.644004579794, 6515.0, 6941.826454338581, 7411.814109742415, 7762.146163921964, 856.5631527920805, 875.2778957360204, 878.6173233052823, 885.2784980241083, 912.4388501071793, 25063.87468062648, 29297.414051718846, 29363.706362936526, 29425.411491770046, 29941.0, 1016.6035246253966, 1038.5689938675516, 1066.4774260612398, 1083.8807731149568, 1091.9235653504338, 11785.764284714258, 13615.863841361459, 14869.479568215276, 15353.0, 15477.5356739298, 530021.0, 602514.0, 606104.0, 609092.0, 610325.0, 59019.40980590225, 59148.40851591429, 59246.70376648089, 59369.40630593725, 59744.40255597475, 1394.3516264936852, 1430.399232322427, 1453.0772959171002, 1454.7963285140302, 1458.941642334316, 28607.427851442437, 29518.55722164212, 29559.408811824072, 29778.702212977594, 30094.69905300919, 50117.0, 50484.747576261885, 50651.0, 50655.74672126616, 50750.74624626853, 436467.0, 436681.0, 439464.0, 439670.0, 441528.0, 24346.391340216636, 25045.373865652775, 25093.0, 39067.21865562729, 39420.40869387019, 40909.36362545465, 40988.1802363957, 41819.581804181566, 42149.0, 42620.0, 34868.9539313821, 34956.30087398289, 35031.64968350284, 35772.28455430929, 35902.281954360245, 34741.82629086838, 34835.825820870734, 35777.64222357743, 35849.46225806667, 35992.100197495274, 33429.66570334265, 33744.49383259302, 34214.48678269778, 34344.313113738084, 34779.478307824895, 29761.10716678503, 31511.84244078765, 31615.051548453583, 31618.841905790323, 31731.206719831265, 23642.290731278088, 23700.170494032627, 23725.050997960578, 23977.0, 24113.638295425233], "value": 19742.60333273286, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.9088414222657, 390.7870210735149, 397.63616291093643, 402.4908490759189, 417.0075220974081, 13941.372638231278, 15376.846231537682, 19982.0, 20750.377488675345, 20843.791562084374, 19987.600247995033, 20160.294389696362, 20444.897775511137, 20469.283575074838, 20606.69089963648, 4780.952190478086, 4920.483349248331, 5528.668279903219, 5547.861303467405, 5549.139883318092, 4880.682755620891, 5635.802746903859, 5773.134029895507, 5776.682282474462, 5783.479486846183, 5476.91784623231, 5656.321241451032, 5690.317161940573, 5702.7433765480655, 5705.971470142644, 5441.7279136043435, 5702.087665973424, 5710.7430165642645, 5714.371419143891, 5718.9428105719035, 4935.3090567320605, 4954.083494553519, 4987.576056035241, 4993.425756038066, 4998.150314446553, 19538.218471261134, 24463.633045504153, 24474.877625611756, 24837.254882353558, 24916.5016699665, 2224.343818573525, 2611.8824652890667, 2653.8805753741126, 2675.692295386036, 2699.0688212566633, 14630.853691463055, 14973.775393369107, 15076.472323468626, 15391.692166156727, 15710.0, 1698.371602507068, 1808.6834803909264, 1810.1582764014665, 1812.2116879157609, 1813.07533158089, 111499.88500115057, 112976.0, 114750.42624786822, 120339.0, 137708.0, 11663.125265605113, 11757.470913808898, 11928.46321915516, 11940.641780746591, 12064.276143431422, 15201.01193422424, 15262.542123736306, 15285.38858445672, 15294.00588961714, 15307.846921530865, 8018.919810801934, 8349.165083491602, 8592.613332400057, 8730.126987301219, 8831.514266715392, 8440.0, 8447.676888855614, 8461.196186362286, 8610.311175105977, 8618.569071546397, 4701.529847015271, 4725.385699858996, 4726.787294571753, 4758.500357462417, 4788.162071637449, 2034.2574960139739, 2063.535704466513, 2072.968905466419, 2074.3258441006733, 2078.0, 1011.9930668984408, 1022.6829682798208, 1028.3726926574784, 1047.9161667066617, 1062.0866055192528, 16169.0, 17023.659526809643, 19177.616447670967, 19854.404367868698, 20021.399358019284, 979.3829887171037, 991.3704797453669, 1032.912202462799, 1045.9644951497962, 1083.268793564341, 10075.244356673278, 10548.156147508334, 10556.0, 10563.47182640865, 10721.35671859691, 624504.0, 713168.0, 717932.0, 729689.0, 732477.0, 145415.0, 148517.0, 148916.0, 148929.51070489374, 151354.48645513624, 433.71808324588636, 457.66819056184664, 458.8256462544212, 463.16861234084223, 1020.7193021919031, 10937.45312734376, 10992.340459572451, 11165.665030049111, 11392.829107563559, 11811.881881181078, 44430.88922776956, 55724.72137639286, 62641.20803693997, 64387.67806160939, 64466.0, 63933.0, 69396.0, 83077.5809771938, 86477.0, 88080.5595972016, 6290.685465726787, 7077.469189810682, 8428.915710843059, 8513.914860851311, 8745.825083498421, 9317.580708867981, 12441.813372799596, 12733.681657958625, 13309.800352994907, 13363.198208107544, 9039.59321830506, 10431.791364172826, 10760.0, 11184.832227516756, 11535.826962595736, 10479.0, 10864.45677716127, 11141.0, 11542.307461552333, 11567.710807229887, 11059.115270778479, 11407.144464165387, 11487.023602993504, 11694.941525292319, 11702.2978621283, 8174.100848906734, 8333.83332333362, 8399.286060684666, 8640.092790257184, 8691.86962195555, 10676.252662313875, 10804.027637512347, 10947.507362168562, 11121.221514493907, 11291.491882865126], "value": 9451.246886597259, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1248.544281337311, 1310.1091257944597, 1427.6145440730998, 1441.8486058963808, 1455.7161353536062, 7561.697532098709, 7835.294823465902, 8167.0, 8544.829103417927, 8568.314534837205, 8074.394420418463, 8240.175982401757, 8328.541930193836, 8427.410081294312, 8442.620082096306, 2337.906483740648, 2374.513224788923, 2376.6316220985773, 2378.0725517048363, 2382.95234095318, 1747.7503584936767, 2101.075526768217, 2182.8035476807086, 2207.6909232707435, 2389.223502361731, 2263.7736226377315, 2335.8364914455997, 2341.1922886604093, 2359.917402890899, 2360.728516220631, 2325.2791634593245, 2343.484433424644, 2353.752855950126, 2360.893759780814, 2362.208660098869, 2333.5449587330477, 2339.6724458575814, 2388.1880160745254, 2402.1712509184304, 2409.1929203716777, 8444.61999210037, 8473.70342038032, 8474.576271186477, 8534.914650853536, 8569.828603427959, 5098.668586541863, 5224.8693782655355, 5248.160294352885, 5257.973710131463, 5268.947310526884, 2937.970620293791, 3310.2386451116377, 3526.2771131917893, 3547.8580856765698, 3575.6781889630056, 1137.3346592243547, 1168.6902970712767, 1218.6770505815966, 1218.798898181799, 1237.8143278508296, 10787.784244315148, 10863.130949524098, 10927.562897484091, 10931.578894743712, 10932.305492648653, 3889.086064774776, 4617.746023968714, 4748.8337908173735, 4755.762211889391, 4804.087223427608, 7059.329363710439, 8422.694482355244, 8641.481511109228, 8662.177093176138, 8714.651413943371, 5153.613478989016, 5173.81891633791, 5173.948260517422, 5177.0, 5179.04187725272, 4601.401817763736, 4781.95218047822, 4821.108095002436, 4836.927446088312, 4865.489123642037, 3790.6967442604528, 3811.1805961718364, 3856.2094770571966, 3883.514560679915, 3905.6484916357663, 1100.3287994323457, 1140.4297851074464, 1165.2717051842599, 1191.0412118244724, 1203.807390817465, 692.6432887063166, 897.2059727141527, 899.59967814322, 906.7415786500816, 910.2172131966504, 5535.169724541351, 5589.557924931403, 5652.434756524314, 5692.288463942007, 5824.88350232993, 955.6082006377352, 982.4792859784326, 1000.5547531348626, 1003.7440452684518, 1021.213665477578, 3567.4827150063616, 3651.507046548682, 3677.44838274261, 3740.551133863954, 3884.7280690351404, 8183.345332373396, 10088.092071713581, 10227.59089636421, 10252.23108266883, 10270.6405275815, 10021.0, 10084.294099413117, 10122.949385253174, 10196.99999999985, 10202.846957295647, 6798.912174052128, 7880.566568838769, 7941.523508589503, 8015.839683206304, 8044.31623312025, 5089.720065396291, 5306.495882891119, 5454.836354909359, 5576.944230557805, 5612.887742245214, 9008.819823603622, 9097.0, 9204.355695101278, 9317.068293170629, 9321.347505674537, 9262.490563019099, 9352.579133938852, 9400.623975040922, 9474.95262523683, 9650.95174524123, 6786.457083433214, 6843.863122737418, 6879.6560171992205, 6901.482388820959, 6909.516333856582, 7813.882791758015, 7816.804579885548, 7907.367410607023, 7920.683172673259, 7922.405819563671, 7050.294970502909, 7130.073090498409, 7177.784666460015, 7193.388561972291, 7299.452541059336, 7038.472114591528, 7076.716931322895, 7086.0433841432805, 7105.8578828422105, 7127.928720712934, 6252.781152659635, 6364.172657554488, 6373.171487706569, 6441.355864413708, 6501.804945851632, 3982.4623675803396, 4316.330968699856, 4939.777710003131, 5052.646314757932, 5112.514311140436, 4444.377787109743, 4967.7019378837385, 5003.699778013331, 5119.820806271762, 5153.072446959583], "value": 4386.406517701943, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.1355073295059, 359.9622039685833, 367.5827935293441, 368.4841222288795, 370.9591944886064, 5196.960607878421, 5320.494553017457, 5451.100568406213, 5456.3179602549635, 5465.561766042788, 4286.635635970946, 4861.270809378595, 5260.395054568726, 5383.87337001885, 5400.594955378352, 3747.6883090918095, 3838.8272527736317, 3933.7639741615594, 4273.145370925812, 4284.443022407083, 4119.8352065917325, 4124.381342798574, 4273.594008569181, 4284.2648727265505, 4297.376880352347, 3482.9477557836526, 4159.857673298254, 4177.16456708658, 4196.307609244471, 4208.789560521977, 3848.499695039627, 4215.409842622035, 4224.176285624305, 4242.512111107231, 4267.253230684618, 3288.1122097033667, 3529.4882242075014, 3550.680438760498, 3697.8890633281044, 3765.1528406108405, 4692.601128904047, 4974.751262436864, 5021.347224860781, 5259.3951695555115, 5334.786608535654, 3875.7286989910435, 3933.9803300983313, 4622.0293738314995, 4940.1601727706375, 4965.950340496621, 4666.0, 4937.716193789604, 5428.348598168205, 5757.466714645542, 5789.681567513785, 3654.2326111516613, 4072.246634372621, 4092.4475195848477, 4132.690048246393, 4157.648764151662, 4973.502649735034, 5206.0, 5519.282493275889, 5563.527100196488, 5989.3112292086535, 4022.35642297231, 4155.877912963543, 4166.83332666696, 4205.5794420557695, 4258.829646814154, 4120.464339635888, 4251.893702657459, 4288.335308027261, 4304.956950430455, 4322.7190232634775, 4258.445667331402, 4266.424032755538, 4558.475775285819, 4596.770566275354, 4871.634627402959, 5530.142827861688, 5779.410662067881, 5817.360090390139, 5831.7667293307795, 5858.8535286617325, 1056.9365838049587, 1285.7878450055637, 1318.2156616812981, 1381.7581923163407, 1407.394820227312, 878.5519385113638, 956.6651671914914, 985.4136788610765, 991.8859331176862, 995.348047029197, 4642.605378542794, 4690.507496712864, 4791.904161916742, 5006.574441172468, 5106.617003724736, 4459.9777001115435, 5573.164025396223, 5591.608587398843, 5612.007737253298, 5656.773729050874, 4515.841945531891, 4854.563089321978, 4910.029432193472, 5058.698292277005, 5090.905455327123, 2587.974120258811, 2775.6114144019853, 2908.2695796001344, 2924.5905573219766, 2989.0733872499595, 5284.048871203144, 5484.725763711798, 5869.706514674334, 5891.499222566044, 5917.260342457193, 5267.71027593486, 5591.552675785927, 5621.959937411592, 5871.653157700155, 6007.3992600739575, 5285.889963107714, 6173.84565385869, 6212.968935155295, 6234.098599927066, 6241.938870392044, 5057.6459647824295, 5471.316085489314, 5663.9716801415725, 6053.878922421615, 6075.058365953284, 5205.557527610195, 5774.740136693775, 5935.109733540004, 5945.0, 5945.613535120204, 5715.428257229129, 6011.549133814894, 6193.783217587363, 6225.937740622717, 6243.937560624336, 3876.4960555127655, 3952.3478626026385, 3990.3415936370175, 4017.5580686123917, 4019.879403617896, 5717.3996730342715, 5917.3490915998345, 5970.4923931947815, 6006.819795406145, 6018.668973206516, 4748.815544849408, 5554.1946417770005, 5698.743556540048, 5763.982606087836, 5881.17663527098, 4626.791794369195, 4918.458969513279, 5786.363500014911, 5786.437661831366, 5833.912491312549, 4673.299005149119, 5092.516210959953, 5593.860153496195, 5669.943300566942, 5691.0, 4355.1725172217175, 5329.880725047783, 5728.455796699307, 5731.7103651678035, 5789.363170051375, 5078.949210507848, 5087.3386459759995, 5197.506236907639, 5650.3219613646625, 5654.038813401649], "value": 4178.409858364676, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.947053970952, 708.9397401220896, 775.7750252426797, 823.6664151018838, 830.0, 15026.323815428304, 15254.771178432333, 15551.377944882219, 15710.764338534917, 15807.604809879758, 14310.928445357784, 14331.28343582822, 14354.712905741879, 14626.926865365658, 14638.048526845747, 867.111211008718, 875.483464755794, 880.9779755506099, 881.9206271435602, 882.6028287270753, 683.4054372695762, 699.9720011199546, 844.7803571071535, 861.6682577207757, 866.9956650216772, 900.8198360327928, 914.5335878701877, 921.6866265469739, 926.2497377124517, 928.1461055828654, 907.3693782820942, 916.615021690888, 917.2341095185528, 919.5126582911101, 919.6827094652334, 683.0846665468297, 684.4832151725465, 684.6234570985938, 686.5503095472474, 687.3744892148121, 15167.24163791806, 15279.694406111927, 15301.61745956349, 15315.0, 15794.36822527109, 14190.43238270468, 14491.347889345005, 14789.630259243497, 14792.630184245372, 14848.851511484854, 11520.596779112691, 11764.058875290042, 11792.705182370424, 11838.704032399173, 11864.58473953416, 3492.406290930548, 3616.385214513539, 3635.8727444539577, 3734.533183352081, 3736.9252614947823, 106568.46715766449, 112419.43790281078, 113667.0, 115159.0, 116417.25374119396, 11023.83464248037, 11209.887901121048, 11381.146414018982, 11417.086633069335, 11498.540058397737, 19011.524711882037, 20510.282140125324, 20529.48676283105, 20818.063187156615, 24108.0, 6658.500612454085, 6967.407770339578, 7779.338756205672, 7785.844283114306, 7971.641276142587, 3719.386301260262, 4073.368627862686, 4148.605882441163, 4224.091820258659, 4293.635041021548, 3517.786363704518, 3562.412201986695, 3613.3134704406602, 3619.746617736786, 3623.2391197848747, 539.8839249561363, 569.7607005057886, 645.3417514135649, 650.9218893732782, 666.6966530228734, 588.341058015026, 660.9140811694546, 681.6455443169623, 696.554205308603, 698.5668885291051, 9548.570314335871, 10255.282130250811, 10268.07587317145, 10468.738281543023, 10517.263791534671, 555.4565436939367, 576.2364866551835, 606.5178183344252, 644.8503877547994, 693.8404167041608, 4818.975905120452, 4973.751312434364, 4990.950090499121, 4994.225894986283, 5003.649744517848, 76860.61569692228, 92751.60872586917, 97050.51474742581, 98437.50781246048, 100175.0, 51650.0, 80283.59858200671, 84420.0, 87142.0, 89570.0, 73991.0, 74252.62873685597, 74697.0, 75835.62082189663, 76180.61909690416, 10574.41840698769, 10723.540558956942, 10768.138548915911, 10903.454827258764, 11069.0, 43367.0, 45686.77156614196, 47385.34151304688, 47955.801104972656, 49846.0, 62992.0, 64175.679121604095, 64348.0, 66102.33897660962, 66673.0, 12292.446839892405, 12444.253344799341, 12455.377231138587, 12495.437705303464, 12584.433700483318, 13756.587302380945, 13830.723385532434, 14392.85607143957, 14407.495737649131, 14414.063085899803, 12946.93526532399, 13299.268540229994, 13451.529196478075, 13608.115472494255, 13917.37371818291, 12478.875211248134, 13262.003370937364, 13428.0, 13739.0, 13858.65353366174, 12574.182678125893, 13279.468821247428, 13540.59378218655, 13661.248631325372, 13666.18002919828, 9975.152112070555, 10603.575856965635, 10632.787344252916, 11079.5568177272, 11619.6514104577, 9430.245580353418, 10010.998900109931, 10661.307015043998, 10662.413567253876, 10944.288621239593], "value": 7415.38969505085, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 121.0, 119.0, 118.0, 119.0, 118.0, 118.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 111.0, 111.0, 142.0, 115.0, 103.0, 99.0, 97.0, 113.0, 152.0], "value": 117.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 200.0, 212.0, 239.0, 180.0, 270.0, 274.0, 203.0, 195.0, 194.0], "value": 216.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 61.0, 78.0, 70.0, 85.0, 82.0, 81.0, 64.0, 75.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 58.0, 84.0, 91.0, 100.0, 106.0, 107.0, 71.0, 71.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 135.0, 82.0, 118.0, 115.0, 136.0, 129.0, 89.0, 101.0], "value": 112.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 146.0, 98.0, 145.0, 133.0, 152.0, 148.0, 96.0, 124.0], "value": 123.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 96.0, 92.0, 103.0, 93.0, 96.0, 98.0, 93.0, 102.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 69.0, 70.0, 80.0, 70.0, 69.0, 69.0, 72.0, 71.0, 71.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 86.0, 84.0, 84.0, 87.0, 89.0, 85.0, 74.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 145.0, 149.0, 156.0, 157.0, 153.0, 158.0, 157.0, 212.0, 159.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 173.0, 166.0, 167.0, 169.0, 177.0, 233.0, 241.0, 170.0, 167.0], "value": 183.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 68.0, 66.0, 68.0, 67.0, 65.0, 66.0], "value": 66.7, "unit": "score"}]}]} 08:17:11 INFO - Return code: 0 08:17:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:17:11 ERROR - # TBPL SUCCESS # 08:17:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:17:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:17:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:17:11 INFO - 2017-03-01 08:17:11.523 screenresolution[1935:17881] starting screenresolution argv=screenresolution get 08:17:11 INFO - 2017-03-01 08:17:11.525 screenresolution[1935:17881] Display 0: 1600x1200x32@60 08:17:11 INFO - 2017-03-01 08:17:11.531 screenresolution[1936:17884] starting screenresolution argv=screenresolution list 08:17:11 INFO - Available Modes on Display 0 08:17:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:17:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:17:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:17:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:17:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:17:11 INFO - Intel Iris: 08:17:11 INFO - Chipset Model: Intel Iris 08:17:11 INFO - Type: GPU 08:17:11 INFO - Bus: Built-In 08:17:11 INFO - VRAM (Dynamic, Max): 1536 MB 08:17:11 INFO - Vendor: Intel (0x8086) 08:17:11 INFO - Device ID: 0x0a2e 08:17:11 INFO - Revision ID: 0x0009 08:17:11 INFO - Displays: 08:17:11 INFO - Display: 08:17:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:17:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:17:11 INFO - Display Serial Number: 1600x1200 60 08:17:11 INFO - Main Display: Yes 08:17:11 INFO - Mirror: Off 08:17:11 INFO - Online: Yes 08:17:11 INFO - Rotation: Supported 08:17:11 INFO - Return code: 0 08:17:11 INFO - Running post-action listener: _resource_record_post_action 08:17:11 INFO - [mozharness: 2017-03-01 16:17:11.767463Z] Finished run-tests step (success) 08:17:11 INFO - Running post-run listener: _resource_record_post_run 08:17:11 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 110592; Write bytes: 514063872; Read time: 3; Write time: 1617 08:17:11 INFO - TinderboxPrint: CPU usage
54.2% 08:17:11 INFO - TinderboxPrint: I/O read bytes / time
110,592 / 3 08:17:11 INFO - TinderboxPrint: I/O write bytes / time
514,063,872 / 1,617 08:17:11 INFO - TinderboxPrint: CPU idle
2,192.1 (45.8%) 08:17:11 INFO - TinderboxPrint: CPU system
962.5 (20.1%) 08:17:11 INFO - TinderboxPrint: CPU user
1,635.1 (34.1%) 08:17:11 INFO - TinderboxPrint: Swap in / out
207,388,672 / 0 08:17:11 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207464960; Write bytes: 203535872; Read time: 15904; Write time: 444 08:17:11 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 8192; Write bytes: 300517376; Read time: 1; Write time: 1139 08:17:12 INFO - Running post-run listener: _upload_blobber_files 08:17:12 INFO - Blob upload gear active. 08:17:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:17:12 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 08:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:17:12 INFO - (blobuploader) - INFO - Open directory for files ... 08:17:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:17:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:17:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:13 INFO - (blobuploader) - INFO - Done attempting. 08:17:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:17:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:17:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:14 INFO - (blobuploader) - INFO - Done attempting. 08:17:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:17:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:17:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:15 INFO - (blobuploader) - INFO - Done attempting. 08:17:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:17:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:17:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:17 INFO - (blobuploader) - INFO - Done attempting. 08:17:17 INFO - (blobuploader) - INFO - Iteration through files over. 08:17:17 INFO - Return code: 0 08:17:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:17:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:17:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7458fc7e7cdd2262272e240a6ef8aa2d4d50d8aef0541da5833f50ad4f46a5757e8bef13378577fa217864fd078d5630300063fcf87e446610bab9005d78983", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07b9add8c67ad2a838045e716fc685fc51c11a8e3a499dcd3edd462d924ece1bca5110054001885014d9d1fea0fd4c14bd8c4550be6baa0701ad21834a39ed51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c42b7b104c161df4bc66f78b0885a24ce647ae94a95acd9395221e165a0860f4fb63be1608e3cfe3fcac846f88b71c6e2af5108b0b8f28e0af2affc26a799c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e2d414c806d7855f1c5400e6f37e65b86959c58d6d6bc4e3545b7a5cdb54a80d3069049e2af21f0ce5d53e65a087777c3777f5ee37f1ab640973c0f59da28a4"} 08:17:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:17:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:17:17 INFO - Contents: 08:17:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7458fc7e7cdd2262272e240a6ef8aa2d4d50d8aef0541da5833f50ad4f46a5757e8bef13378577fa217864fd078d5630300063fcf87e446610bab9005d78983", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07b9add8c67ad2a838045e716fc685fc51c11a8e3a499dcd3edd462d924ece1bca5110054001885014d9d1fea0fd4c14bd8c4550be6baa0701ad21834a39ed51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c42b7b104c161df4bc66f78b0885a24ce647ae94a95acd9395221e165a0860f4fb63be1608e3cfe3fcac846f88b71c6e2af5108b0b8f28e0af2affc26a799c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e2d414c806d7855f1c5400e6f37e65b86959c58d6d6bc4e3545b7a5cdb54a80d3069049e2af21f0ce5d53e65a087777c3777f5ee37f1ab640973c0f59da28a4"} 08:17:17 INFO - Running post-run listener: copy_logs_to_upload_dir 08:17:17 INFO - Copying logs to upload dir... 08:17:17 INFO - mkdir: /builds/slave/test/build/upload/logs 08:17:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.798579 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-03-01 08:17:17.627423) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-01 08:17:17.631485) ========= 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.4rAm67G4tf/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.mpNWEj3Qkg/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7458fc7e7cdd2262272e240a6ef8aa2d4d50d8aef0541da5833f50ad4f46a5757e8bef13378577fa217864fd078d5630300063fcf87e446610bab9005d78983", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07b9add8c67ad2a838045e716fc685fc51c11a8e3a499dcd3edd462d924ece1bca5110054001885014d9d1fea0fd4c14bd8c4550be6baa0701ad21834a39ed51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c42b7b104c161df4bc66f78b0885a24ce647ae94a95acd9395221e165a0860f4fb63be1608e3cfe3fcac846f88b71c6e2af5108b0b8f28e0af2affc26a799c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e2d414c806d7855f1c5400e6f37e65b86959c58d6d6bc4e3545b7a5cdb54a80d3069049e2af21f0ce5d53e65a087777c3777f5ee37f1ab640973c0f59da28a4"} build_url:https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011050 build_url: 'https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7458fc7e7cdd2262272e240a6ef8aa2d4d50d8aef0541da5833f50ad4f46a5757e8bef13378577fa217864fd078d5630300063fcf87e446610bab9005d78983", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07b9add8c67ad2a838045e716fc685fc51c11a8e3a499dcd3edd462d924ece1bca5110054001885014d9d1fea0fd4c14bd8c4550be6baa0701ad21834a39ed51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c42b7b104c161df4bc66f78b0885a24ce647ae94a95acd9395221e165a0860f4fb63be1608e3cfe3fcac846f88b71c6e2af5108b0b8f28e0af2affc26a799c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e2d414c806d7855f1c5400e6f37e65b86959c58d6d6bc4e3545b7a5cdb54a80d3069049e2af21f0ce5d53e65a087777c3777f5ee37f1ab640973c0f59da28a4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-01 08:17:17.666618) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 08:17:17.666988) ========= 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.4rAm67G4tf/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.mpNWEj3Qkg/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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.005176 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 08:17:17.715987) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-01 08:17:17.716338) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-01 08:17:17.716678) ========= ========= Total master_lag: 0.25 =========