builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0241 starttime: 1491816608.25 results: success (0) buildid: 20170410004019 builduid: b096275487dc4d3690306396480ed334 revision: efca7a198376e7800873e4612a8b34fc77022d4d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 02:30:08.248774) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 02:30:08.249517) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 02:30:08.250027) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 02:30:08.281579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:30:08.282236) ========= 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.NE4UA7bLw6/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.clbVNB8od4/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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-04-10 02:30:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 5.95M=0.002s 2017-04-10 02:30:08 (5.95 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.342362 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:30:08.650274) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:30:08.650625) ========= 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.NE4UA7bLw6/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.clbVNB8od4/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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.027453 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:30:08.701489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-10 02:30:08.702147) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev efca7a198376e7800873e4612a8b34fc77022d4d --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 efca7a198376e7800873e4612a8b34fc77022d4d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NE4UA7bLw6/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.clbVNB8od4/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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-04-10 02:30:08,985 truncating revision to first 12 chars 2017-04-10 02:30:08,985 Setting DEBUG logging. 2017-04-10 02:30:08,985 attempt 1/10 2017-04-10 02:30:08,985 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/efca7a198376?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-10 02:30:11,092 unpacking tar archive at: mozilla-aurora-efca7a198376/testing/mozharness/ program finished with exit code 0 elapsedTime=2.378091 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-10 02:30:11.105027) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 02:30:11.105387) ========= script_repo_revision: efca7a198376e7800873e4612a8b34fc77022d4d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 02:30:11.105793) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 02:30:11.106062) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 02:30:11.126564) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 23 mins, 0 secs) (at 2017-04-10 02:30:11.127175) ========= /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.NE4UA7bLw6/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.clbVNB8od4/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:30:11 INFO - MultiFileLogger online at 20170410 02:30:11 in /builds/slave/test 02:30:11 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 02:30:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:30:11 INFO - {'append_to_log': False, 02:30:11 INFO - 'base_work_dir': '/builds/slave/test', 02:30:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:30:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:30:11 INFO - 'branch': 'Mozilla-Aurora', 02:30:11 INFO - 'buildbot_json_path': 'buildprops.json', 02:30:11 INFO - 'config_files': ('talos/mac_config.py',), 02:30:11 INFO - 'default_actions': ('clobber', 02:30:11 INFO - 'read-buildbot-config', 02:30:11 INFO - 'download-and-extract', 02:30:11 INFO - 'populate-webroot', 02:30:11 INFO - 'create-virtualenv', 02:30:11 INFO - 'install', 02:30:11 INFO - 'run-tests'), 02:30:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:30:11 INFO - 'download_minidump_stackwalk': True, 02:30:11 INFO - 'download_symbols': 'ondemand', 02:30:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:30:11 INFO - 'tooltool.py': '/tools/tooltool.py', 02:30:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:30:11 INFO - '/tools/misc-python/virtualenv.py')}, 02:30:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:30:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:30:11 INFO - 'gecko_profile': False, 02:30:11 INFO - 'gecko_profile_interval': 0, 02:30:11 INFO - 'installer_path': 'installer.exe', 02:30:11 INFO - 'log_level': 'info', 02:30:11 INFO - 'log_name': 'talos', 02:30:11 INFO - 'log_to_console': True, 02:30:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:30:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:30:11 INFO - 'opt_config_files': (), 02:30:11 INFO - 'pip_index': False, 02:30:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:30:11 INFO - 'cmd': ('bash', 02:30:11 INFO - '-c', 02:30:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:30:11 INFO - 'enabled': True, 02:30:11 INFO - 'halt_on_failure': False, 02:30:11 INFO - 'name': 'check_screen_resolution'},), 02:30:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:30:11 INFO - 'cmd': ('bash', 02:30:11 INFO - '-c', 02:30:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:30:11 INFO - 'enabled': True, 02:30:11 INFO - 'halt_on_failure': False, 02:30:11 INFO - 'name': 'check_screen_resolution'},), 02:30:11 INFO - 'run_cmd_checks_enabled': True, 02:30:11 INFO - 'suite': 'dromaeojs-e10s', 02:30:11 INFO - 'system_bits': '32', 02:30:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:30:11 INFO - 'title': 't-yosemite-r7-0241', 02:30:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:30:11 INFO - 'use_talos_json': True, 02:30:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:30:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:30:11 INFO - 'work_dir': 'build'} 02:30:11 INFO - [mozharness: 2017-04-10 09:30:11.517390Z] Running clobber step. 02:30:11 INFO - Running pre-action listener: _resource_record_pre_action 02:30:11 INFO - Running main action method: clobber 02:30:11 INFO - rmtree: /builds/slave/test/build 02:30:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:30:13 INFO - Running post-action listener: _resource_record_post_action 02:30:13 INFO - [mozharness: 2017-04-10 09:30:13.959254Z] Finished clobber step (success) 02:30:13 INFO - [mozharness: 2017-04-10 09:30:13.959379Z] Running read-buildbot-config step. 02:30:13 INFO - Running pre-action listener: _resource_record_pre_action 02:30:13 INFO - Running main action method: read_buildbot_config 02:30:13 INFO - Using buildbot properties: 02:30:13 INFO - { 02:30:13 INFO - "project": "", 02:30:13 INFO - "product": "firefox", 02:30:13 INFO - "script_repo_revision": "production", 02:30:13 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:30:13 INFO - "repository": "", 02:30:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:30:13 INFO - "buildid": "20170410004019", 02:30:13 INFO - "stage_platform": "macosx64", 02:30:13 INFO - "basedir": "/builds/slave/test", 02:30:13 INFO - "nightly_build": "True", 02:30:13 INFO - "buildnumber": 11, 02:30:13 INFO - "slavename": "t-yosemite-r7-0241", 02:30:13 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 02:30:13 INFO - "platform": "yosemite_r7", 02:30:13 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:30:13 INFO - "branch": "mozilla-aurora", 02:30:13 INFO - "repo_path": "releases/mozilla-aurora", 02:30:13 INFO - "revision": "efca7a198376e7800873e4612a8b34fc77022d4d", 02:30:13 INFO - "pgo_build": "False", 02:30:13 INFO - "builduid": "b096275487dc4d3690306396480ed334", 02:30:13 INFO - "slavebuilddir": "test" 02:30:13 INFO - } 02:30:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:30:13 INFO - Running post-action listener: _resource_record_post_action 02:30:13 INFO - [mozharness: 2017-04-10 09:30:13.962696Z] Finished read-buildbot-config step (success) 02:30:13 INFO - [mozharness: 2017-04-10 09:30:13.962799Z] Running download-and-extract step. 02:30:13 INFO - Running pre-action listener: _resource_record_pre_action 02:30:13 INFO - Running main action method: download_and_extract 02:30:13 INFO - mkdir: /builds/slave/test/build/tests 02:30: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')]} 02:30:13 INFO - trying https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:30:13 INFO - Downloading https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:30:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:30:16 INFO - Downloaded 1199 bytes. 02:30:16 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:30:16 INFO - Using the following test package requirements: 02:30:16 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:30:16 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:30:16 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:30:16 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:30:16 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:30:16 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:30:16 INFO - u'jsshell-mac.zip'], 02:30:16 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:30:16 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:30:16 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:30:16 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:30:16 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:30:16 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:30:16 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:30:16 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:30:16 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:30:16 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:30:16 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:30:16 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:30:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:30:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:30:16 INFO - Fetch https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:30:18 INFO - Expected file size: 51790143 02:30:18 INFO - Obtained file size: 51790143 02:30:33 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:30:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:30:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:30:33 INFO - Fetch https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:31:05 INFO - retry: attempt #1 caught exception: '' 02:31:05 INFO - retry: Failed, sleeping 60 seconds before retrying 02:32:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #2 02:32:05 INFO - Fetch https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:32:07 INFO - Expected file size: 51790143 02:32:07 INFO - Obtained file size: 51790143 02:32:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:32:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:32:22 INFO - Fetch https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:32:25 INFO - Expected file size: 14404424 02:32:25 INFO - Obtained file size: 14404424 02:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:25 INFO - trying https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:32:25 INFO - Downloading https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:32:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:32:27 INFO - Downloaded 74724700 bytes. 02:32:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:32:27 INFO - mkdir: /builds/slave/test/properties 02:32:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:32:27 INFO - Writing to file /builds/slave/test/properties/build_url 02:32:27 INFO - Contents: 02:32:27 INFO - build_url:https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:32:28 INFO - Running post-action listener: _resource_record_post_action 02:32:28 INFO - Running post-action listener: set_extra_try_arguments 02:32:28 INFO - [mozharness: 2017-04-10 09:32:28.699774Z] Finished download-and-extract step (success) 02:32:28 INFO - [mozharness: 2017-04-10 09:32:28.699906Z] Running populate-webroot step. 02:32:28 INFO - Running pre-action listener: _resource_record_pre_action 02:32:28 INFO - Running main action method: populate_webroot 02:32:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:32:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:32:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:32:28 INFO - '--tppagecycles', 02:32:28 INFO - '7'], 02:32:28 INFO - 'tests': ['tsvgm']}}, 02:32:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:32:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:32:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:32:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:32:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:32:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:32:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:32:28 INFO - 'talos_options': ['--disable-e10s'], 02:32:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:32:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:32:28 INFO - 'talos_options': ['--disable-e10s'], 02:32:28 INFO - 'tests': ['damp', 'tps']}, 02:32:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:32:28 INFO - 'tests': ['damp', 'tps']}, 02:32:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:32:28 INFO - 'tests': ['dromaeo_dom']}, 02:32:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:32:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:32:28 INFO - 'tests': ['basic_compositor_video']}, 02:32:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:32:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:32:28 INFO - 'tests': ['a11yr', 02:32:28 INFO - 'ts_paint', 02:32:28 INFO - 'tpaint', 02:32:28 INFO - 'sessionrestore', 02:32:28 INFO - 'sessionrestore_no_auto_restore', 02:32:28 INFO - 'tabpaint']}, 02:32:28 INFO - 'other-e10s': {'tests': ['a11yr', 02:32:28 INFO - 'ts_paint', 02:32:28 INFO - 'tpaint', 02:32:28 INFO - 'sessionrestore', 02:32:28 INFO - 'sessionrestore_no_auto_restore', 02:32:28 INFO - 'tabpaint']}, 02:32:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:32:28 INFO - 'ts_paint', 02:32:28 INFO - 'tpaint', 02:32:28 INFO - 'sessionrestore', 02:32:28 INFO - 'sessionrestore_no_auto_restore', 02:32:28 INFO - 'tabpaint']}, 02:32:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:32:28 INFO - 'ts_paint', 02:32:28 INFO - 'tpaint', 02:32:28 INFO - 'sessionrestore', 02:32:28 INFO - 'sessionrestore_no_auto_restore', 02:32:28 INFO - 'tabpaint']}, 02:32:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:32:28 INFO - 'tests': ['a11yr', 02:32:28 INFO - 'ts_paint', 02:32:28 INFO - 'tpaint', 02:32:28 INFO - 'sessionrestore', 02:32:28 INFO - 'sessionrestore_no_auto_restore', 02:32:28 INFO - 'tabpaint']}, 02:32:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:32:28 INFO - 'tests': ['a11yr', 02:32:28 INFO - 'ts_paint', 02:32:28 INFO - 'tpaint', 02:32:28 INFO - 'sessionrestore', 02:32:28 INFO - 'sessionrestore_no_auto_restore', 02:32:28 INFO - 'tabpaint']}, 02:32:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:32:28 INFO - 'tests': ['tsvgx', 02:32:28 INFO - 'tsvgr_opacity', 02:32:28 INFO - 'tart', 02:32:28 INFO - 'tscrollx', 02:32:28 INFO - 'cart', 02:32:28 INFO - 'tsvg_static']}, 02:32:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:32:28 INFO - 'tsvgr_opacity', 02:32:28 INFO - 'tart', 02:32:28 INFO - 'tscrollx', 02:32:28 INFO - 'cart', 02:32:28 INFO - 'tsvg_static']}, 02:32:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:32:28 INFO - 'talos_options': ['--disable-e10s'], 02:32:28 INFO - 'tests': ['tp5o']}, 02:32:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:32:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:32:28 INFO - 'talos_options': ['--disable-e10s', 02:32:28 INFO - '--xperf_path', 02:32:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:28 INFO - 'tests': ['tp5n']}, 02:32:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:32:28 INFO - 'talos_options': ['--xperf_path', 02:32:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:28 INFO - 'tests': ['tp5n']}}, 02:32:28 INFO - 'talos.zip': {'path': '', 02:32:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:32:28 INFO - Running post-action listener: _resource_record_post_action 02:32:28 INFO - [mozharness: 2017-04-10 09:32:28.718066Z] Finished populate-webroot step (success) 02:32:28 INFO - [mozharness: 2017-04-10 09:32:28.718175Z] Running create-virtualenv step. 02:32:28 INFO - Running pre-action listener: _resource_record_pre_action 02:32:28 INFO - Running main action method: create_virtualenv 02:32:28 INFO - Creating virtualenv /builds/slave/test/build/venv 02:32:28 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 02:32:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:32:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:32:28 INFO - Using real prefix '/tools/python27' 02:32:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:32:29 INFO - Installing distribute.............................................................................................................................................................................................done. 02:32:32 INFO - Installing pip.................done. 02:32:32 INFO - Return code: 0 02:32:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:32:32 INFO - Reading from file tmpfile_stdout 02:32:32 INFO - Output received: 02:32:32 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) 02:32:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:32:32 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')]} 02:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:32 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')]} 02:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102700b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102703768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3c04be370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ded30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024d3be8>, '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.NE4UA7bLw6/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.clbVNB8od4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:32:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:32:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE4UA7bLw6/Render', 02:32:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:33 INFO - 'HOME': '/Users/cltbld', 02:32:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:33 INFO - 'LOGNAME': 'cltbld', 02:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:33 INFO - 'MOZ_NO_REMOTE': '1', 02:32:33 INFO - 'NO_EM_RESTART': '1', 02:32:33 INFO - 'PAGER': '/bin/cat', 02:32:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:33 INFO - 'PWD': '/builds/slave/test', 02:32:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:33 INFO - 'SHELL': '/bin/bash', 02:32:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clbVNB8od4/Listeners', 02:32:33 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:32:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:33 INFO - 'USER': 'cltbld', 02:32:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:33 INFO - 'XPC_FLAGS': '0x0', 02:32:33 INFO - 'XPC_SERVICE_NAME': '0', 02:32:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:33 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 02:32:33 INFO - Cleaning up... 02:32:33 INFO - Return code: 0 02:32:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102700b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102703768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3c04be370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ded30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024d3be8>, '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.NE4UA7bLw6/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.clbVNB8od4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:32:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:32:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE4UA7bLw6/Render', 02:32:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:33 INFO - 'HOME': '/Users/cltbld', 02:32:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:33 INFO - 'LOGNAME': 'cltbld', 02:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:33 INFO - 'MOZ_NO_REMOTE': '1', 02:32:33 INFO - 'NO_EM_RESTART': '1', 02:32:33 INFO - 'PAGER': '/bin/cat', 02:32:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:33 INFO - 'PWD': '/builds/slave/test', 02:32:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:33 INFO - 'SHELL': '/bin/bash', 02:32:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clbVNB8od4/Listeners', 02:32:33 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:32:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:33 INFO - 'USER': 'cltbld', 02:32:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:33 INFO - 'XPC_FLAGS': '0x0', 02:32:33 INFO - 'XPC_SERVICE_NAME': '0', 02:32:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:33 INFO - Downloading/unpacking psutil>=3.1.1 02:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:32:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:39 INFO - Installing collected packages: psutil 02:32:39 INFO - Running setup.py install for psutil 02:32:39 INFO - building 'psutil._psutil_osx' extension 02:32:39 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 02:32:39 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 02:32:39 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 02:32:39 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 02:32:39 INFO - building 'psutil._psutil_posix' extension 02:32:39 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 02:32:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:32:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:32:39 INFO - ^ 02:32:40 INFO - 1 warning generated. 02:32:40 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 02:32:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:40 INFO - Successfully installed psutil 02:32:40 INFO - Cleaning up... 02:32:40 INFO - Return code: 0 02:32:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:32:40 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')]} 02:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:40 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')]} 02:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:40 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 0x102700b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102703768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3c04be370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ded30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024d3be8>, '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.NE4UA7bLw6/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.clbVNB8od4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:32:40 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 02:32:40 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 02:32:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE4UA7bLw6/Render', 02:32:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:40 INFO - 'HOME': '/Users/cltbld', 02:32:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:40 INFO - 'LOGNAME': 'cltbld', 02:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:40 INFO - 'MOZ_NO_REMOTE': '1', 02:32:40 INFO - 'NO_EM_RESTART': '1', 02:32:40 INFO - 'PAGER': '/bin/cat', 02:32:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:40 INFO - 'PWD': '/builds/slave/test', 02:32:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:40 INFO - 'SHELL': '/bin/bash', 02:32:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clbVNB8od4/Listeners', 02:32:40 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:32:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:40 INFO - 'USER': 'cltbld', 02:32:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:40 INFO - 'XPC_FLAGS': '0x0', 02:32:40 INFO - 'XPC_SERVICE_NAME': '0', 02:32:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:32:43 INFO - Installing collected packages: mozsystemmonitor 02:32:43 INFO - Running setup.py install for mozsystemmonitor 02:32:44 INFO - Successfully installed mozsystemmonitor 02:32:44 INFO - Cleaning up... 02:32:44 INFO - Return code: 0 02:32:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:44 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 0x102700b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102703768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3c04be370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ded30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024d3be8>, '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.NE4UA7bLw6/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.clbVNB8od4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:32:44 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 02:32:44 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 02:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE4UA7bLw6/Render', 02:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:44 INFO - 'HOME': '/Users/cltbld', 02:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:44 INFO - 'LOGNAME': 'cltbld', 02:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:44 INFO - 'MOZ_NO_REMOTE': '1', 02:32:44 INFO - 'NO_EM_RESTART': '1', 02:32:44 INFO - 'PAGER': '/bin/cat', 02:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:44 INFO - 'PWD': '/builds/slave/test', 02:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:44 INFO - 'SHELL': '/bin/bash', 02:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clbVNB8od4/Listeners', 02:32:44 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:44 INFO - 'USER': 'cltbld', 02:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:44 INFO - 'XPC_FLAGS': '0x0', 02:32:44 INFO - 'XPC_SERVICE_NAME': '0', 02:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:44 INFO - Downloading/unpacking jsonschema==2.5.1 02:32:44 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 02:32:44 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 02:32:44 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 02:32:44 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 02:32:44 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 02:32:44 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 02:32:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:32:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:32:47 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 02:32:47 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 02:32:47 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 02:32:47 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 02:32:47 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 02:32:47 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 02:32:48 INFO - Downloading functools32-3.2.3-2.tar.gz 02:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:32:48 INFO - warning: no files found matching '*.txt' 02:32:48 INFO - no previously-included directories found matching 'build' 02:32:48 INFO - no previously-included directories found matching 'dist' 02:32:48 INFO - no previously-included directories found matching '.git*' 02:32:48 INFO - Installing collected packages: jsonschema, functools32 02:32:48 INFO - Running setup.py install for functools32 02:32:48 INFO - warning: no files found matching '*.txt' 02:32:48 INFO - no previously-included directories found matching 'build' 02:32:48 INFO - no previously-included directories found matching 'dist' 02:32:48 INFO - no previously-included directories found matching '.git*' 02:32:48 INFO - Successfully installed jsonschema functools32 02:32:48 INFO - Cleaning up... 02:32:48 INFO - Return code: 0 02:32:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:48 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 0x102700b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102703768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3c04be370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ded30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024d3be8>, '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.NE4UA7bLw6/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.clbVNB8od4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:32:48 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 02:32:48 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 02:32:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE4UA7bLw6/Render', 02:32:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:48 INFO - 'HOME': '/Users/cltbld', 02:32:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:48 INFO - 'LOGNAME': 'cltbld', 02:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:48 INFO - 'MOZ_NO_REMOTE': '1', 02:32:48 INFO - 'NO_EM_RESTART': '1', 02:32:48 INFO - 'PAGER': '/bin/cat', 02:32:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:48 INFO - 'PWD': '/builds/slave/test', 02:32:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:48 INFO - 'SHELL': '/bin/bash', 02:32:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clbVNB8od4/Listeners', 02:32:48 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:32:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:48 INFO - 'USER': 'cltbld', 02:32:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:48 INFO - 'XPC_FLAGS': '0x0', 02:32:48 INFO - 'XPC_SERVICE_NAME': '0', 02:32:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:32:48 INFO - Cleaning up... 02:32:48 INFO - Return code: 0 02:32:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:48 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 0x102700b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102703768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3c04be370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ded30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024d3be8>, '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.NE4UA7bLw6/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.clbVNB8od4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:32:48 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 02:32:48 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 02:32:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE4UA7bLw6/Render', 02:32:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:48 INFO - 'HOME': '/Users/cltbld', 02:32:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:48 INFO - 'LOGNAME': 'cltbld', 02:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:48 INFO - 'MOZ_NO_REMOTE': '1', 02:32:48 INFO - 'NO_EM_RESTART': '1', 02:32:48 INFO - 'PAGER': '/bin/cat', 02:32:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:48 INFO - 'PWD': '/builds/slave/test', 02:32:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:48 INFO - 'SHELL': '/bin/bash', 02:32:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clbVNB8od4/Listeners', 02:32:48 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:32:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:48 INFO - 'USER': 'cltbld', 02:32:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:48 INFO - 'XPC_FLAGS': '0x0', 02:32:48 INFO - 'XPC_SERVICE_NAME': '0', 02:32:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:49 INFO - Downloading/unpacking blobuploader==1.2.4 02:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:52 INFO - Downloading blobuploader-1.2.4.tar.gz 02:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:32:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:32:52 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 02:32:52 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 02:32:52 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 02:32:52 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 02:32:52 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 02:32:52 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 02:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:32:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:32:52 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 02:32:52 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 02:32:52 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 02:32:52 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 02:32:52 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 02:32:52 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 02:32:53 INFO - Downloading docopt-0.6.1.tar.gz 02:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:32:53 INFO - Installing collected packages: blobuploader, requests, docopt 02:32:53 INFO - Running setup.py install for blobuploader 02:32:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:32:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:32:53 INFO - Running setup.py install for requests 02:32:54 INFO - Running setup.py install for docopt 02:32:54 INFO - Successfully installed blobuploader requests docopt 02:32:54 INFO - Cleaning up... 02:32:54 INFO - Return code: 0 02:32:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:54 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 0x102700b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102703768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3c04be370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ded30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024d3be8>, '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.NE4UA7bLw6/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.clbVNB8od4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:32:54 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 02:32:54 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 02:32:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE4UA7bLw6/Render', 02:32:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:54 INFO - 'HOME': '/Users/cltbld', 02:32:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:54 INFO - 'LOGNAME': 'cltbld', 02:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:54 INFO - 'MOZ_NO_REMOTE': '1', 02:32:54 INFO - 'NO_EM_RESTART': '1', 02:32:54 INFO - 'PAGER': '/bin/cat', 02:32:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:54 INFO - 'PWD': '/builds/slave/test', 02:32:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:54 INFO - 'SHELL': '/bin/bash', 02:32:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clbVNB8od4/Listeners', 02:32:54 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:32:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:54 INFO - 'USER': 'cltbld', 02:32:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:54 INFO - 'XPC_FLAGS': '0x0', 02:32:54 INFO - 'XPC_SERVICE_NAME': '0', 02:32:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:54 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-NV5yyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:54 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-jZOVqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:54 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-21Epe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:54 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-dxaVWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:54 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-5TSdLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:55 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Bfwl9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:55 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-4C_tc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:55 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-8Z3iL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:55 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-ckIXh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:55 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-pWwCVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:55 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-D6mitp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:55 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-6CDq2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:55 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-iB11hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:55 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-NWibO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:56 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-KDSPnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:56 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-xZBros-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:56 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-aJZRgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:32:56 INFO - Running setup.py install for manifestparser 02:32:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:32:56 INFO - Running setup.py install for mozcrash 02:32:56 INFO - Running setup.py install for mozdebug 02:32:56 INFO - Running setup.py install for mozdevice 02:32:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:32:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:32:56 INFO - Running setup.py install for mozfile 02:32:57 INFO - Running setup.py install for mozhttpd 02:32:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:32:57 INFO - Running setup.py install for mozinfo 02:32:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:32:57 INFO - Running setup.py install for mozInstall 02:32:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:32:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:32:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:32:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:32:57 INFO - Running setup.py install for mozleak 02:32:57 INFO - Running setup.py install for mozlog 02:32:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:32:57 INFO - Running setup.py install for moznetwork 02:32:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:32:57 INFO - Running setup.py install for mozprocess 02:32:58 INFO - Running setup.py install for mozprofile 02:32:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:32:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:32:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:32:58 INFO - Running setup.py install for mozrunner 02:32:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:32:58 INFO - Running setup.py install for mozscreenshot 02:32:58 INFO - Running setup.py install for moztest 02:32:58 INFO - Running setup.py install for mozversion 02:32:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:32:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:32:58 INFO - Cleaning up... 02:32:58 INFO - Return code: 0 02:32:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:58 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 0x102700b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102703768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3c04be370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ded30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024d3be8>, '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.NE4UA7bLw6/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.clbVNB8od4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:32:58 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 02:32:58 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 02:32:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE4UA7bLw6/Render', 02:32:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:58 INFO - 'HOME': '/Users/cltbld', 02:32:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:58 INFO - 'LOGNAME': 'cltbld', 02:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:58 INFO - 'MOZ_NO_REMOTE': '1', 02:32:58 INFO - 'NO_EM_RESTART': '1', 02:32:58 INFO - 'PAGER': '/bin/cat', 02:32:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:58 INFO - 'PWD': '/builds/slave/test', 02:32:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:58 INFO - 'SHELL': '/bin/bash', 02:32:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clbVNB8od4/Listeners', 02:32:58 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:32:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:58 INFO - 'USER': 'cltbld', 02:32:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:58 INFO - 'XPC_FLAGS': '0x0', 02:32:58 INFO - 'XPC_SERVICE_NAME': '0', 02:32:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:59 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-a9XWRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:59 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)) 02:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:59 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-EEPZJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:59 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)) 02:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:59 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-PyZOlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:59 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)) 02:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:59 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-GKmbGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:59 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)) 02:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:59 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-NYD3Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:59 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)) 02:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:59 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-RoegX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:59 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)) 02:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:59 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-64ZdVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:59 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)) 02:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:59 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-5Ga1ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:00 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)) 02:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:00 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-JWeKbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:00 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)) 02:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:00 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-9nKgeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:00 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)) 02:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:00 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-MSmRHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:00 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)) 02:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:00 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-5ggBAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 02:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:00 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-f88iwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:00 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)) 02:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:00 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-maJzsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:00 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)) 02:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:00 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-cw6ekj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:00 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)) 02:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:00 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-LR1SbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:00 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)) 02:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:00 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-1oEqAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:01 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)) 02:33:01 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)) 02:33:01 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)) 02:33:01 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)) 02:33:01 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)) 02:33:01 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)) 02:33:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:04 INFO - Downloading blessings-1.6.tar.gz 02:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:33:04 INFO - Installing collected packages: blessings 02:33:04 INFO - Running setup.py install for blessings 02:33:04 INFO - Successfully installed blessings 02:33:04 INFO - Cleaning up... 02:33:04 INFO - Return code: 0 02:33:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:33:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:04 INFO - Reading from file tmpfile_stdout 02:33:04 INFO - Current package versions: 02:33:04 INFO - blessings == 1.6 02:33:04 INFO - blobuploader == 1.2.4 02:33:04 INFO - docopt == 0.6.1 02:33:04 INFO - functools32 == 3.2.3-2 02:33:04 INFO - jsonschema == 2.5.1 02:33:04 INFO - manifestparser == 1.1 02:33:04 INFO - mozInstall == 1.12 02:33:04 INFO - mozcrash == 1.0 02:33:04 INFO - mozdebug == 0.1 02:33:04 INFO - mozdevice == 0.49 02:33:04 INFO - mozfile == 1.2 02:33:04 INFO - mozhttpd == 0.7 02:33:04 INFO - mozinfo == 0.9 02:33:04 INFO - mozleak == 0.1 02:33:04 INFO - mozlog == 3.4 02:33:04 INFO - moznetwork == 0.27 02:33:04 INFO - mozprocess == 0.25 02:33:04 INFO - mozprofile == 0.28 02:33:04 INFO - mozrunner == 6.13 02:33:04 INFO - mozscreenshot == 0.1 02:33:04 INFO - mozsystemmonitor == 0.3 02:33:04 INFO - moztest == 0.8 02:33:04 INFO - mozversion == 1.4 02:33:04 INFO - psutil == 3.1.1 02:33:04 INFO - requests == 1.2.3 02:33:04 INFO - wsgiref == 0.1.2 02:33:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:04 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')]} 02:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:04 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')]} 02:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:04 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 0x102700b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102703768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3c04be370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ded30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024d3be8>, '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.NE4UA7bLw6/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.clbVNB8od4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:33:04 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 02:33:04 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 02:33:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE4UA7bLw6/Render', 02:33:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:04 INFO - 'HOME': '/Users/cltbld', 02:33:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:04 INFO - 'LOGNAME': 'cltbld', 02:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:04 INFO - 'MOZ_NO_REMOTE': '1', 02:33:04 INFO - 'NO_EM_RESTART': '1', 02:33:04 INFO - 'PAGER': '/bin/cat', 02:33:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:04 INFO - 'PWD': '/builds/slave/test', 02:33:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:04 INFO - 'SHELL': '/bin/bash', 02:33:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clbVNB8od4/Listeners', 02:33:04 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:33:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:04 INFO - 'USER': 'cltbld', 02:33:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:04 INFO - 'XPC_FLAGS': '0x0', 02:33:04 INFO - 'XPC_SERVICE_NAME': '0', 02:33:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:04 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)) 02:33:04 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)) 02:33:04 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)) 02:33:04 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)) 02:33:04 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)) 02:33:04 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)) 02:33:04 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)) 02:33:04 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)) 02:33:04 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)) 02:33:04 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)) 02:33:04 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)) 02:33:04 INFO - Cleaning up... 02:33:04 INFO - Return code: 0 02:33:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:33:04 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')]} 02:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:04 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')]} 02:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:04 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 0x102700b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102703768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3c04be370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ded30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024d3be8>, '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.NE4UA7bLw6/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.clbVNB8od4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:33:04 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 02:33:04 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 02:33:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE4UA7bLw6/Render', 02:33:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:04 INFO - 'HOME': '/Users/cltbld', 02:33:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:04 INFO - 'LOGNAME': 'cltbld', 02:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:04 INFO - 'MOZ_NO_REMOTE': '1', 02:33:04 INFO - 'NO_EM_RESTART': '1', 02:33:04 INFO - 'PAGER': '/bin/cat', 02:33:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:05 INFO - 'PWD': '/builds/slave/test', 02:33:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:05 INFO - 'SHELL': '/bin/bash', 02:33:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clbVNB8od4/Listeners', 02:33:05 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:33:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:05 INFO - 'USER': 'cltbld', 02:33:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:05 INFO - 'XPC_FLAGS': '0x0', 02:33:05 INFO - 'XPC_SERVICE_NAME': '0', 02:33:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:33:05 INFO - Cleaning up... 02:33:05 INFO - Return code: 0 02:33:05 INFO - Running post-action listener: _resource_record_post_action 02:33:05 INFO - Running post-action listener: _start_resource_monitoring 02:33:05 INFO - Starting resource monitoring. 02:33:05 INFO - [mozharness: 2017-04-10 09:33:05.285554Z] Finished create-virtualenv step (success) 02:33:05 INFO - [mozharness: 2017-04-10 09:33:05.286560Z] Running install step. 02:33:05 INFO - Running pre-action listener: _resource_record_pre_action 02:33:05 INFO - Running main action method: install 02:33:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:05 INFO - Reading from file tmpfile_stdout 02:33:05 INFO - Detecting whether we're running mozinstall >=1.0... 02:33:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:33:05 INFO - Reading from file tmpfile_stdout 02:33:05 INFO - Output received: 02:33:05 INFO - Usage: mozinstall [options] installer 02:33:05 INFO - Options: 02:33:05 INFO - -h, --help show this help message and exit 02:33:05 INFO - -d DEST, --destination=DEST 02:33:05 INFO - Directory to install application into. [default: 02:33:05 INFO - "/builds/slave/test"] 02:33:05 INFO - --app=APP Application being installed. [default: firefox] 02:33:05 INFO - mkdir: /builds/slave/test/build/application 02:33:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:33:25 INFO - Reading from file tmpfile_stdout 02:33:25 INFO - Output received: 02:33:25 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:33:25 INFO - Running post-action listener: _resource_record_post_action 02:33:25 INFO - [mozharness: 2017-04-10 09:33:25.790763Z] Finished install step (success) 02:33:25 INFO - [mozharness: 2017-04-10 09:33:25.790888Z] Running run-tests step. 02:33:25 INFO - Running pre-action listener: _resource_record_pre_action 02:33:25 INFO - Running main action method: run_tests 02:33:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:33:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:33:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:33:25 INFO - 2017-04-10 02:33:25.803 screenresolution[1630:7895] starting screenresolution argv=screenresolution get 02:33:25 INFO - 2017-04-10 02:33:25.805 screenresolution[1630:7895] Display 0: 1600x1200x32@60 02:33:25 INFO - 2017-04-10 02:33:25.810 screenresolution[1631:7898] starting screenresolution argv=screenresolution list 02:33:25 INFO - Available Modes on Display 0 02:33:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:33:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:33:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:33:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:33:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:33:26 INFO - Intel Iris: 02:33:26 INFO - Chipset Model: Intel Iris 02:33:26 INFO - Type: GPU 02:33:26 INFO - Bus: Built-In 02:33:26 INFO - VRAM (Dynamic, Max): 1536 MB 02:33:26 INFO - Vendor: Intel (0x8086) 02:33:26 INFO - Device ID: 0x0a2e 02:33:26 INFO - Revision ID: 0x0009 02:33:26 INFO - Displays: 02:33:26 INFO - Display: 02:33:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:33:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:33:26 INFO - Display Serial Number: 1600x1200 60 02:33:26 INFO - Main Display: Yes 02:33:26 INFO - Mirror: Off 02:33:26 INFO - Online: Yes 02:33:26 INFO - Rotation: Supported 02:33:26 INFO - Return code: 0 02:33:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:33:26 INFO - Python 2.7.3 02:33:26 INFO - Return code: 0 02:33:26 INFO - grabbing minidump binary from tooltool 02:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:26 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 0x1024ded30>, '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 0x102405db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024d3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:33:26 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 02:33:26 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 02:33:26 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 02:33:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:33:26 INFO - Return code: 0 02:33:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:33:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:33:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:33:26 INFO - ENV: RUST_BACKTRACE is now 1 02:33:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:33:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:33:26 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/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0241', '--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 02:33:26 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/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0241 --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 02:33:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NE4UA7bLw6/Render', 02:33:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:26 INFO - 'HOME': '/Users/cltbld', 02:33:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:26 INFO - 'LOGNAME': 'cltbld', 02:33:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:33:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:26 INFO - 'MOZ_NO_REMOTE': '1', 02:33:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:33:26 INFO - 'NO_EM_RESTART': '1', 02:33:26 INFO - 'PAGER': '/bin/cat', 02:33:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:26 INFO - 'PWD': '/builds/slave/test', 02:33:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:33:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:26 INFO - 'RUST_BACKTRACE': '1', 02:33:26 INFO - 'SHELL': '/bin/bash', 02:33:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clbVNB8od4/Listeners', 02:33:26 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:33:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:26 INFO - 'USER': 'cltbld', 02:33:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:26 INFO - 'XPC_FLAGS': '0x0', 02:33:26 INFO - 'XPC_SERVICE_NAME': '0', 02:33:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:26 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/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0241', '--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 02:33:26 INFO - mozversion application_buildid: 20170410004019 02:33:26 INFO - mozversion application_changeset: efca7a198376e7800873e4612a8b34fc77022d4d 02:33:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:33:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:33:26 INFO - mozversion application_name: Firefox 02:33:26 INFO - mozversion application_remotingname: firefox-dev 02:33:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:33:26 INFO - mozversion application_vendor: Mozilla 02:33:26 INFO - mozversion application_version: 54.0a2 02:33:26 INFO - mozversion platform_buildid: 20170410004019 02:33:26 INFO - mozversion platform_changeset: efca7a198376e7800873e4612a8b34fc77022d4d 02:33:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:33:26 INFO - mozversion platform_version: 54.0a2 02:33:26 INFO - using testdate: 1491816806 02:33:26 INFO - actual date: 1491816806 02:33:26 INFO - starting webserver on 'localhost:49247' 02:33:26 INFO - SUITE-START | Running 2 tests 02:33:26 INFO - TEST-START | dromaeo_css 02:33:26 INFO - operating with platform_type : mac_ 02:33:26 INFO - Initialising browser for dromaeo_css test... 02:33:26 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpuXrhMP/profile http://localhost:49247/getInfo.html) 02:33:29 INFO - PROCESS | 1641 | 2017-04-10 02:33:29.294 plugin-container[1644:8087] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c43, name = 'com.apple.tsm.portname' 02:33:29 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:33:29 INFO - PROCESS | 1641 | 2017-04-10 02:33:29.295 plugin-container[1644:8087] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 02:33:29 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:33:29 INFO - PROCESS | 1641 | 2017-04-10 02:33:29.295 plugin-container[1644:8087] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:33:29 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 02:33:29 INFO - PROCESS | 1641 | colorDepth:24 02:33:29 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 02:33:29 INFO - PROCESS | 1641 | __metrics 02:33:29 ERROR - PROCESS | 1641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 02:33:30 INFO - TEST-INFO | 1641: exit 0 02:33:30 INFO - Browser initialized. 02:33:30 INFO - Running cycle 1/1 for dromaeo_css test... 02:33:30 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpuXrhMP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:32 INFO - PROCESS | 1646 | 2017-04-10 02:33:32.640 plugin-container[1647:8223] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873b, name = 'com.apple.tsm.portname' 02:33:32 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:33:32 INFO - PROCESS | 1646 | 2017-04-10 02:33:32.640 plugin-container[1647:8223] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x451f, name = 'com.apple.CFPasteboardClient' 02:33:32 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:33:32 INFO - PROCESS | 1646 | 2017-04-10 02:33:32.640 plugin-container[1647:8223] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:33:42 INFO - PROCESS | 1646 | RSS: Main: 220893184 02:33:42 INFO - PROCESS | 1646 | 02:36:45 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 02:36:47 INFO - PROCESS | 1646 | RSS: Main: 241999872 02:36:47 INFO - PROCESS | 1646 | 02:38:30 INFO - PROCESS | 1646 | ************************* 02:38:30 INFO - PROCESS | 1646 | A coding exception was thrown and uncaught in a Task. 02:38:30 INFO - PROCESS | 1646 | 02:38:30 ERROR - PROCESS | 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:38:30 INFO - PROCESS | 1646 | Full stack: 02:38:30 INFO - PROCESS | 1646 | ************************* 02:38:30 INFO - PROCESS | 1646 | ************************* 02:38:30 INFO - PROCESS | 1646 | A coding exception was thrown and uncaught in a Task. 02:38:30 INFO - PROCESS | 1646 | 02:38:30 ERROR - PROCESS | 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:38:30 INFO - PROCESS | 1646 | Full stack: 02:38:30 INFO - PROCESS | 1646 | ************************* 02:38:30 INFO - PROCESS | 1646 | ************************* 02:38:30 INFO - PROCESS | 1646 | A coding exception was thrown and uncaught in a Task. 02:38:30 INFO - PROCESS | 1646 | 02:38:30 ERROR - PROCESS | 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:38:30 INFO - PROCESS | 1646 | Full stack: 02:38:30 INFO - PROCESS | 1646 | ************************* 02:38:30 INFO - PROCESS | 1646 | ************************* 02:38:30 INFO - PROCESS | 1646 | A coding exception was thrown and uncaught in a Task. 02:38:30 INFO - PROCESS | 1646 | 02:38:30 ERROR - PROCESS | 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:38:30 INFO - PROCESS | 1646 | Full stack: 02:38:30 INFO - PROCESS | 1646 | ************************* 02:39:49 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 02:39:50 INFO - PROCESS | 1646 | RSS: Main: 248823808 02:39:50 INFO - PROCESS | 1646 | 02:42:52 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 02:42:52 INFO - PROCESS | 1646 | RSS: Main: 255848448 02:42:52 INFO - PROCESS | 1646 | 02:45:54 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 02:45:55 INFO - PROCESS | 1646 | RSS: Main: 253931520 02:45:55 INFO - PROCESS | 1646 | 02:48:58 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 02:48:59 INFO - PROCESS | 1646 | RSS: Main: 258985984 02:48:59 INFO - PROCESS | 1646 | 02:52:01 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 02:52:02 INFO - PROCESS | 1646 | RSS: Main: 255295488 02:52:02 INFO - PROCESS | 1646 | 02:52:02 INFO - PROCESS | 1646 | __start_tp_report 02:52:02 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 02:52:02 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 02:52:02 INFO - PROCESS | 1646 | |i|pagename|runs| 02:52:02 INFO - PROCESS | 1646 | |0;dojo.html;3433.502142189381;3472.496488009238;3478.9652103478957;3483.1292176955762;3496.702780263681;4908.165611845986;5960.076188190832;6040.818775436733;6108.847278818021;6112.1137435072;5994.250718660168;6023.126646636246;6099;6105.236845394325;6113.358097399776;4725.692829966041;5369.845483221106;5417.86224892772;5504.972475137619;5535.806246781363;5532.861678458031;5553;5554.91667624986;5559.499645031946;5559.805406810762;5324.680519168843;5381.81163659272;5536.252605898192;5551.139573366135;5600.6079574429605;5504;5510.283663123809;5516.3797196331425;5533.6956467394275;5566.55467562594;5364.839054828361;5481.5340696040885;5492.395836458027;5506.972465137689;5538.169274608801;4681.88295292617;6116.960116780158;6125.264968203799;6204.7828326008375;6230.096635987802;6262.029385445263;6292.307846136921;6302.369763023707;6336.20797400325;6347.206599175103;6534.771283005072;6536;6549.574277671936;6601.504887133437;6690.531662783607;6177.84555386119;6204.193454850885;6241.469475094668;6241.687915604201;6276.717547710364;5666.688332141689;6367.713452894538;6394.712237949303;6499.415052645285;6616.206055273302;6281.3404592518045;6302.275238347557;6308.148399966038;6331.176946996861;6340.778072767431;6474.352564743488;6510.153680021567;6511.38141876521;6528.412442880163;6535.150430444012;5154.304168937146;6405.775797847146;6415.839604009844;6430.0676401921455;6468.579542329733;5581.10702287632;6232.626042437469;6271.749130034747;6271.749130034838;6313.589616674902;5209.895802083937;5256.1327380982475;5259.132243179909;5264.92102618461;5279.102552566073;4029.858954936622;4528.569785870337;4594.88512787183;4613.123506533815;4627.814887404466;5924.5852790305125;5970.253718285215;6117.979653188475;6177.96911015451;6216.658083805434;6453.580517266362;6468.062130991074;6524.575902566318;6529.183852018497;6537.1501704778075;5994.520438364921;6050.818475445743;6126.609281623611;6164.321924588292;6178;5666.886662266814;5766.192733017381;5768;5805.158252053428;5807.970960145257;6390.840228994312;6474.417302442803;6640.634765087773;6751.729930802713;6765.52641315113;6420.422162005442;6483.059956306403;6504.739810407531;6530.47756179514;6556.737730490727;6732.697028633821;6734.057231987427;6736.292689267556;6739.460843132636;6762.560433571802;6158.445739883432;6291.213598300213;6394.008928616072;6414.807555773335;6437.967810161106;6333.240011198685;6375.681215939092;6402.231732192166;6402.6158430494315;6418.711157997995;6231.688415579112;6299.590526615939;6306.590071645328;6313.589616674902;6333.113364128933;6220;6292.18201633803;6322.209723784527;6328.936710632835;6329.841753956188;6117.248930028971;6166.321704612579;6222.315545289924;6285.402886725937;6286.277078136073;6310.021946598285;6311.053341998737;6322.905156422566;6328.588641738273;6331.873362532816;6233.625982441068;6270.7491700331475;6282.403171698864;6299.842503937438;6308.337624549356 02:52:02 INFO - PROCESS | 1646 | |1;ext.html;626.949844012479;749.6926260233305;821.3265122599468;937.6062053937345;942.0861764088831;38254.04364890879;38794.612053879486;40280.79859600705;40468.392974105336;40484.59515404845;39042.8047859761;39169.21661566767;39210;39343;39453;7861.960690196555;8290.41967062306;10138.898611013907;10486.213533984943;10725.30285531438;9228.492432916188;10599.523021464014;10665.733356666067;10678.946605266963;10696.839547406795;8235.958820205891;10706.1435085193;10716.892831071706;10745.731356716067;11117.22179447439;10611.946940265327;10691.305065170778;10717.946410267978;10729.409882456463;10744.086752626035;10412.895871041268;10475.685729428129;10475.79048419035;10493;10498.895011049868;33409;33572.83213583941;33589.83205083983;33650.1587460313;33659.6634033659;3686.594474607791;3766.6233376662112;3767.547894252707;3794.392897136445;3803.847846086181;24444;24547;25042.373940651447;25927.74072259272;25975.480490390277;3060.5409188621884;3092.752579793611;3185.4266232078216;3262.9184270393193;3291.753118516121;289143;290065;291736;292250;293582;42749;42792.14415711668;42853.35719964141;42925.926851828954;43013.13973720508;41204.587954120674;44095;44095.77952110283;44127.33808992868;44157.55842441598;12055.879441205476;12717.682057948625;12767.61697149087;12801.743965120646;12870.742585148244;10882.075023622923;10887.510062047228;10909.563617455371;10926;10927.562897484011;11288.379139147262;11788.94105529484;11801.586944456903;11812.173147879737;11902.226355287052;5623.943760562423;5700.344460387026;5706.28671416073;5708.229389032511;5740.6268592541355;893.2942975049638;1093.2128867215752;1109.3676604335612;1121.8445001648315;1188.483009890683;26886.462270754477;26922.865385672947;26967.865160674464;26999.595006074924;27326;1031.5718976624617;1190.8690044095142;1215.5380955236953;1271.3325504110417;1279.437047699028;11984.34086125254;13540;13974.301284935917;14048.648783780487;14277;462612;465406;468746;469398;469870;47011.059778804236;56525.43474565284;56918;57051;57106.7144664274;1361.884239839605;1385.1827421821174;1401;1401.0472878442554;1410.3089486151712;26094.86952565225;26267.60598591061;26291.868540657175;26886.731132688423;27031.1890643281;39799.20401591894;39960.00099997524;39961.40057899075;40178.59821401749;40257.1948561033;465349;476107;476683;476980;478102.6094869503;27491.074003719834;28341.71658283473;28398.716012839606;28578.999735009176;28724.851005960365;29202.26994325074;36191.91424257276;36908.446373304956;37133;37218.62781372152;26170.476590468465;26584.601230981938;27112.72887271102;27271.454570908867;27645.86177069102;23993.52012959766;26079.869600651877;26574.069907553916;26839.463210735285;27103.322416939733;29752.95864644727;29825.5526167112;30253.69746302597;30617.54073688941;30704.38591228118;24435.877820611495;25092;25356.746432536176;25530.872345638152;27158;21498.251973339055;21604.67592986138;22244.888775556017;22365;22413.551728965656 02:52:02 INFO - PROCESS | 1646 | |2;jquery.html;407.26895223074575;412.36495796473434;413.3386581469649;426.2519278665942;452.028139500075;19196.136173872175;20015.499612509695;21543.13827446904;21575.24486642968;21665.133394664215;20966.37100886976;21826.781732182673;22025;22390.776092239073;22438.439039024033;6287.245530536342;6612.867742645144;6642;6648.966755166218;6658.034584985175;6230.937690623104;6383;6453.774117905874;6502.479801615883;6507.674616269192;6399.744010239585;6443.548951573392;6467.417932386084;6490.286068532458;6494.31809659986;6249.312575616678;6486.708098135595;6491.350864913518;6491.870162596769;6504.284528701839;6138.956377415805;6259.812205633838;6342.5243106767175;6356.809295721136;6365.713542890535;25833.483330333474;26029.349266268306;26142;26391.736082639312;26526;2858.7141285871453;2947.8378689172087;3049.2986613079115;3106.130283520595;3163.9558945547915;15661.295241714037;16381.42665006731;16511.83488165115;16905;17023.65952680952;2023.1401654297013;2042.234162189179;2049.405672355015;2056.0953180600486;2056.2186369179767;148082;156847;178080;180900.19099808965;181763;17395.73906391405;17680.646387072185;19516.70724939127;20861.478463038544;21066.999999999694;32017;32634;32902.177445564055;33173.17067073342;33215.169620759676;7617.428692847948;9299.53502324881;9569.521523923777;9718.97950715179;9729.513524323755;7649.885251721229;7669.041369828771;7694.384449244047;7825.530468171814;7844.646990885424;8227.095019547845;9570.090841370058;9599.664011759554;9744.610215591298;9768.411370986694;4001.779902105354;4190.368125332826;4277.593628605277;4311.8490852820005;4328.5022222444195;817.1950628630794;898.2140626951417;917.1434119527371;924.2144177449114;939.9718008459757;20767.273145439838;21227.68158477624;21265.57468850645;21351.572968540542;21463.67804482934;817.3134566963779;856.3063918226256;886.9689560865339;932.105179028127;943.8159558885951;10549.683509494727;10965.61620343284;10976.670699879016;11045;11222.158338124673;611465;615660;735832;737041;740695;147832;152830;156574;156777.2161139187;159221;1322.127395918689;1339.6985678222322;1370.766969615168;1374.1960952842699;1383.1355402873405;19261.325853595055;20293.188272468935;20393.388198354074;20396.184152633727;20453.38639840807;66523;66578.33686652673;66649.33350666432;67416.65166696541;68347.65826170838;85936.71094933456;88293;92657;93317.5334123325;93704;8119.512829230265;11140.610078647209;11489.942550287195;11619.76760464769;11896;12249.877501224873;12656.6835829105;13193.34033298312;13229.735405291647;13606.183628982293;11113.15236766446;11166.553337866719;11281.71795705114;11301.039411649774;11559.595414160463;8786.912130878609;10555.366677999345;10596.576136954436;10611.840822387825;10916.235863489479;11399.658010259374;11678.824817627912;11752.471138798604;11854.110941679237;11917.34454605005;11739.647810565697;11755.941220293844;11779.941100294443;11814.645560633195;12120.515179392725;6098.75604975796;8536.957315213383;11167.162462815484;11493.310401375944;11698.06415486776 02:52:02 INFO - PROCESS | 1646 | |3;mootools.html;1441;1458.5624312706188;1526.8702160316373;1561.1881821452837;1571.167281340889;9763.804723905518;10638.414887181201;11266.605668801594;11280.661580152599;11355.261907975975;11169.944150279238;11363.943180284108;11388.886111138887;11389.259698119617;11402.543898244081;2359.784710873897;2373.9169129080487;2376.3346263046374;2391.4260577461373;2392.055138220402;2298.7816157465013;2368.27767530903;2380.452495925938;2398.2205783120557;2399.6280576510667;2009.6181725472186;2267.535155293161;2352.8588284702973;2375.121205154087;2383.916562920298;2344.601417758985;2354.376090336062;2354.976450235493;2361.055577768889;2384.463495713451;1974.9605007899904;1978.9901050494655;2359.823013273994;2370.7155141382973;2372.7389987101405;11096.00135987765;11200.663980080612;11229.943850280779;11244.775104497865;11266.718332041683;5100.362454693163;5648.378678345379;5654.802081927113;5810.970945145289;5870.677112758796;3282.606087269519;3299.637039925606;3418.487411752385;3556.0931962349696;3624.800635965021;1139.9658010259704;1144.553624086607;1189.5122999570222;1239.4608345369793;1242.1118899986463;13009;13391.86608133916;13656.317184140753;14797.446268141905;15273;4526.569975852289;4617.3074038893765;4618.769061546909;4633.2818413146015;4643.117807616542;11880.762384752257;11885.40572971348;11950.641480755592;11993.700157495958;12039.39803009846;5603.719814009283;5613.831585052455;5620.57845661577;5622.662640241599;5649.802256920988;5038.042771873333;5227.790888364499;5285.841424757264;5290.576753859682;5295.470452954673;3252.3820474110316;3866.304065268279;3889.747166434173;3891.2606604745574;3960.0693836948294;1032.59051394847;1033.9379637221791;1044.7567394800164;1047.696168111239;1048.2295512798087;925.3753716241645;926.9582868770922;935.9672411465566;940.1726480696943;983.9901600984042;6012.947734146507;6343.619382837044;6430.164078669743;6559.508036897252;6625.3043430440075;950.2065775077749;981.8232718110665;984.9704508864745;988.5057471264367;1016.9389836609827;4037.4347591337237;4138.91722165561;4154.231467178582;4194.266003449445;4215.620594146541;13428.19430834153;14005;14024.859751402355;14036;14071;13447.26040067786;13633.522826701017;13872.959528035437;13963.930180349033;13963.930180349236;10105.090541851268;10194.694159175237;10213.285070045025;10253.487325633689;10274.537645806106;6363.6818159090935;6403.103565500926;6506.02409638539;6517.9348206517325;6535.954247320597;11926.522939082339;12240.143189976616;12349.506019759108;12435.564755233523;12454.875451245372;11281.548738050386;11348.602798901999;12221.266723996589;12788.48846046185;12792.232466052066;8962.14859588338;9329.533523323942;9363.4381937084;9382.437053776795;9389.248860091313;10223.59105635796;10251.948740256252;10273.075423211947;10341.844872327072;10362.222833287684;8775.648974040967;8821.558922054;8837.955810220908;8849.247813935888;8866.069062748318;8468.280196183146;8550.486970781772;8606.311495080254;8639.784005399915;8728.91271087281;7605.733799316998;7668.69325227007;7788;7887.44787864844;7895.289423951872;5695.572832037531;5851.1515830205235;5948.37542058095;6002.759889604542;6058.182145410313;5813.3895940925595;5885.911711324419;6061.605995610271;6072.757089716361;6151.753929842936 02:52:02 INFO - PROCESS | 1646 | |4;prototype.html;370.2003672068331;375.7107027588756;377.1683438019168;390.9804509774511;399.5664703796381;4608.654350923677;4944.579710724593;5143.711048583377;5231.816886408977;5344.625876188668;4227.85202517912;5036.772231847302;5212.322398088253;5228.738563071841;5229.790808367661;3853.8265778039986;4117.56765539617;4133.1940271647045;4156.5635608261155;4226.323788193889;3766.322062028834;3983.24318379507;4099.795010249491;4178.268802959486;4203.222403855281;3794.924101517968;4170.082581831992;4174.603412675791;4179.686523510733;4196.286631272676;3774.471573979645;4016.6385025347713;4075.816588253536;4080.18396320737;4081.3673880548563;3276.3611095836322;3299.686529779667;3637.872674456408;3653.6529029742132;3663.6885864701267;4021.678265738734;4138.937915931233;4955.727434991074;5169.508896654812;5180.332128953592;3938.586448422903;4148.423599032379;4617.376654151713;4654.906097067186;4723.267893476516;5187.250757098744;5230.372355317349;5290.206469029637;5293.258943747878;5425.283680678747;3301.7053148062105;3908.5700572936953;4086.2031903778775;4126.339785634284;4134.73124246923;5142.51146141116;5326.360836699582;5461.238393494861;5959.791407300723;6023.66869822164;4193.958060419418;4213.810378532973;4363.36731173978;4666.580007799314;4700.929486057712;4186.623203911662;4321.947075139284;4797.328374027639;4806.8849706129195;4833.202521583899;4485.529019452975;4585.151746926763;5080.517350851663;5096.21008743638;5121.07820592297;5342.465753424704;5631.352394474606;5635.408282130317;5640.746166422521;5715.428457154251;1546.26552387615;1571.462088726698;1594.5136733296456;1596.1859451679495;1608.1155364549452;1060.1995493402433;1103.9172062095374;1135.0692432205676;1209.6492017314881;1215.53202017224;4398.978005109954;4741.2888066789565;4757.500462451462;4865.489123642037;5383.8384848453825;5077.796888124508;5477.315335583052;5808.780156167168;5880.529557635379;5906.350301466835;4396.582324679151;4474.621660646257;4532.682712210114;4818.156822556039;5210.534994228796;2643.0088716731225;2763.5440152375036;2961.304093538017;3079.321769635554;3095.628524577065;5611.5230205433;5686.346070201897;5724.398938111522;5960.00339886143;6246.969250073687;5224.7126408047925;5310.309659744208;5664.433556644302;6027.468463245447;6031.758729650853;5705.971470142706;5780.71096445176;5893.465809701784;5916.822495325147;6105.5420843437805;4841.685290456109;5126.923096153486;5588.77644894216;5852.619579727304;5921.703914804157;4539.954600453953;4646.468683800268;5342.423984924379;5601.691906945157;5614.354349249726;5094.2867998479505;5384.165454354581;5480.616356855141;5513.9448605513435;5862.530997520274;4086.1010577672864;4308.612224899774;4492.932606010978;4550.567696068868;4579.656525760514;4285.46431696038;4796.184648609815;5027.673201241908;5221.765020574007;5233.450487698889;5645.725479222124;5649.954758369715;5679.211048519703;5694.402087780723;5718.542516598579;4690.366800482027;5272.734543709405;5689.31728192603;5736.569757268138;5740.483356497935;4459.063596644612;4996.00159936014;5367.329083864517;5586.916196256978;5633.380328163817;5159.638825282194;5169.560587350117;5560.972195138998;5664.518515926193;5763.8559036024435;4988.226824842155;4988.226824842155;5371.818199995994;5510.311211098613;5640.71796410186 02:52:02 INFO - PROCESS | 1646 | |5;yui.html;714.6319645382632;735.4116706634691;756.71623141322;819.5205804604307;833.8082241084551;15285.159316237603;16095.436659716912;16237.594060148502;16249.675006499863;16259.187040647965;14314.568543145706;15296.617584560392;15301.770473442879;15352;15362.155081470515;931.5621657820831;965.7054598347502;969.2100937735757;971.053223107468;971.6016433262329;934.3086116273977;966.2511553546022;975.2880397309968;975.9560819763128;977.799551092028;1017.2878984710695;1023.0076825479273;1023.3092662452851;1024.1499555369064;1025.097913835827;1011.4285428732743;1013.7769690668041;1019.3781793106199;1020.6427750287414;1021.5658345203296;753.15270320889;760.6424980259269;761.5240474703311;761.8476304739074;762.8474305138939;15560.844391556053;15686.607834804106;15896.125713085776;16231.782616303706;16292.918535407247;12019.93990030053;13984.650383740387;14101.576952691436;14142.9585540326;14425.78361324581;11837.940810295979;11895.107866910017;11898.643040708706;11970.281783093042;11987.930545958856;3317.3365326934468;3694.242680250542;3710.684591809699;3730.9253814923823;3850.172212974224;102988;105199.47400263026;107420;107908.92091079068;108806.91193088047;10461;10872.510737016853;10878.075363594025;10920.344779313267;11027.503762330554;20009.499762505762;21581.02885370162;22494.32517024492;22726;22762.20332288362;7467.887981680279;7705.306522412898;7740.7677769667;7743.45795794289;7770.300672939463;3736.1593641431004;4254.553271906467;4332.35014747784;4350.108227813291;4353.1293741251875;3005.5792189093545;3091.31990961988;3544.4151714966742;3636.61815509373;3695.168587067942;697.9441644668415;700.2822107339915;706.5513398991575;706.6678661029308;715.2454160860239;617.3671986214076;664.3000769555415;701.4563713122269;701.8771714949863;722.955329548797;10274.691759247235;10466.424346660855;10475.42385168823;10934.289271197347;11024.944875275572;567.3277166557642;575.2521721761693;594.5006194796392;642.8521440068811;703.9577625342496;4606.262997920384;5060.240963855451;5097.796088156507;5098.490150984871;5098.847034588968;86889;92180;96880;100595;103226.96773032323;58031.8393632125;70085.94871076939;70821.64589177021;76596;86062;68578.65710671415;70227.29772702309;70915.58168836594;72260.63869680723;72583;10834.349939003685;11144.665660030212;11213.719657008314;11370.772584548096;11378.772424551627;39252.607473924894;48958.26562601635;49374.50625493843;50725.74637126791;51613;63144.36855631385;65070.37324066936;65673;66989;67555.66222168857;12406.875931240573;12496.625101246977;12514.249145051326;13276.53532126371;13302.467901284228;14360.425582976564;14555;14750.114993100447;14814.925925370304;14880.776788347966;13349.25743069037;13457.596272111852;13925.164490130219;14206.786898196742;14248.501302454364;13189;13197.868021319664;13792.310384480536;13875.236861972284;14291.428342866584;13195.20828750278;13372.799408009083;13388.665283367995;13401.396937137657;13451.529196478075;9231.953840230755;9261;9451.574679139592;9452.858207127036;9691.123550579543;9968.601255949681;10429.478526073513;11059.50232239535;11381.260218085798;11460.796616355496 02:52:02 INFO - PROCESS | 1646 | __end_tp_report 02:52:02 INFO - PROCESS | 1646 | __start_cc_report 02:52:02 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,412 02:52:02 INFO - PROCESS | 1646 | __end_cc_report 02:52:02 INFO - PROCESS | 1646 | __startTimestamp1491817922023__endTimestamp 02:52:02 INFO - PROCESS | 1646 | 02:52:02 INFO - PROCESS | 1646 | ------- Summary: start ------- 02:52:02 INFO - PROCESS | 1646 | Number of tests: 6 02:52:02 INFO - PROCESS | 1646 | 02:52:02 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5979.03 Median:6233.63 stddev:679.36 (10.9%) stddev-sans-first:651.43 02:52:02 INFO - PROCESS | 1646 | Values: 3433.5 3472.5 3479.0 3483.1 3496.7 4908.2 5960.1 6040.8 6108.8 6112.1 5994.3 6023.1 6099.0 6105.2 6113.4 4725.7 5369.8 5417.9 5505.0 5535.8 5532.9 5553.0 5554.9 5559.5 5559.8 5324.7 5381.8 5536.3 5551.1 5600.6 5504.0 5510.3 5516.4 5533.7 5566.6 5364.8 5481.5 5492.4 5507.0 5538.2 4681.9 6117.0 6125.3 6204.8 6230.1 6262.0 6292.3 6302.4 6336.2 6347.2 6534.8 6536.0 6549.6 6601.5 6690.5 6177.8 6204.2 6241.5 6241.7 6276.7 5666.7 6367.7 6394.7 6499.4 6616.2 6281.3 6302.3 6308.1 6331.2 6340.8 6474.4 6510.2 6511.4 6528.4 6535.2 5154.3 6405.8 6415.8 6430.1 6468.6 5581.1 6232.6 6271.7 6271.7 6313.6 5209.9 5256.1 5259.1 5264.9 5279.1 4029.9 4528.6 4594.9 4613.1 4627.8 5924.6 5970.3 6118.0 6178.0 6216.7 6453.6 6468.1 6524.6 6529.2 6537.2 5994.5 6050.8 6126.6 6164.3 6178.0 5666.9 5766.2 5768.0 5805.2 5808.0 6390.8 6474.4 6640.6 6751.7 6765.5 6420.4 6483.1 6504.7 6530.5 6556.7 6732.7 6734.1 6736.3 6739.5 6762.6 6158.4 6291.2 6394.0 6414.8 6438.0 6333.2 6375.7 6402.2 6402.6 6418.7 6231.7 6299.6 6306.6 6313.6 6333.1 6220.0 6292.2 6322.2 6328.9 6329.8 6117.2 6166.3 6222.3 6285.4 6286.3 6310.0 6311.1 6322.9 6328.6 6331.9 6233.6 6270.7 6282.4 6299.8 6308.3 02:52:02 INFO - PROCESS | 1646 | 02:52:02 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:53265.32 Median:27993.79 stddev:111833.74 (399.5%) stddev-sans-first:112077.63 02:52:02 INFO - PROCESS | 1646 | Values: 626.9 749.7 821.3 937.6 942.1 38254.0 38794.6 40280.8 40468.4 40484.6 39042.8 39169.2 39210.0 39343.0 39453.0 7862.0 8290.4 10138.9 10486.2 10725.3 9228.5 10599.5 10665.7 10678.9 10696.8 8236.0 10706.1 10716.9 10745.7 11117.2 10611.9 10691.3 10717.9 10729.4 10744.1 10412.9 10475.7 10475.8 10493.0 10498.9 33409.0 33572.8 33589.8 33650.2 33659.7 3686.6 3766.6 3767.5 3794.4 3803.8 24444.0 24547.0 25042.4 25927.7 25975.5 3060.5 3092.8 3185.4 3262.9 3291.8 289143.0 290065.0 291736.0 292250.0 293582.0 42749.0 42792.1 42853.4 42925.9 43013.1 41204.6 44095.0 44095.8 44127.3 44157.6 12055.9 12717.7 12767.6 12801.7 12870.7 10882.1 10887.5 10909.6 10926.0 10927.6 11288.4 11788.9 11801.6 11812.2 11902.2 5623.9 5700.3 5706.3 5708.2 5740.6 893.3 1093.2 1109.4 1121.8 1188.5 26886.5 26922.9 26967.9 26999.6 27326.0 1031.6 1190.9 1215.5 1271.3 1279.4 11984.3 13540.0 13974.3 14048.6 14277.0 462612.0 465406.0 468746.0 469398.0 469870.0 47011.1 56525.4 56918.0 57051.0 57106.7 1361.9 1385.2 1401.0 1401.0 1410.3 26094.9 26267.6 26291.9 26886.7 27031.2 39799.2 39960.0 39961.4 40178.6 40257.2 465349.0 476107.0 476683.0 476980.0 478102.6 27491.1 28341.7 28398.7 28579.0 28724.9 29202.3 36191.9 36908.4 37133.0 37218.6 26170.5 26584.6 27112.7 27271.5 27645.9 23993.5 26079.9 26574.1 26839.5 27103.3 29753.0 29825.6 30253.7 30617.5 30704.4 24435.9 25092.0 25356.7 25530.9 27158.0 21498.3 21604.7 22244.9 22365.0 22413.6 02:52:02 INFO - PROCESS | 1646 | 02:52:02 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:41937.78 Median:14692.36 stddev:116404.88 (792.3%) stddev-sans-first:116689.66 02:52:02 INFO - PROCESS | 1646 | Values: 407.3 412.4 413.3 426.3 452.0 19196.1 20015.5 21543.1 21575.2 21665.1 20966.4 21826.8 22025.0 22390.8 22438.4 6287.2 6612.9 6642.0 6649.0 6658.0 6230.9 6383.0 6453.8 6502.5 6507.7 6399.7 6443.5 6467.4 6490.3 6494.3 6249.3 6486.7 6491.4 6491.9 6504.3 6139.0 6259.8 6342.5 6356.8 6365.7 25833.5 26029.3 26142.0 26391.7 26526.0 2858.7 2947.8 3049.3 3106.1 3164.0 15661.3 16381.4 16511.8 16905.0 17023.7 2023.1 2042.2 2049.4 2056.1 2056.2 148082.0 156847.0 178080.0 180900.2 181763.0 17395.7 17680.6 19516.7 20861.5 21067.0 32017.0 32634.0 32902.2 33173.2 33215.2 7617.4 9299.5 9569.5 9719.0 9729.5 7649.9 7669.0 7694.4 7825.5 7844.6 8227.1 9570.1 9599.7 9744.6 9768.4 4001.8 4190.4 4277.6 4311.8 4328.5 817.2 898.2 917.1 924.2 940.0 20767.3 21227.7 21265.6 21351.6 21463.7 817.3 856.3 887.0 932.1 943.8 10549.7 10965.6 10976.7 11045.0 11222.2 611465.0 615660.0 735832.0 737041.0 740695.0 147832.0 152830.0 156574.0 156777.2 159221.0 1322.1 1339.7 1370.8 1374.2 1383.1 19261.3 20293.2 20393.4 20396.2 20453.4 66523.0 66578.3 66649.3 67416.7 68347.7 85936.7 88293.0 92657.0 93317.5 93704.0 8119.5 11140.6 11489.9 11619.8 11896.0 12249.9 12656.7 13193.3 13229.7 13606.2 11113.2 11166.6 11281.7 11301.0 11559.6 8786.9 10555.4 10596.6 10611.8 10916.2 11399.7 11678.8 11752.5 11854.1 11917.3 11739.6 11755.9 11779.9 11814.6 12120.5 6098.8 8537.0 11167.2 11493.3 11698.1 02:52:02 INFO - PROCESS | 1646 | 02:52:02 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:6691.48 Median:2387.94 stddev:4204.56 (176.1%) stddev-sans-first:4197.85 02:52:02 INFO - PROCESS | 1646 | Values: 1441.0 1458.6 1526.9 1561.2 1571.2 9763.8 10638.4 11266.6 11280.7 11355.3 11169.9 11363.9 11388.9 11389.3 11402.5 2359.8 2373.9 2376.3 2391.4 2392.1 2298.8 2368.3 2380.5 2398.2 2399.6 2009.6 2267.5 2352.9 2375.1 2383.9 2344.6 2354.4 2355.0 2361.1 2384.5 1975.0 1979.0 2359.8 2370.7 2372.7 11096.0 11200.7 11229.9 11244.8 11266.7 5100.4 5648.4 5654.8 5811.0 5870.7 3282.6 3299.6 3418.5 3556.1 3624.8 1140.0 1144.6 1189.5 1239.5 1242.1 13009.0 13391.9 13656.3 14797.4 15273.0 4526.6 4617.3 4618.8 4633.3 4643.1 11880.8 11885.4 11950.6 11993.7 12039.4 5603.7 5613.8 5620.6 5622.7 5649.8 5038.0 5227.8 5285.8 5290.6 5295.5 3252.4 3866.3 3889.7 3891.3 3960.1 1032.6 1033.9 1044.8 1047.7 1048.2 925.4 927.0 936.0 940.2 984.0 6012.9 6343.6 6430.2 6559.5 6625.3 950.2 981.8 985.0 988.5 1016.9 4037.4 4138.9 4154.2 4194.3 4215.6 13428.2 14005.0 14024.9 14036.0 14071.0 13447.3 13633.5 13873.0 13963.9 13963.9 10105.1 10194.7 10213.3 10253.5 10274.5 6363.7 6403.1 6506.0 6517.9 6536.0 11926.5 12240.1 12349.5 12435.6 12454.9 11281.5 11348.6 12221.3 12788.5 12792.2 8962.1 9329.5 9363.4 9382.4 9389.2 10223.6 10251.9 10273.1 10341.8 10362.2 8775.6 8821.6 8838.0 8849.2 8866.1 8468.3 8550.5 8606.3 8639.8 8728.9 7605.7 7668.7 7788.0 7887.4 7895.3 5695.6 5851.2 5948.4 6002.8 6058.2 5813.4 5885.9 6061.6 6072.8 6151.8 02:52:02 INFO - PROCESS | 1646 | 02:52:02 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4560.88 Median:4905.03 stddev:1304.73 (26.6%) stddev-sans-first:1269.91 02:52:02 INFO - PROCESS | 1646 | Values: 370.2 375.7 377.2 391.0 399.6 4608.7 4944.6 5143.7 5231.8 5344.6 4227.9 5036.8 5212.3 5228.7 5229.8 3853.8 4117.6 4133.2 4156.6 4226.3 3766.3 3983.2 4099.8 4178.3 4203.2 3794.9 4170.1 4174.6 4179.7 4196.3 3774.5 4016.6 4075.8 4080.2 4081.4 3276.4 3299.7 3637.9 3653.7 3663.7 4021.7 4138.9 4955.7 5169.5 5180.3 3938.6 4148.4 4617.4 4654.9 4723.3 5187.3 5230.4 5290.2 5293.3 5425.3 3301.7 3908.6 4086.2 4126.3 4134.7 5142.5 5326.4 5461.2 5959.8 6023.7 4194.0 4213.8 4363.4 4666.6 4700.9 4186.6 4321.9 4797.3 4806.9 4833.2 4485.5 4585.2 5080.5 5096.2 5121.1 5342.5 5631.4 5635.4 5640.7 5715.4 1546.3 1571.5 1594.5 1596.2 1608.1 1060.2 1103.9 1135.1 1209.6 1215.5 4399.0 4741.3 4757.5 4865.5 5383.8 5077.8 5477.3 5808.8 5880.5 5906.4 4396.6 4474.6 4532.7 4818.2 5210.5 2643.0 2763.5 2961.3 3079.3 3095.6 5611.5 5686.3 5724.4 5960.0 6247.0 5224.7 5310.3 5664.4 6027.5 6031.8 5706.0 5780.7 5893.5 5916.8 6105.5 4841.7 5126.9 5588.8 5852.6 5921.7 4540.0 4646.5 5342.4 5601.7 5614.4 5094.3 5384.2 5480.6 5513.9 5862.5 4086.1 4308.6 4492.9 4550.6 4579.7 4285.5 4796.2 5027.7 5221.8 5233.5 5645.7 5650.0 5679.2 5694.4 5718.5 4690.4 5272.7 5689.3 5736.6 5740.5 4459.1 4996.0 5367.3 5586.9 5633.4 5159.6 5169.6 5561.0 5664.5 5763.9 4988.2 4988.2 5371.8 5510.3 5640.7 02:52:02 INFO - PROCESS | 1646 | 02:52:02 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:19630.27 Median:12883.89 stddev:27400.19 (212.7%) stddev-sans-first:27440.24 02:52:02 INFO - PROCESS | 1646 | Values: 714.6 735.4 756.7 819.5 833.8 15285.2 16095.4 16237.6 16249.7 16259.2 14314.6 15296.6 15301.8 15352.0 15362.2 931.6 965.7 969.2 971.1 971.6 934.3 966.3 975.3 976.0 977.8 1017.3 1023.0 1023.3 1024.1 1025.1 1011.4 1013.8 1019.4 1020.6 1021.6 753.2 760.6 761.5 761.8 762.8 15560.8 15686.6 15896.1 16231.8 16292.9 12019.9 13984.7 14101.6 14143.0 14425.8 11837.9 11895.1 11898.6 11970.3 11987.9 3317.3 3694.2 3710.7 3730.9 3850.2 102988.0 105199.5 107420.0 107908.9 108806.9 10461.0 10872.5 10878.1 10920.3 11027.5 20009.5 21581.0 22494.3 22726.0 22762.2 7467.9 7705.3 7740.8 7743.5 7770.3 3736.2 4254.6 4332.4 4350.1 4353.1 3005.6 3091.3 3544.4 3636.6 3695.2 697.9 700.3 706.6 706.7 715.2 617.4 664.3 701.5 701.9 723.0 10274.7 10466.4 10475.4 10934.3 11024.9 567.3 575.3 594.5 642.9 704.0 4606.3 5060.2 5097.8 5098.5 5098.8 86889.0 92180.0 96880.0 100595.0 103227.0 58031.8 70085.9 70821.6 76596.0 86062.0 68578.7 70227.3 70915.6 72260.6 72583.0 10834.3 11144.7 11213.7 11370.8 11378.8 39252.6 48958.3 49374.5 50725.7 51613.0 63144.4 65070.4 65673.0 66989.0 67555.7 12406.9 12496.6 12514.2 13276.5 13302.5 14360.4 14555.0 14750.1 14814.9 14880.8 13349.3 13457.6 13925.2 14206.8 14248.5 13189.0 13197.9 13792.3 13875.2 14291.4 13195.2 13372.8 13388.7 13401.4 13451.5 9232.0 9261.0 9451.6 9452.9 9691.1 9968.6 10429.5 11059.5 11381.3 11460.8 02:52:02 INFO - PROCESS | 1646 | -------- Summary: end -------- 02:52:02 INFO - PROCESS | 1646 | 02:52:02 INFO - TEST-INFO | 1646: exit 0 02:52:02 INFO - TEST-OK | dromaeo_css | took 1116306ms 02:52:02 INFO - TEST-START | kraken 02:52:02 INFO - operating with platform_type : mac_ 02:52:02 INFO - Initialising browser for kraken test... 02:52:02 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpiUBRle/profile http://localhost:49247/getInfo.html) 02:52:05 INFO - PROCESS | 1654 | 2017-04-10 02:52:05.496 plugin-container[1656:10655] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3b, name = 'com.apple.tsm.portname' 02:52:05 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:52:05 INFO - PROCESS | 1654 | 2017-04-10 02:52:05.497 plugin-container[1656:10655] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 02:52:05 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:52:05 INFO - PROCESS | 1654 | 2017-04-10 02:52:05.497 plugin-container[1656:10655] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:52:05 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 02:52:05 INFO - PROCESS | 1654 | colorDepth:24 02:52:05 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 02:52:05 INFO - PROCESS | 1654 | __metrics 02:52:05 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 02:52:06 INFO - TEST-INFO | 1654: exit 0 02:52:06 INFO - Browser initialized. 02:52:06 INFO - Running cycle 1/1 for kraken test... 02:52:06 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpiUBRle/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:08 INFO - PROCESS | 1657 | 2017-04-10 02:52:08.889 plugin-container[1658:10779] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a47, name = 'com.apple.tsm.portname' 02:52:08 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:52:08 INFO - PROCESS | 1657 | 2017-04-10 02:52:08.890 plugin-container[1658:10779] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9017, name = 'com.apple.CFPasteboardClient' 02:52:08 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:52:08 INFO - PROCESS | 1657 | 2017-04-10 02:52:08.890 plugin-container[1658:10779] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:52:18 INFO - PROCESS | 1657 | RSS: Main: 220676096 02:52:18 INFO - PROCESS | 1657 | 02:52:21 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 02:52:22 INFO - PROCESS | 1657 | RSS: Main: 235188224 02:52:22 INFO - PROCESS | 1657 | 02:52:25 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 02:52:25 INFO - PROCESS | 1657 | RSS: Main: 243138560 02:52:25 INFO - PROCESS | 1657 | 02:52:29 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 02:52:30 INFO - PROCESS | 1657 | RSS: Main: 247017472 02:52:30 INFO - PROCESS | 1657 | 02:52:31 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 02:52:32 INFO - PROCESS | 1657 | RSS: Main: 248287232 02:52:32 INFO - PROCESS | 1657 | 02:52:34 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:52:35 INFO - PROCESS | 1657 | RSS: Main: 248303616 02:52:35 INFO - PROCESS | 1657 | 02:52:38 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 02:52:39 INFO - PROCESS | 1657 | RSS: Main: 252071936 02:52:39 INFO - PROCESS | 1657 | 02:52:42 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 02:52:42 INFO - PROCESS | 1657 | RSS: Main: 251809792 02:52:42 INFO - PROCESS | 1657 | 02:52:46 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 02:52:46 INFO - PROCESS | 1657 | RSS: Main: 251936768 02:52:46 INFO - PROCESS | 1657 | 02:52:48 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:52:49 INFO - PROCESS | 1657 | RSS: Main: 251547648 02:52:49 INFO - PROCESS | 1657 | 02:52:51 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:52:51 INFO - PROCESS | 1657 | RSS: Main: 251551744 02:52:51 INFO - PROCESS | 1657 | 02:52:53 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:52:54 INFO - PROCESS | 1657 | RSS: Main: 251576320 02:52:54 INFO - PROCESS | 1657 | 02:52:57 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:52:58 INFO - PROCESS | 1657 | RSS: Main: 252055552 02:52:58 INFO - PROCESS | 1657 | 02:53:01 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:53:01 INFO - PROCESS | 1657 | RSS: Main: 251760640 02:53:01 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 02:53:03 INFO - PROCESS | 1657 | RSS: Main: 253816832 02:53:03 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | __start_tp_report 02:53:03 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 02:53:03 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 02:53:03 INFO - PROCESS | 1657 | |i|pagename|runs| 02:53:03 INFO - PROCESS | 1657 | |0;ai-astar;110;120;121;120;120;119;122;97;116;170 02:53:03 INFO - PROCESS | 1657 | |1;audio-beat-detection;144;115;115;148;116;116;116;149;154;113 02:53:03 INFO - PROCESS | 1657 | |2;audio-dft;252;179;275;282;197;196;196;203;199;194 02:53:03 INFO - PROCESS | 1657 | |3;audio-fft;84;62;62;86;64;63;60;60;72;63 02:53:03 INFO - PROCESS | 1657 | |4;audio-oscillator;83;64;89;84;103;101;112;82;71;82 02:53:03 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;88;136;136;138;88;87;90;90;90;88 02:53:03 INFO - PROCESS | 1657 | |6;imaging-darkroom;97;100;106;93;136;97;97;96;97;141 02:53:03 INFO - PROCESS | 1657 | |7;imaging-desaturate;89;110;146;91;113;139;91;107;144;79 02:53:03 INFO - PROCESS | 1657 | |8;json-parse-financial;67;67;66;77;91;107;71;69;70;70 02:53:03 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;57;63;60;78;92;83;87;86;50;73 02:53:03 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;84;103;97;87;86;84;85;86;84;89 02:53:03 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;134;140;137;157;138;142;143;146;181;141 02:53:03 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;168;165;168;165;173;176;171;169;165;167 02:53:03 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;63;83;85;67;64;65;66;65;64;62 02:53:03 INFO - PROCESS | 1657 | __end_tp_report 02:53:03 INFO - PROCESS | 1657 | __start_cc_report 02:53:03 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1015 02:53:03 INFO - PROCESS | 1657 | __end_cc_report 02:53:03 INFO - PROCESS | 1657 | __startTimestamp1491817983639__endTimestamp 02:53:03 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | ------- Summary: start ------- 02:53:03 INFO - PROCESS | 1657 | Number of tests: 14 02:53:03 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:121.50 Median:120.50 stddev:18.64 (15.5%) stddev-sans-first:19.31 02:53:03 INFO - PROCESS | 1657 | Values: 110.0 120.0 121.0 120.0 120.0 119.0 122.0 97.0 116.0 170.0 02:53:03 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:130.00 stddev:17.53 (13.5%) stddev-sans-first:17.68 02:53:03 INFO - PROCESS | 1657 | Values: 144.0 115.0 115.0 148.0 116.0 116.0 116.0 149.0 154.0 113.0 02:53:03 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:217.30 Median:201.00 stddev:37.40 (18.6%) stddev-sans-first:37.50 02:53:03 INFO - PROCESS | 1657 | Values: 252.0 179.0 275.0 282.0 197.0 196.0 196.0 203.0 199.0 194.0 02:53:03 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:67.60 Median:63.50 stddev:9.78 (15.4%) stddev-sans-first:8.38 02:53:03 INFO - PROCESS | 1657 | Values: 84.0 62.0 62.0 86.0 64.0 63.0 60.0 60.0 72.0 63.0 02:53:03 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:87.10 Median:82.00 stddev:14.69 (17.9%) stddev-sans-first:15.50 02:53:03 INFO - PROCESS | 1657 | Values: 83.0 64.0 89.0 84.0 103.0 101.0 112.0 82.0 71.0 82.0 02:53:03 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:103.10 Median:88.00 stddev:23.19 (26.4%) stddev-sans-first:23.95 02:53:03 INFO - PROCESS | 1657 | Values: 88.0 136.0 136.0 138.0 88.0 87.0 90.0 90.0 90.0 88.0 02:53:03 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:106.00 Median:96.50 stddev:17.49 (18.1%) stddev-sans-first:18.25 02:53:03 INFO - PROCESS | 1657 | Values: 97.0 100.0 106.0 93.0 136.0 97.0 97.0 96.0 97.0 141.0 02:53:03 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:110.90 Median:112.50 stddev:24.56 (21.8%) stddev-sans-first:24.73 02:53:03 INFO - PROCESS | 1657 | Values: 89.0 110.0 146.0 91.0 113.0 139.0 91.0 107.0 144.0 79.0 02:53:03 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:75.50 Median:70.00 stddev:13.30 (19.0%) stddev-sans-first:13.75 02:53:03 INFO - PROCESS | 1657 | Values: 67.0 67.0 66.0 77.0 91.0 107.0 71.0 69.0 70.0 70.0 02:53:03 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:72.90 Median:80.50 stddev:14.55 (18.1%) stddev-sans-first:14.25 02:53:03 INFO - PROCESS | 1657 | Values: 57.0 63.0 60.0 78.0 92.0 83.0 87.0 86.0 50.0 73.0 02:53:03 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:86.00 stddev:6.42 (7.5%) stddev-sans-first:6.60 02:53:03 INFO - PROCESS | 1657 | Values: 84.0 103.0 97.0 87.0 86.0 84.0 85.0 86.0 84.0 89.0 02:53:03 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:142.50 stddev:13.83 (9.7%) stddev-sans-first:13.98 02:53:03 INFO - PROCESS | 1657 | Values: 134.0 140.0 137.0 157.0 138.0 142.0 143.0 146.0 181.0 141.0 02:53:03 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:168.50 stddev:3.68 (2.2%) stddev-sans-first:3.90 02:53:03 INFO - PROCESS | 1657 | Values: 168.0 165.0 168.0 165.0 173.0 176.0 171.0 169.0 165.0 167.0 02:53:03 INFO - PROCESS | 1657 | 02:53:03 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:65.50 stddev:8.36 (12.8%) stddev-sans-first:8.63 02:53:03 INFO - PROCESS | 1657 | Values: 63.0 83.0 85.0 67.0 64.0 65.0 66.0 65.0 64.0 62.0 02:53:03 INFO - PROCESS | 1657 | -------- Summary: end -------- 02:53:03 INFO - PROCESS | 1657 | 02:53:04 INFO - TEST-INFO | 1657: exit 0 02:53:04 INFO - TEST-OK | kraken | took 61870ms 02:53:04 INFO - SUITE-END | took 1178s 02:53:04 INFO - Completed test suite (00:19:38) 02:53:04 INFO - javascript benchmark 02:53:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7605.925721609598, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3433.502142189381, 3472.496488009238, 3478.9652103478957, 3483.1292176955762, 3496.702780263681, 4908.165611845986, 5960.076188190832, 6040.818775436733, 6108.847278818021, 6112.1137435072, 5994.250718660168, 6023.126646636246, 6099.0, 6105.236845394325, 6113.358097399776, 4725.692829966041, 5369.845483221106, 5417.86224892772, 5504.972475137619, 5535.806246781363, 5532.861678458031, 5553.0, 5554.91667624986, 5559.499645031946, 5559.805406810762, 5324.680519168843, 5381.81163659272, 5536.252605898192, 5551.139573366135, 5600.6079574429605, 5504.0, 5510.283663123809, 5516.3797196331425, 5533.6956467394275, 5566.55467562594, 5364.839054828361, 5481.5340696040885, 5492.395836458027, 5506.972465137689, 5538.169274608801, 4681.88295292617, 6116.960116780158, 6125.264968203799, 6204.7828326008375, 6230.096635987802, 6262.029385445263, 6292.307846136921, 6302.369763023707, 6336.20797400325, 6347.206599175103, 6534.771283005072, 6536.0, 6549.574277671936, 6601.504887133437, 6690.531662783607, 6177.84555386119, 6204.193454850885, 6241.469475094668, 6241.687915604201, 6276.717547710364, 5666.688332141689, 6367.713452894538, 6394.712237949303, 6499.415052645285, 6616.206055273302, 6281.3404592518045, 6302.275238347557, 6308.148399966038, 6331.176946996861, 6340.778072767431, 6474.352564743488, 6510.153680021567, 6511.38141876521, 6528.412442880163, 6535.150430444012, 5154.304168937146, 6405.775797847146, 6415.839604009844, 6430.0676401921455, 6468.579542329733, 5581.10702287632, 6232.626042437469, 6271.749130034747, 6271.749130034838, 6313.589616674902, 5209.895802083937, 5256.1327380982475, 5259.132243179909, 5264.92102618461, 5279.102552566073, 4029.858954936622, 4528.569785870337, 4594.88512787183, 4613.123506533815, 4627.814887404466, 5924.5852790305125, 5970.253718285215, 6117.979653188475, 6177.96911015451, 6216.658083805434, 6453.580517266362, 6468.062130991074, 6524.575902566318, 6529.183852018497, 6537.1501704778075, 5994.520438364921, 6050.818475445743, 6126.609281623611, 6164.321924588292, 6178.0, 5666.886662266814, 5766.192733017381, 5768.0, 5805.158252053428, 5807.970960145257, 6390.840228994312, 6474.417302442803, 6640.634765087773, 6751.729930802713, 6765.52641315113, 6420.422162005442, 6483.059956306403, 6504.739810407531, 6530.47756179514, 6556.737730490727, 6732.697028633821, 6734.057231987427, 6736.292689267556, 6739.460843132636, 6762.560433571802, 6158.445739883432, 6291.213598300213, 6394.008928616072, 6414.807555773335, 6437.967810161106, 6333.240011198685, 6375.681215939092, 6402.231732192166, 6402.6158430494315, 6418.711157997995, 6231.688415579112, 6299.590526615939, 6306.590071645328, 6313.589616674902, 6333.113364128933, 6220.0, 6292.18201633803, 6322.209723784527, 6328.936710632835, 6329.841753956188, 6117.248930028971, 6166.321704612579, 6222.315545289924, 6285.402886725937, 6286.277078136073, 6310.021946598285, 6311.053341998737, 6322.905156422566, 6328.588641738273, 6331.873362532816, 6233.625982441068, 6270.7491700331475, 6282.403171698864, 6299.842503937438, 6308.337624549356], "value": 5936.362218593286, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.949844012479, 749.6926260233305, 821.3265122599468, 937.6062053937345, 942.0861764088831, 38254.04364890879, 38794.612053879486, 40280.79859600705, 40468.392974105336, 40484.59515404845, 39042.8047859761, 39169.21661566767, 39210.0, 39343.0, 39453.0, 7861.960690196555, 8290.41967062306, 10138.898611013907, 10486.213533984943, 10725.30285531438, 9228.492432916188, 10599.523021464014, 10665.733356666067, 10678.946605266963, 10696.839547406795, 8235.958820205891, 10706.1435085193, 10716.892831071706, 10745.731356716067, 11117.22179447439, 10611.946940265327, 10691.305065170778, 10717.946410267978, 10729.409882456463, 10744.086752626035, 10412.895871041268, 10475.685729428129, 10475.79048419035, 10493.0, 10498.895011049868, 33409.0, 33572.83213583941, 33589.83205083983, 33650.1587460313, 33659.6634033659, 3686.594474607791, 3766.6233376662112, 3767.547894252707, 3794.392897136445, 3803.847846086181, 24444.0, 24547.0, 25042.373940651447, 25927.74072259272, 25975.480490390277, 3060.5409188621884, 3092.752579793611, 3185.4266232078216, 3262.9184270393193, 3291.753118516121, 289143.0, 290065.0, 291736.0, 292250.0, 293582.0, 42749.0, 42792.14415711668, 42853.35719964141, 42925.926851828954, 43013.13973720508, 41204.587954120674, 44095.0, 44095.77952110283, 44127.33808992868, 44157.55842441598, 12055.879441205476, 12717.682057948625, 12767.61697149087, 12801.743965120646, 12870.742585148244, 10882.075023622923, 10887.510062047228, 10909.563617455371, 10926.0, 10927.562897484011, 11288.379139147262, 11788.94105529484, 11801.586944456903, 11812.173147879737, 11902.226355287052, 5623.943760562423, 5700.344460387026, 5706.28671416073, 5708.229389032511, 5740.6268592541355, 893.2942975049638, 1093.2128867215752, 1109.3676604335612, 1121.8445001648315, 1188.483009890683, 26886.462270754477, 26922.865385672947, 26967.865160674464, 26999.595006074924, 27326.0, 1031.5718976624617, 1190.8690044095142, 1215.5380955236953, 1271.3325504110417, 1279.437047699028, 11984.34086125254, 13540.0, 13974.301284935917, 14048.648783780487, 14277.0, 462612.0, 465406.0, 468746.0, 469398.0, 469870.0, 47011.059778804236, 56525.43474565284, 56918.0, 57051.0, 57106.7144664274, 1361.884239839605, 1385.1827421821174, 1401.0, 1401.0472878442554, 1410.3089486151712, 26094.86952565225, 26267.60598591061, 26291.868540657175, 26886.731132688423, 27031.1890643281, 39799.20401591894, 39960.00099997524, 39961.40057899075, 40178.59821401749, 40257.1948561033, 465349.0, 476107.0, 476683.0, 476980.0, 478102.6094869503, 27491.074003719834, 28341.71658283473, 28398.716012839606, 28578.999735009176, 28724.851005960365, 29202.26994325074, 36191.91424257276, 36908.446373304956, 37133.0, 37218.62781372152, 26170.476590468465, 26584.601230981938, 27112.72887271102, 27271.454570908867, 27645.86177069102, 23993.52012959766, 26079.869600651877, 26574.069907553916, 26839.463210735285, 27103.322416939733, 29752.95864644727, 29825.5526167112, 30253.69746302597, 30617.54073688941, 30704.38591228118, 24435.877820611495, 25092.0, 25356.746432536176, 25530.872345638152, 27158.0, 21498.251973339055, 21604.67592986138, 22244.888775556017, 22365.0, 22413.551728965656], "value": 17641.1881830615, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.26895223074575, 412.36495796473434, 413.3386581469649, 426.2519278665942, 452.028139500075, 19196.136173872175, 20015.499612509695, 21543.13827446904, 21575.24486642968, 21665.133394664215, 20966.37100886976, 21826.781732182673, 22025.0, 22390.776092239073, 22438.439039024033, 6287.245530536342, 6612.867742645144, 6642.0, 6648.966755166218, 6658.034584985175, 6230.937690623104, 6383.0, 6453.774117905874, 6502.479801615883, 6507.674616269192, 6399.744010239585, 6443.548951573392, 6467.417932386084, 6490.286068532458, 6494.31809659986, 6249.312575616678, 6486.708098135595, 6491.350864913518, 6491.870162596769, 6504.284528701839, 6138.956377415805, 6259.812205633838, 6342.5243106767175, 6356.809295721136, 6365.713542890535, 25833.483330333474, 26029.349266268306, 26142.0, 26391.736082639312, 26526.0, 2858.7141285871453, 2947.8378689172087, 3049.2986613079115, 3106.130283520595, 3163.9558945547915, 15661.295241714037, 16381.42665006731, 16511.83488165115, 16905.0, 17023.65952680952, 2023.1401654297013, 2042.234162189179, 2049.405672355015, 2056.0953180600486, 2056.2186369179767, 148082.0, 156847.0, 178080.0, 180900.19099808965, 181763.0, 17395.73906391405, 17680.646387072185, 19516.70724939127, 20861.478463038544, 21066.999999999694, 32017.0, 32634.0, 32902.177445564055, 33173.17067073342, 33215.169620759676, 7617.428692847948, 9299.53502324881, 9569.521523923777, 9718.97950715179, 9729.513524323755, 7649.885251721229, 7669.041369828771, 7694.384449244047, 7825.530468171814, 7844.646990885424, 8227.095019547845, 9570.090841370058, 9599.664011759554, 9744.610215591298, 9768.411370986694, 4001.779902105354, 4190.368125332826, 4277.593628605277, 4311.8490852820005, 4328.5022222444195, 817.1950628630794, 898.2140626951417, 917.1434119527371, 924.2144177449114, 939.9718008459757, 20767.273145439838, 21227.68158477624, 21265.57468850645, 21351.572968540542, 21463.67804482934, 817.3134566963779, 856.3063918226256, 886.9689560865339, 932.105179028127, 943.8159558885951, 10549.683509494727, 10965.61620343284, 10976.670699879016, 11045.0, 11222.158338124673, 611465.0, 615660.0, 735832.0, 737041.0, 740695.0, 147832.0, 152830.0, 156574.0, 156777.2161139187, 159221.0, 1322.127395918689, 1339.6985678222322, 1370.766969615168, 1374.1960952842699, 1383.1355402873405, 19261.325853595055, 20293.188272468935, 20393.388198354074, 20396.184152633727, 20453.38639840807, 66523.0, 66578.33686652673, 66649.33350666432, 67416.65166696541, 68347.65826170838, 85936.71094933456, 88293.0, 92657.0, 93317.5334123325, 93704.0, 8119.512829230265, 11140.610078647209, 11489.942550287195, 11619.76760464769, 11896.0, 12249.877501224873, 12656.6835829105, 13193.34033298312, 13229.735405291647, 13606.183628982293, 11113.15236766446, 11166.553337866719, 11281.71795705114, 11301.039411649774, 11559.595414160463, 8786.912130878609, 10555.366677999345, 10596.576136954436, 10611.840822387825, 10916.235863489479, 11399.658010259374, 11678.824817627912, 11752.471138798604, 11854.110941679237, 11917.34454605005, 11739.647810565697, 11755.941220293844, 11779.941100294443, 11814.645560633195, 12120.515179392725, 6098.75604975796, 8536.957315213383, 11167.162462815484, 11493.310401375944, 11698.06415486776], "value": 11438.347575977841, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.0, 1458.5624312706188, 1526.8702160316373, 1561.1881821452837, 1571.167281340889, 9763.804723905518, 10638.414887181201, 11266.605668801594, 11280.661580152599, 11355.261907975975, 11169.944150279238, 11363.943180284108, 11388.886111138887, 11389.259698119617, 11402.543898244081, 2359.784710873897, 2373.9169129080487, 2376.3346263046374, 2391.4260577461373, 2392.055138220402, 2298.7816157465013, 2368.27767530903, 2380.452495925938, 2398.2205783120557, 2399.6280576510667, 2009.6181725472186, 2267.535155293161, 2352.8588284702973, 2375.121205154087, 2383.916562920298, 2344.601417758985, 2354.376090336062, 2354.976450235493, 2361.055577768889, 2384.463495713451, 1974.9605007899904, 1978.9901050494655, 2359.823013273994, 2370.7155141382973, 2372.7389987101405, 11096.00135987765, 11200.663980080612, 11229.943850280779, 11244.775104497865, 11266.718332041683, 5100.362454693163, 5648.378678345379, 5654.802081927113, 5810.970945145289, 5870.677112758796, 3282.606087269519, 3299.637039925606, 3418.487411752385, 3556.0931962349696, 3624.800635965021, 1139.9658010259704, 1144.553624086607, 1189.5122999570222, 1239.4608345369793, 1242.1118899986463, 13009.0, 13391.86608133916, 13656.317184140753, 14797.446268141905, 15273.0, 4526.569975852289, 4617.3074038893765, 4618.769061546909, 4633.2818413146015, 4643.117807616542, 11880.762384752257, 11885.40572971348, 11950.641480755592, 11993.700157495958, 12039.39803009846, 5603.719814009283, 5613.831585052455, 5620.57845661577, 5622.662640241599, 5649.802256920988, 5038.042771873333, 5227.790888364499, 5285.841424757264, 5290.576753859682, 5295.470452954673, 3252.3820474110316, 3866.304065268279, 3889.747166434173, 3891.2606604745574, 3960.0693836948294, 1032.59051394847, 1033.9379637221791, 1044.7567394800164, 1047.696168111239, 1048.2295512798087, 925.3753716241645, 926.9582868770922, 935.9672411465566, 940.1726480696943, 983.9901600984042, 6012.947734146507, 6343.619382837044, 6430.164078669743, 6559.508036897252, 6625.3043430440075, 950.2065775077749, 981.8232718110665, 984.9704508864745, 988.5057471264367, 1016.9389836609827, 4037.4347591337237, 4138.91722165561, 4154.231467178582, 4194.266003449445, 4215.620594146541, 13428.19430834153, 14005.0, 14024.859751402355, 14036.0, 14071.0, 13447.26040067786, 13633.522826701017, 13872.959528035437, 13963.930180349033, 13963.930180349236, 10105.090541851268, 10194.694159175237, 10213.285070045025, 10253.487325633689, 10274.537645806106, 6363.6818159090935, 6403.103565500926, 6506.02409638539, 6517.9348206517325, 6535.954247320597, 11926.522939082339, 12240.143189976616, 12349.506019759108, 12435.564755233523, 12454.875451245372, 11281.548738050386, 11348.602798901999, 12221.266723996589, 12788.48846046185, 12792.232466052066, 8962.14859588338, 9329.533523323942, 9363.4381937084, 9382.437053776795, 9389.248860091313, 10223.59105635796, 10251.948740256252, 10273.075423211947, 10341.844872327072, 10362.222833287684, 8775.648974040967, 8821.558922054, 8837.955810220908, 8849.247813935888, 8866.069062748318, 8468.280196183146, 8550.486970781772, 8606.311495080254, 8639.784005399915, 8728.91271087281, 7605.733799316998, 7668.69325227007, 7788.0, 7887.44787864844, 7895.289423951872, 5695.572832037531, 5851.1515830205235, 5948.37542058095, 6002.759889604542, 6058.182145410313, 5813.3895940925595, 5885.911711324419, 6061.605995610271, 6072.757089716361, 6151.753929842936], "value": 5084.233597169649, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.2003672068331, 375.7107027588756, 377.1683438019168, 390.9804509774511, 399.5664703796381, 4608.654350923677, 4944.579710724593, 5143.711048583377, 5231.816886408977, 5344.625876188668, 4227.85202517912, 5036.772231847302, 5212.322398088253, 5228.738563071841, 5229.790808367661, 3853.8265778039986, 4117.56765539617, 4133.1940271647045, 4156.5635608261155, 4226.323788193889, 3766.322062028834, 3983.24318379507, 4099.795010249491, 4178.268802959486, 4203.222403855281, 3794.924101517968, 4170.082581831992, 4174.603412675791, 4179.686523510733, 4196.286631272676, 3774.471573979645, 4016.6385025347713, 4075.816588253536, 4080.18396320737, 4081.3673880548563, 3276.3611095836322, 3299.686529779667, 3637.872674456408, 3653.6529029742132, 3663.6885864701267, 4021.678265738734, 4138.937915931233, 4955.727434991074, 5169.508896654812, 5180.332128953592, 3938.586448422903, 4148.423599032379, 4617.376654151713, 4654.906097067186, 4723.267893476516, 5187.250757098744, 5230.372355317349, 5290.206469029637, 5293.258943747878, 5425.283680678747, 3301.7053148062105, 3908.5700572936953, 4086.2031903778775, 4126.339785634284, 4134.73124246923, 5142.51146141116, 5326.360836699582, 5461.238393494861, 5959.791407300723, 6023.66869822164, 4193.958060419418, 4213.810378532973, 4363.36731173978, 4666.580007799314, 4700.929486057712, 4186.623203911662, 4321.947075139284, 4797.328374027639, 4806.8849706129195, 4833.202521583899, 4485.529019452975, 4585.151746926763, 5080.517350851663, 5096.21008743638, 5121.07820592297, 5342.465753424704, 5631.352394474606, 5635.408282130317, 5640.746166422521, 5715.428457154251, 1546.26552387615, 1571.462088726698, 1594.5136733296456, 1596.1859451679495, 1608.1155364549452, 1060.1995493402433, 1103.9172062095374, 1135.0692432205676, 1209.6492017314881, 1215.53202017224, 4398.978005109954, 4741.2888066789565, 4757.500462451462, 4865.489123642037, 5383.8384848453825, 5077.796888124508, 5477.315335583052, 5808.780156167168, 5880.529557635379, 5906.350301466835, 4396.582324679151, 4474.621660646257, 4532.682712210114, 4818.156822556039, 5210.534994228796, 2643.0088716731225, 2763.5440152375036, 2961.304093538017, 3079.321769635554, 3095.628524577065, 5611.5230205433, 5686.346070201897, 5724.398938111522, 5960.00339886143, 6246.969250073687, 5224.7126408047925, 5310.309659744208, 5664.433556644302, 6027.468463245447, 6031.758729650853, 5705.971470142706, 5780.71096445176, 5893.465809701784, 5916.822495325147, 6105.5420843437805, 4841.685290456109, 5126.923096153486, 5588.77644894216, 5852.619579727304, 5921.703914804157, 4539.954600453953, 4646.468683800268, 5342.423984924379, 5601.691906945157, 5614.354349249726, 5094.2867998479505, 5384.165454354581, 5480.616356855141, 5513.9448605513435, 5862.530997520274, 4086.1010577672864, 4308.612224899774, 4492.932606010978, 4550.567696068868, 4579.656525760514, 4285.46431696038, 4796.184648609815, 5027.673201241908, 5221.765020574007, 5233.450487698889, 5645.725479222124, 5649.954758369715, 5679.211048519703, 5694.402087780723, 5718.542516598579, 4690.366800482027, 5272.734543709405, 5689.31728192603, 5736.569757268138, 5740.483356497935, 4459.063596644612, 4996.00159936014, 5367.329083864517, 5586.916196256978, 5633.380328163817, 5159.638825282194, 5169.560587350117, 5560.972195138998, 5664.518515926193, 5763.8559036024435, 4988.226824842155, 4988.226824842155, 5371.818199995994, 5510.311211098613, 5640.71796410186], "value": 4188.2193422193, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.6319645382632, 735.4116706634691, 756.71623141322, 819.5205804604307, 833.8082241084551, 15285.159316237603, 16095.436659716912, 16237.594060148502, 16249.675006499863, 16259.187040647965, 14314.568543145706, 15296.617584560392, 15301.770473442879, 15352.0, 15362.155081470515, 931.5621657820831, 965.7054598347502, 969.2100937735757, 971.053223107468, 971.6016433262329, 934.3086116273977, 966.2511553546022, 975.2880397309968, 975.9560819763128, 977.799551092028, 1017.2878984710695, 1023.0076825479273, 1023.3092662452851, 1024.1499555369064, 1025.097913835827, 1011.4285428732743, 1013.7769690668041, 1019.3781793106199, 1020.6427750287414, 1021.5658345203296, 753.15270320889, 760.6424980259269, 761.5240474703311, 761.8476304739074, 762.8474305138939, 15560.844391556053, 15686.607834804106, 15896.125713085776, 16231.782616303706, 16292.918535407247, 12019.93990030053, 13984.650383740387, 14101.576952691436, 14142.9585540326, 14425.78361324581, 11837.940810295979, 11895.107866910017, 11898.643040708706, 11970.281783093042, 11987.930545958856, 3317.3365326934468, 3694.242680250542, 3710.684591809699, 3730.9253814923823, 3850.172212974224, 102988.0, 105199.47400263026, 107420.0, 107908.92091079068, 108806.91193088047, 10461.0, 10872.510737016853, 10878.075363594025, 10920.344779313267, 11027.503762330554, 20009.499762505762, 21581.02885370162, 22494.32517024492, 22726.0, 22762.20332288362, 7467.887981680279, 7705.306522412898, 7740.7677769667, 7743.45795794289, 7770.300672939463, 3736.1593641431004, 4254.553271906467, 4332.35014747784, 4350.108227813291, 4353.1293741251875, 3005.5792189093545, 3091.31990961988, 3544.4151714966742, 3636.61815509373, 3695.168587067942, 697.9441644668415, 700.2822107339915, 706.5513398991575, 706.6678661029308, 715.2454160860239, 617.3671986214076, 664.3000769555415, 701.4563713122269, 701.8771714949863, 722.955329548797, 10274.691759247235, 10466.424346660855, 10475.42385168823, 10934.289271197347, 11024.944875275572, 567.3277166557642, 575.2521721761693, 594.5006194796392, 642.8521440068811, 703.9577625342496, 4606.262997920384, 5060.240963855451, 5097.796088156507, 5098.490150984871, 5098.847034588968, 86889.0, 92180.0, 96880.0, 100595.0, 103226.96773032323, 58031.8393632125, 70085.94871076939, 70821.64589177021, 76596.0, 86062.0, 68578.65710671415, 70227.29772702309, 70915.58168836594, 72260.63869680723, 72583.0, 10834.349939003685, 11144.665660030212, 11213.719657008314, 11370.772584548096, 11378.772424551627, 39252.607473924894, 48958.26562601635, 49374.50625493843, 50725.74637126791, 51613.0, 63144.36855631385, 65070.37324066936, 65673.0, 66989.0, 67555.66222168857, 12406.875931240573, 12496.625101246977, 12514.249145051326, 13276.53532126371, 13302.467901284228, 14360.425582976564, 14555.0, 14750.114993100447, 14814.925925370304, 14880.776788347966, 13349.25743069037, 13457.596272111852, 13925.164490130219, 14206.786898196742, 14248.501302454364, 13189.0, 13197.868021319664, 13792.310384480536, 13875.236861972284, 14291.428342866584, 13195.20828750278, 13372.799408009083, 13388.665283367995, 13401.396937137657, 13451.529196478075, 9231.953840230755, 9261.0, 9451.574679139592, 9452.858207127036, 9691.123550579543, 9968.601255949681, 10429.478526073513, 11059.50232239535, 11381.260218085798, 11460.796616355496], "value": 7589.3848298167195, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1562.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 120.0, 121.0, 120.0, 120.0, 119.0, 122.0, 97.0, 116.0, 170.0], "value": 121.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 115.0, 115.0, 148.0, 116.0, 116.0, 116.0, 149.0, 154.0, 113.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [252.0, 179.0, 275.0, 282.0, 197.0, 196.0, 196.0, 203.0, 199.0, 194.0], "value": 217.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 62.0, 62.0, 86.0, 64.0, 63.0, 60.0, 60.0, 72.0, 63.0], "value": 67.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 64.0, 89.0, 84.0, 103.0, 101.0, 112.0, 82.0, 71.0, 82.0], "value": 87.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 136.0, 136.0, 138.0, 88.0, 87.0, 90.0, 90.0, 90.0, 88.0], "value": 103.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 100.0, 106.0, 93.0, 136.0, 97.0, 97.0, 96.0, 97.0, 141.0], "value": 106.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 110.0, 146.0, 91.0, 113.0, 139.0, 91.0, 107.0, 144.0, 79.0], "value": 110.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 77.0, 91.0, 107.0, 71.0, 69.0, 70.0, 70.0], "value": 75.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 63.0, 60.0, 78.0, 92.0, 83.0, 87.0, 86.0, 50.0, 73.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 103.0, 97.0, 87.0, 86.0, 84.0, 85.0, 86.0, 84.0, 89.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 140.0, 137.0, 157.0, 138.0, 142.0, 143.0, 146.0, 181.0, 141.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 168.0, 165.0, 173.0, 176.0, 171.0, 169.0, 165.0, 167.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 83.0, 85.0, 67.0, 64.0, 65.0, 66.0, 65.0, 64.0, 62.0], "value": 68.4, "unit": "score"}]}]} 02:53:04 INFO - Return code: 0 02:53:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:53:04 ERROR - # TBPL SUCCESS # 02:53:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:53:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:53:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:53:04 INFO - 2017-04-10 02:53:04.983 screenresolution[1662:11173] starting screenresolution argv=screenresolution get 02:53:04 INFO - 2017-04-10 02:53:04.987 screenresolution[1662:11173] Display 0: 1600x1200x32@60 02:53:04 INFO - 2017-04-10 02:53:04.993 screenresolution[1663:11176] starting screenresolution argv=screenresolution list 02:53:04 INFO - Available Modes on Display 0 02:53:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:53:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:53:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:53:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:53:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:53:05 INFO - Intel Iris: 02:53:05 INFO - Chipset Model: Intel Iris 02:53:05 INFO - Type: GPU 02:53:05 INFO - Bus: Built-In 02:53:05 INFO - VRAM (Dynamic, Max): 1536 MB 02:53:05 INFO - Vendor: Intel (0x8086) 02:53:05 INFO - Device ID: 0x0a2e 02:53:05 INFO - Revision ID: 0x0009 02:53:05 INFO - Displays: 02:53:05 INFO - Display: 02:53:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:53:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:53:05 INFO - Display Serial Number: 1600x1200 60 02:53:05 INFO - Main Display: Yes 02:53:05 INFO - Mirror: Off 02:53:05 INFO - Online: Yes 02:53:05 INFO - Rotation: Supported 02:53:05 INFO - Return code: 0 02:53:05 INFO - Running post-action listener: _resource_record_post_action 02:53:05 INFO - [mozharness: 2017-04-10 09:53:05.228398Z] Finished run-tests step (success) 02:53:05 INFO - Running post-run listener: _resource_record_post_run 02:53:05 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 34107392; Write bytes: 513996800; Read time: 200; Write time: 1642 02:53:05 INFO - TinderboxPrint: CPU usage
54.5% 02:53:05 INFO - TinderboxPrint: I/O read bytes / time
34,107,392 / 200 02:53:05 INFO - TinderboxPrint: I/O write bytes / time
513,996,800 / 1,642 02:53:05 INFO - TinderboxPrint: CPU idle
2,181.9 (45.5%) 02:53:05 INFO - TinderboxPrint: CPU system
960.3 (20.0%) 02:53:05 INFO - TinderboxPrint: CPU user
1,655.7 (34.5%) 02:53:05 INFO - TinderboxPrint: Swap in / out
238,571,520 / 0 02:53:05 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203823616; Write bytes: 201203712; Read time: 15589; Write time: 461 02:53:05 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 32112640; Write bytes: 302000128; Read time: 182; Write time: 1150 02:53:05 INFO - Running post-run listener: _upload_blobber_files 02:53:05 INFO - Blob upload gear active. 02:53:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:53:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:53:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:53:06 INFO - (blobuploader) - INFO - Open directory for files ... 02:53:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:53:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:53:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:07 INFO - (blobuploader) - INFO - Done attempting. 02:53:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:53:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:53:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:08 INFO - (blobuploader) - INFO - Done attempting. 02:53:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:53:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:53:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:09 INFO - (blobuploader) - INFO - Done attempting. 02:53:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:53:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:53:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:11 INFO - (blobuploader) - INFO - Done attempting. 02:53:11 INFO - (blobuploader) - INFO - Iteration through files over. 02:53:11 INFO - Return code: 0 02:53:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:53:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:53:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a8e5df03acd6c0d874bab554ef0c6e8fad77bfd9aa592fa483bb58f843c6596f37fc1703c23d84ee4f6577fe0d5c38736f65d11f18725d1a61c77e374d968a0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a92c5a8b31cf21e4f8e708202d7a0275e2ede8591a1030895f755e8497ccdb7e4a044cbc38706c4608ab527ac6bc8f30f936af06041453034e917f7d27439516", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fcf721aa91bec88e971672cb46909df4bffe1bb011f527003ca79cf59c522fe36dd74680bf9930eb2bc01dfab57457408e6facd864f48c94f2a11569bafd8649", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/233e5d2d82bd534448b9938517c8c01f528dc1ec8b3231c71c6c805362842278076c06acdfef33016c83d26601a95fc9228241fc029810bb476631665d4717a7"} 02:53:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:53:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:53:11 INFO - Contents: 02:53:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a8e5df03acd6c0d874bab554ef0c6e8fad77bfd9aa592fa483bb58f843c6596f37fc1703c23d84ee4f6577fe0d5c38736f65d11f18725d1a61c77e374d968a0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a92c5a8b31cf21e4f8e708202d7a0275e2ede8591a1030895f755e8497ccdb7e4a044cbc38706c4608ab527ac6bc8f30f936af06041453034e917f7d27439516", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fcf721aa91bec88e971672cb46909df4bffe1bb011f527003ca79cf59c522fe36dd74680bf9930eb2bc01dfab57457408e6facd864f48c94f2a11569bafd8649", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/233e5d2d82bd534448b9938517c8c01f528dc1ec8b3231c71c6c805362842278076c06acdfef33016c83d26601a95fc9228241fc029810bb476631665d4717a7"} 02:53:11 INFO - Running post-run listener: copy_logs_to_upload_dir 02:53:11 INFO - Copying logs to upload dir... 02:53:11 INFO - mkdir: /builds/slave/test/build/upload/logs 02:53:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1380.257162 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 23 mins, 0 secs) (at 2017-04-10 02:53:11.511359) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 02:53:11.514736) ========= 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.NE4UA7bLw6/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.clbVNB8od4/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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/1a8e5df03acd6c0d874bab554ef0c6e8fad77bfd9aa592fa483bb58f843c6596f37fc1703c23d84ee4f6577fe0d5c38736f65d11f18725d1a61c77e374d968a0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a92c5a8b31cf21e4f8e708202d7a0275e2ede8591a1030895f755e8497ccdb7e4a044cbc38706c4608ab527ac6bc8f30f936af06041453034e917f7d27439516", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fcf721aa91bec88e971672cb46909df4bffe1bb011f527003ca79cf59c522fe36dd74680bf9930eb2bc01dfab57457408e6facd864f48c94f2a11569bafd8649", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/233e5d2d82bd534448b9938517c8c01f528dc1ec8b3231c71c6c805362842278076c06acdfef33016c83d26601a95fc9228241fc029810bb476631665d4717a7"} build_url:https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011169 build_url: 'https://queue.taskcluster.net/v1/task/USo4liIRTnO7Sp0RGDn72Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a8e5df03acd6c0d874bab554ef0c6e8fad77bfd9aa592fa483bb58f843c6596f37fc1703c23d84ee4f6577fe0d5c38736f65d11f18725d1a61c77e374d968a0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a92c5a8b31cf21e4f8e708202d7a0275e2ede8591a1030895f755e8497ccdb7e4a044cbc38706c4608ab527ac6bc8f30f936af06041453034e917f7d27439516", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fcf721aa91bec88e971672cb46909df4bffe1bb011f527003ca79cf59c522fe36dd74680bf9930eb2bc01dfab57457408e6facd864f48c94f2a11569bafd8649", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/233e5d2d82bd534448b9938517c8c01f528dc1ec8b3231c71c6c805362842278076c06acdfef33016c83d26601a95fc9228241fc029810bb476631665d4717a7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 02:53:11.549411) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:53:11.549708) ========= 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.NE4UA7bLw6/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.clbVNB8od4/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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.005295 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:53:11.598221) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 02:53:11.598572) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 02:53:11.598935) ========= ========= Total master_lag: 0.27 =========