builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0177 starttime: 1490613472.42 results: success (0) buildid: 20170327030203 builduid: 770911de535645b4b92b4b26645d7cc4 revision: cc53710589fb500610495da5258b7b9221edf681 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 04:17:52.419385) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 04:17:52.419825) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 04:17:52.420428) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 04:17:52.447804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:17:52.448560) ========= 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.2p3scKLJDZ/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.Vt2zdjYSIw/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-27 04:17:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.2M=0.001s 2017-03-27 04:17:52 (13.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109672 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:17:52.584664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:17:52.585075) ========= 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.2p3scKLJDZ/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.Vt2zdjYSIw/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.028428 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:17:52.636592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 04:17:52.637118) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cc53710589fb500610495da5258b7b9221edf681 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cc53710589fb500610495da5258b7b9221edf681 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2p3scKLJDZ/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.Vt2zdjYSIw/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-27 04:17:52,720 truncating revision to first 12 chars 2017-03-27 04:17:52,721 Setting DEBUG logging. 2017-03-27 04:17:52,721 attempt 1/10 2017-03-27 04:17:52,721 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cc53710589fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-27 04:17:53,570 unpacking tar archive at: mozilla-central-cc53710589fb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.120788 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 04:17:53.781987) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 04:17:53.782344) ========= script_repo_revision: cc53710589fb500610495da5258b7b9221edf681 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 04:17:53.782759) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 04:17:53.783034) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 04:17:53.802732) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2017-03-27 04:17:53.803131) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2p3scKLJDZ/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.Vt2zdjYSIw/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:17:53 INFO - MultiFileLogger online at 20170327 04:17:53 in /builds/slave/test 04:17:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:17:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:17:53 INFO - {'append_to_log': False, 04:17:53 INFO - 'base_work_dir': '/builds/slave/test', 04:17:53 INFO - 'blob_upload_branch': 'Firefox', 04:17:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:17:53 INFO - 'branch': 'Firefox', 04:17:53 INFO - 'buildbot_json_path': 'buildprops.json', 04:17:53 INFO - 'config_files': ('talos/mac_config.py',), 04:17:53 INFO - 'default_actions': ('clobber', 04:17:53 INFO - 'read-buildbot-config', 04:17:53 INFO - 'download-and-extract', 04:17:53 INFO - 'populate-webroot', 04:17:53 INFO - 'create-virtualenv', 04:17:53 INFO - 'install', 04:17:53 INFO - 'run-tests'), 04:17:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:17:53 INFO - 'download_minidump_stackwalk': True, 04:17:53 INFO - 'download_symbols': 'ondemand', 04:17:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:17:53 INFO - 'tooltool.py': '/tools/tooltool.py', 04:17:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:17:53 INFO - '/tools/misc-python/virtualenv.py')}, 04:17:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:17:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:17:53 INFO - 'gecko_profile': False, 04:17:53 INFO - 'gecko_profile_interval': 0, 04:17:53 INFO - 'installer_path': 'installer.exe', 04:17:53 INFO - 'log_level': 'info', 04:17:53 INFO - 'log_name': 'talos', 04:17:53 INFO - 'log_to_console': True, 04:17:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:17:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:17:53 INFO - 'opt_config_files': (), 04:17:53 INFO - 'pip_index': False, 04:17:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:17:53 INFO - 'cmd': ('bash', 04:17:53 INFO - '-c', 04:17:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:17:53 INFO - 'enabled': True, 04:17:53 INFO - 'halt_on_failure': False, 04:17:53 INFO - 'name': 'check_screen_resolution'},), 04:17:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:17:53 INFO - 'cmd': ('bash', 04:17:53 INFO - '-c', 04:17:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:17:53 INFO - 'enabled': True, 04:17:53 INFO - 'halt_on_failure': False, 04:17:53 INFO - 'name': 'check_screen_resolution'},), 04:17:53 INFO - 'run_cmd_checks_enabled': True, 04:17:53 INFO - 'suite': 'dromaeojs-e10s', 04:17:53 INFO - 'system_bits': '32', 04:17:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:17:53 INFO - 'title': 't-yosemite-r7-0177', 04:17:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:17:53 INFO - 'use_talos_json': True, 04:17:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:17:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:17:53 INFO - 'work_dir': 'build'} 04:17:53 INFO - [mozharness: 2017-03-27 11:17:53.995786Z] Running clobber step. 04:17:53 INFO - Running pre-action listener: _resource_record_pre_action 04:17:53 INFO - Running main action method: clobber 04:17:53 INFO - rmtree: /builds/slave/test/build 04:17:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:17:56 INFO - Running post-action listener: _resource_record_post_action 04:17:56 INFO - [mozharness: 2017-03-27 11:17:56.489538Z] Finished clobber step (success) 04:17:56 INFO - [mozharness: 2017-03-27 11:17:56.489795Z] Running read-buildbot-config step. 04:17:56 INFO - Running pre-action listener: _resource_record_pre_action 04:17:56 INFO - Running main action method: read_buildbot_config 04:17:56 INFO - Using buildbot properties: 04:17:56 INFO - { 04:17:56 INFO - "project": "", 04:17:56 INFO - "product": "firefox", 04:17:56 INFO - "script_repo_revision": "production", 04:17:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:17:56 INFO - "repository": "", 04:17:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:17:56 INFO - "buildid": "20170327030203", 04:17:56 INFO - "stage_platform": "macosx64", 04:17:56 INFO - "basedir": "/builds/slave/test", 04:17:56 INFO - "nightly_build": "True", 04:17:56 INFO - "buildnumber": 25, 04:17:56 INFO - "slavename": "t-yosemite-r7-0177", 04:17:56 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 04:17:56 INFO - "platform": "yosemite_r7", 04:17:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:17:56 INFO - "branch": "mozilla-central", 04:17:56 INFO - "repo_path": "mozilla-central", 04:17:56 INFO - "revision": "cc53710589fb500610495da5258b7b9221edf681", 04:17:56 INFO - "pgo_build": "False", 04:17:56 INFO - "builduid": "770911de535645b4b92b4b26645d7cc4", 04:17:56 INFO - "slavebuilddir": "test" 04:17:56 INFO - } 04:17:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:17:56 INFO - Running post-action listener: _resource_record_post_action 04:17:56 INFO - [mozharness: 2017-03-27 11:17:56.495280Z] Finished read-buildbot-config step (success) 04:17:56 INFO - [mozharness: 2017-03-27 11:17:56.495523Z] Running download-and-extract step. 04:17:56 INFO - Running pre-action listener: _resource_record_pre_action 04:17:56 INFO - Running main action method: download_and_extract 04:17:56 INFO - mkdir: /builds/slave/test/build/tests 04:17:56 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')]} 04:17:56 INFO - trying https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:17:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:17:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:17:57 INFO - Downloaded 1325 bytes. 04:17:57 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:17:57 INFO - Using the following test package requirements: 04:17:57 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:17:57 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:17:57 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:17:57 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:17:57 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:17:57 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:17:57 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:17:57 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:17:57 INFO - u'jsshell-mac.zip'], 04:17:57 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:17:57 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:17:57 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:17:57 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:17:57 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:17:57 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:17:57 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:17:57 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:17:57 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:17:57 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:17:57 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:17:57 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:17:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:17:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:17:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:17:59 INFO - Expected file size: 52413476 04:17:59 INFO - Obtained file size: 52413476 04:18:15 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:18:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:18:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:18:15 INFO - Fetch https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:18:17 INFO - Expected file size: 52413476 04:18:17 INFO - Obtained file size: 52413476 04:18:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:18:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:18:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:18:34 INFO - Expected file size: 14404171 04:18:34 INFO - Obtained file size: 14404171 04:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:34 INFO - trying https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:18:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:18:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:18:36 INFO - Downloaded 75669010 bytes. 04:18:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:18:36 INFO - mkdir: /builds/slave/test/properties 04:18:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:18:36 INFO - Writing to file /builds/slave/test/properties/build_url 04:18:36 INFO - Contents: 04:18:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:18:37 INFO - Running post-action listener: _resource_record_post_action 04:18:37 INFO - Running post-action listener: set_extra_try_arguments 04:18:37 INFO - [mozharness: 2017-03-27 11:18:37.181386Z] Finished download-and-extract step (success) 04:18:37 INFO - [mozharness: 2017-03-27 11:18:37.181540Z] Running populate-webroot step. 04:18:37 INFO - Running pre-action listener: _resource_record_pre_action 04:18:37 INFO - Running main action method: populate_webroot 04:18:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:18:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:18:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:18:37 INFO - '--tppagecycles', 04:18:37 INFO - '7'], 04:18:37 INFO - 'tests': ['tsvgm']}}, 04:18:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:18:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:18:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:18:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:18:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:18:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:18:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:18:37 INFO - 'talos_options': ['--disable-e10s'], 04:18:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:18:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:18:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:18:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:18:37 INFO - 'talos_options': ['--disable-e10s'], 04:18:37 INFO - 'tests': ['damp', 'tps']}, 04:18:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:18:37 INFO - 'tests': ['damp', 'tps']}, 04:18:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:18:37 INFO - 'tests': ['dromaeo_dom']}, 04:18:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:18:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:18:37 INFO - 'tests': ['basic_compositor_video']}, 04:18:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:18:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:18:37 INFO - 'tests': ['a11yr', 04:18:37 INFO - 'ts_paint', 04:18:37 INFO - 'tpaint', 04:18:37 INFO - 'sessionrestore', 04:18:37 INFO - 'sessionrestore_no_auto_restore', 04:18:37 INFO - 'tabpaint']}, 04:18:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:18:37 INFO - 'ts_paint', 04:18:37 INFO - 'tpaint', 04:18:37 INFO - 'sessionrestore', 04:18:37 INFO - 'sessionrestore_no_auto_restore', 04:18:37 INFO - 'tabpaint']}, 04:18:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:18:37 INFO - 'ts_paint', 04:18:37 INFO - 'tpaint', 04:18:37 INFO - 'sessionrestore', 04:18:37 INFO - 'sessionrestore_no_auto_restore', 04:18:37 INFO - 'tabpaint']}, 04:18:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:18:37 INFO - 'ts_paint', 04:18:37 INFO - 'tpaint', 04:18:37 INFO - 'sessionrestore', 04:18:37 INFO - 'sessionrestore_no_auto_restore', 04:18:37 INFO - 'tabpaint']}, 04:18:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:18:37 INFO - 'tests': ['a11yr', 04:18:37 INFO - 'ts_paint', 04:18:37 INFO - 'tpaint', 04:18:37 INFO - 'sessionrestore', 04:18:37 INFO - 'sessionrestore_no_auto_restore', 04:18:37 INFO - 'tabpaint']}, 04:18:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:18:37 INFO - 'tests': ['a11yr', 04:18:37 INFO - 'ts_paint', 04:18:37 INFO - 'tpaint', 04:18:37 INFO - 'sessionrestore', 04:18:37 INFO - 'sessionrestore_no_auto_restore', 04:18:37 INFO - 'tabpaint']}, 04:18:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:18:37 INFO - 'tests': ['tsvgx', 04:18:37 INFO - 'tsvgr_opacity', 04:18:37 INFO - 'tart', 04:18:37 INFO - 'tscrollx', 04:18:37 INFO - 'cart', 04:18:37 INFO - 'tsvg_static']}, 04:18:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:18:37 INFO - 'tsvgr_opacity', 04:18:37 INFO - 'tart', 04:18:37 INFO - 'tscrollx', 04:18:37 INFO - 'cart', 04:18:37 INFO - 'tsvg_static']}, 04:18:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:18:37 INFO - 'talos_options': ['--disable-e10s'], 04:18:37 INFO - 'tests': ['tp5o']}, 04:18:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:18:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:18:37 INFO - 'talos_options': ['--disable-e10s', 04:18:37 INFO - '--xperf_path', 04:18:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:18:37 INFO - 'tests': ['tp5n']}, 04:18:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:18:37 INFO - 'talos_options': ['--xperf_path', 04:18:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:18:37 INFO - 'tests': ['tp5n']}}, 04:18:37 INFO - 'talos.zip': {'path': '', 04:18:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:18:37 INFO - Running post-action listener: _resource_record_post_action 04:18:37 INFO - [mozharness: 2017-03-27 11:18:37.200123Z] Finished populate-webroot step (success) 04:18:37 INFO - [mozharness: 2017-03-27 11:18:37.200203Z] Running create-virtualenv step. 04:18:37 INFO - Running pre-action listener: _resource_record_pre_action 04:18:37 INFO - Running main action method: create_virtualenv 04:18:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:18:37 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 04:18:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:18:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:18:37 INFO - Using real prefix '/tools/python27' 04:18:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:18:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:18:40 INFO - Installing pip.................done. 04:18:40 INFO - Return code: 0 04:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:18:41 INFO - Reading from file tmpfile_stdout 04:18:41 INFO - Output received: 04:18:41 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) 04:18:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:41 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 0x102fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a348fb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dbad30>, '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 0x102ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dafbe8>, '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.2p3scKLJDZ/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.Vt2zdjYSIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:18:41 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 04:18:41 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 04:18:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2p3scKLJDZ/Render', 04:18:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:41 INFO - 'HOME': '/Users/cltbld', 04:18:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:41 INFO - 'LOGNAME': 'cltbld', 04:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:41 INFO - 'MOZ_NO_REMOTE': '1', 04:18:41 INFO - 'NO_EM_RESTART': '1', 04:18:41 INFO - 'PAGER': '/bin/cat', 04:18:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:41 INFO - 'PWD': '/builds/slave/test', 04:18:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:41 INFO - 'SHELL': '/bin/bash', 04:18:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vt2zdjYSIw/Listeners', 04:18:41 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:18:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:41 INFO - 'USER': 'cltbld', 04:18:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:41 INFO - 'XPC_FLAGS': '0x0', 04:18:41 INFO - 'XPC_SERVICE_NAME': '0', 04:18:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:41 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 04:18:41 INFO - Cleaning up... 04:18:41 INFO - Return code: 0 04:18:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:41 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 0x102fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a348fb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dbad30>, '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 0x102ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dafbe8>, '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.2p3scKLJDZ/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.Vt2zdjYSIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:18:41 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 04:18:41 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 04:18:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2p3scKLJDZ/Render', 04:18:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:41 INFO - 'HOME': '/Users/cltbld', 04:18:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:41 INFO - 'LOGNAME': 'cltbld', 04:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:41 INFO - 'MOZ_NO_REMOTE': '1', 04:18:41 INFO - 'NO_EM_RESTART': '1', 04:18:41 INFO - 'PAGER': '/bin/cat', 04:18:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:41 INFO - 'PWD': '/builds/slave/test', 04:18:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:41 INFO - 'SHELL': '/bin/bash', 04:18:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vt2zdjYSIw/Listeners', 04:18:41 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:18:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:41 INFO - 'USER': 'cltbld', 04:18:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:41 INFO - 'XPC_FLAGS': '0x0', 04:18:41 INFO - 'XPC_SERVICE_NAME': '0', 04:18:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:41 INFO - Downloading/unpacking psutil>=3.1.1 04:18:41 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 04:18:41 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 04:18:41 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 04:18:41 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 04:18:41 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 04:18:41 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 04:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:18:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:18:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:18:45 INFO - Installing collected packages: psutil 04:18:45 INFO - Running setup.py install for psutil 04:18:45 INFO - building 'psutil._psutil_osx' extension 04:18:45 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 04:18:45 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 04:18:45 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 04:18:46 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 04:18:46 INFO - building 'psutil._psutil_posix' extension 04:18:46 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 04:18:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:18:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:18:46 INFO - ^ 04:18:46 INFO - 1 warning generated. 04:18:46 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 04:18:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:18:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:18:46 INFO - Successfully installed psutil 04:18:46 INFO - Cleaning up... 04:18:46 INFO - Return code: 0 04:18:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a348fb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dbad30>, '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 0x102ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dafbe8>, '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.2p3scKLJDZ/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.Vt2zdjYSIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:18:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:18:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2p3scKLJDZ/Render', 04:18:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:46 INFO - 'HOME': '/Users/cltbld', 04:18:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:46 INFO - 'LOGNAME': 'cltbld', 04:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:46 INFO - 'MOZ_NO_REMOTE': '1', 04:18:46 INFO - 'NO_EM_RESTART': '1', 04:18:46 INFO - 'PAGER': '/bin/cat', 04:18:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:46 INFO - 'PWD': '/builds/slave/test', 04:18:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:46 INFO - 'SHELL': '/bin/bash', 04:18:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vt2zdjYSIw/Listeners', 04:18:46 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:18:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:46 INFO - 'USER': 'cltbld', 04:18:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:46 INFO - 'XPC_FLAGS': '0x0', 04:18:46 INFO - 'XPC_SERVICE_NAME': '0', 04:18:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:18:49 INFO - Installing collected packages: mozsystemmonitor 04:18:49 INFO - Running setup.py install for mozsystemmonitor 04:18:49 INFO - Successfully installed mozsystemmonitor 04:18:49 INFO - Cleaning up... 04:18:49 INFO - Return code: 0 04:18:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:18:49 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')]} 04:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:50 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')]} 04:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:50 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 0x102fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a348fb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dbad30>, '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 0x102ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dafbe8>, '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.2p3scKLJDZ/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.Vt2zdjYSIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:18:50 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 04:18:50 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 04:18:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2p3scKLJDZ/Render', 04:18:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:50 INFO - 'HOME': '/Users/cltbld', 04:18:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:50 INFO - 'LOGNAME': 'cltbld', 04:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:50 INFO - 'MOZ_NO_REMOTE': '1', 04:18:50 INFO - 'NO_EM_RESTART': '1', 04:18:50 INFO - 'PAGER': '/bin/cat', 04:18:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:50 INFO - 'PWD': '/builds/slave/test', 04:18:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:50 INFO - 'SHELL': '/bin/bash', 04:18:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vt2zdjYSIw/Listeners', 04:18:50 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:18:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:50 INFO - 'USER': 'cltbld', 04:18:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:50 INFO - 'XPC_FLAGS': '0x0', 04:18:50 INFO - 'XPC_SERVICE_NAME': '0', 04:18:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:50 INFO - Downloading/unpacking jsonschema==2.5.1 04:18:50 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 04:18:50 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 04:18:50 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 04:18:50 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 04:18:50 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 04:18:50 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 04:18:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:18:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:18:53 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 04:18:53 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 04:18:53 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 04:18:53 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 04:18:53 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 04:18:53 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 04:18:54 INFO - Downloading functools32-3.2.3-2.tar.gz 04:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:18:54 INFO - warning: no files found matching '*.txt' 04:18:54 INFO - no previously-included directories found matching 'build' 04:18:54 INFO - no previously-included directories found matching 'dist' 04:18:54 INFO - no previously-included directories found matching '.git*' 04:18:54 INFO - Installing collected packages: jsonschema, functools32 04:18:54 INFO - Running setup.py install for functools32 04:18:54 INFO - warning: no files found matching '*.txt' 04:18:54 INFO - no previously-included directories found matching 'build' 04:18:54 INFO - no previously-included directories found matching 'dist' 04:18:54 INFO - no previously-included directories found matching '.git*' 04:18:54 INFO - Successfully installed jsonschema functools32 04:18:54 INFO - Cleaning up... 04:18:54 INFO - Return code: 0 04:18:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:18: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')]} 04:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18: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')]} 04:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a348fb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dbad30>, '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 0x102ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dafbe8>, '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.2p3scKLJDZ/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.Vt2zdjYSIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:18:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2p3scKLJDZ/Render', 04:18:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:54 INFO - 'HOME': '/Users/cltbld', 04:18:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:54 INFO - 'LOGNAME': 'cltbld', 04:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:54 INFO - 'MOZ_NO_REMOTE': '1', 04:18:54 INFO - 'NO_EM_RESTART': '1', 04:18:54 INFO - 'PAGER': '/bin/cat', 04:18:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:54 INFO - 'PWD': '/builds/slave/test', 04:18:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:54 INFO - 'SHELL': '/bin/bash', 04:18:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vt2zdjYSIw/Listeners', 04:18:54 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:18:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:54 INFO - 'USER': 'cltbld', 04:18:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:54 INFO - 'XPC_FLAGS': '0x0', 04:18:54 INFO - 'XPC_SERVICE_NAME': '0', 04:18:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:18:54 INFO - Cleaning up... 04:18:54 INFO - Return code: 0 04:18:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:18: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')]} 04:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18: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')]} 04:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a348fb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dbad30>, '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 0x102ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dafbe8>, '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.2p3scKLJDZ/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.Vt2zdjYSIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:18:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2p3scKLJDZ/Render', 04:18:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:54 INFO - 'HOME': '/Users/cltbld', 04:18:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:54 INFO - 'LOGNAME': 'cltbld', 04:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:54 INFO - 'MOZ_NO_REMOTE': '1', 04:18:54 INFO - 'NO_EM_RESTART': '1', 04:18:54 INFO - 'PAGER': '/bin/cat', 04:18:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:54 INFO - 'PWD': '/builds/slave/test', 04:18:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:54 INFO - 'SHELL': '/bin/bash', 04:18:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vt2zdjYSIw/Listeners', 04:18:54 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:18:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:54 INFO - 'USER': 'cltbld', 04:18:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:54 INFO - 'XPC_FLAGS': '0x0', 04:18:54 INFO - 'XPC_SERVICE_NAME': '0', 04:18:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:55 INFO - Downloading/unpacking blobuploader==1.2.4 04:18:55 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 04:18:55 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 04:18:55 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 04:18:55 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 04:18:55 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 04:18:55 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 04:18:57 INFO - Downloading blobuploader-1.2.4.tar.gz 04:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:18:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:18:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:59 INFO - Downloading docopt-0.6.1.tar.gz 04:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:18:59 INFO - Installing collected packages: blobuploader, requests, docopt 04:18:59 INFO - Running setup.py install for blobuploader 04:18:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:18:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:18:59 INFO - Running setup.py install for requests 04:18:59 INFO - Running setup.py install for docopt 04:19:00 INFO - Successfully installed blobuploader requests docopt 04:19:00 INFO - Cleaning up... 04:19:00 INFO - Return code: 0 04:19:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:00 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 0x102fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a348fb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dbad30>, '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 0x102ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dafbe8>, '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.2p3scKLJDZ/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.Vt2zdjYSIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:19:00 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 04:19:00 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 04:19:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2p3scKLJDZ/Render', 04:19:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:19:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:19:00 INFO - 'HOME': '/Users/cltbld', 04:19:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:19:00 INFO - 'LOGNAME': 'cltbld', 04:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:00 INFO - 'MOZ_NO_REMOTE': '1', 04:19:00 INFO - 'NO_EM_RESTART': '1', 04:19:00 INFO - 'PAGER': '/bin/cat', 04:19:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:00 INFO - 'PWD': '/builds/slave/test', 04:19:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:19:00 INFO - 'SHELL': '/bin/bash', 04:19:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vt2zdjYSIw/Listeners', 04:19:00 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:19:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:19:00 INFO - 'USER': 'cltbld', 04:19:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:19:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:00 INFO - 'XPC_FLAGS': '0x0', 04:19:00 INFO - 'XPC_SERVICE_NAME': '0', 04:19:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:19:00 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-aDm9yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:19:00 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-MYKbGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:19:00 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-p5v9Uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:19:00 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-8Lka61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:19:00 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-HKLKDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:19:00 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-QWG_Ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:19:00 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-rB9F3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:19:01 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-JKRiYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:19:01 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-vQkJQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:19:01 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-UGTt9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:19:01 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-enyFgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:19:01 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-sfb0vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:19:01 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-o3B8DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:19:01 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-r_Qga4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:01 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-_T3VRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:19:01 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-i_3fb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:19:02 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-rb3bMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:19:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:19:02 INFO - Running setup.py install for manifestparser 04:19:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:19:02 INFO - Running setup.py install for mozcrash 04:19:02 INFO - Running setup.py install for mozdebug 04:19:02 INFO - Running setup.py install for mozdevice 04:19:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:19:02 INFO - Running setup.py install for mozfile 04:19:02 INFO - Running setup.py install for mozhttpd 04:19:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:19:02 INFO - Running setup.py install for mozinfo 04:19:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:19:03 INFO - Running setup.py install for mozInstall 04:19:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:19:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:19:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:19:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:19:03 INFO - Running setup.py install for mozleak 04:19:03 INFO - Running setup.py install for mozlog 04:19:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:19:03 INFO - Running setup.py install for moznetwork 04:19:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:19:03 INFO - Running setup.py install for mozprocess 04:19:03 INFO - Running setup.py install for mozprofile 04:19:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:19:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:19:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:19:04 INFO - Running setup.py install for mozrunner 04:19:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:19:04 INFO - Running setup.py install for mozscreenshot 04:19:04 INFO - Running setup.py install for moztest 04:19:04 INFO - Running setup.py install for mozversion 04:19:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:19:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:19:04 INFO - Cleaning up... 04:19:04 INFO - Return code: 0 04:19:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:19: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')]} 04:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19: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')]} 04:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:04 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 0x102fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a348fb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dbad30>, '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 0x102ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dafbe8>, '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.2p3scKLJDZ/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.Vt2zdjYSIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:19:04 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 04:19:04 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 04:19:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2p3scKLJDZ/Render', 04:19:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:19:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:19:04 INFO - 'HOME': '/Users/cltbld', 04:19:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:19:04 INFO - 'LOGNAME': 'cltbld', 04:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:04 INFO - 'MOZ_NO_REMOTE': '1', 04:19:04 INFO - 'NO_EM_RESTART': '1', 04:19:04 INFO - 'PAGER': '/bin/cat', 04:19:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:04 INFO - 'PWD': '/builds/slave/test', 04:19:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:19:04 INFO - 'SHELL': '/bin/bash', 04:19:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vt2zdjYSIw/Listeners', 04:19:04 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:19:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:19:04 INFO - 'USER': 'cltbld', 04:19:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:19:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:04 INFO - 'XPC_FLAGS': '0x0', 04:19:04 INFO - 'XPC_SERVICE_NAME': '0', 04:19:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:19:04 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-eisei1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:19:05 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)) 04:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:19:05 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-jlXONf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:19:05 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)) 04:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:19:05 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-dwnz_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:19:05 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)) 04:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:19:05 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-awm4eH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:19:05 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)) 04:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:19:05 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-3Jt3JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:19:05 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)) 04:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:19:05 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-ACmB55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:19:05 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)) 04:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:19:05 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Bc9K34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:19:05 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)) 04:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:19:05 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-i1O5SM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:19:05 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)) 04:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:19:05 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-n3rcgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:19:05 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)) 04:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:19:05 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-_y923J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:19:06 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)) 04:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:19:06 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-DRRKFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:19:06 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)) 04:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:19:06 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-hozp_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:19:06 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)) 04:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:19:06 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-6ZqoXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:19:06 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)) 04:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:19:06 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-gD07bG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:19:06 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)) 04:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:06 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Yawnrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:06 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)) 04:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:19:06 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-U2J3oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:19:06 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)) 04:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:19:06 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-oTjm99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:19:06 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)) 04:19:06 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)) 04:19:06 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)) 04:19:06 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)) 04:19:06 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)) 04:19:06 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)) 04:19:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:19:06 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 04:19:06 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 04:19:06 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 04:19:06 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 04:19:06 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 04:19:06 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 04:19:09 INFO - Downloading blessings-1.6.tar.gz 04:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:19:09 INFO - Installing collected packages: blessings 04:19:09 INFO - Running setup.py install for blessings 04:19:09 INFO - Successfully installed blessings 04:19:09 INFO - Cleaning up... 04:19:09 INFO - Return code: 0 04:19:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:19:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:19:10 INFO - Reading from file tmpfile_stdout 04:19:10 INFO - Current package versions: 04:19:10 INFO - blessings == 1.6 04:19:10 INFO - blobuploader == 1.2.4 04:19:10 INFO - docopt == 0.6.1 04:19:10 INFO - functools32 == 3.2.3-2 04:19:10 INFO - jsonschema == 2.5.1 04:19:10 INFO - manifestparser == 1.1 04:19:10 INFO - mozInstall == 1.12 04:19:10 INFO - mozcrash == 1.0 04:19:10 INFO - mozdebug == 0.1 04:19:10 INFO - mozdevice == 0.49 04:19:10 INFO - mozfile == 1.2 04:19:10 INFO - mozhttpd == 0.7 04:19:10 INFO - mozinfo == 0.9 04:19:10 INFO - mozleak == 0.1 04:19:10 INFO - mozlog == 3.4 04:19:10 INFO - moznetwork == 0.27 04:19:10 INFO - mozprocess == 0.25 04:19:10 INFO - mozprofile == 0.28 04:19:10 INFO - mozrunner == 6.13 04:19:10 INFO - mozscreenshot == 0.1 04:19:10 INFO - mozsystemmonitor == 0.3 04:19:10 INFO - moztest == 0.8 04:19:10 INFO - mozversion == 1.4 04:19:10 INFO - psutil == 3.1.1 04:19:10 INFO - requests == 1.2.3 04:19:10 INFO - wsgiref == 0.1.2 04:19:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:19:10 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')]} 04:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:10 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')]} 04:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:10 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 0x102fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a348fb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dbad30>, '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 0x102ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dafbe8>, '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.2p3scKLJDZ/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.Vt2zdjYSIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:19:10 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 04:19:10 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 04:19:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2p3scKLJDZ/Render', 04:19:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:19:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:19:10 INFO - 'HOME': '/Users/cltbld', 04:19:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:19:10 INFO - 'LOGNAME': 'cltbld', 04:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:10 INFO - 'MOZ_NO_REMOTE': '1', 04:19:10 INFO - 'NO_EM_RESTART': '1', 04:19:10 INFO - 'PAGER': '/bin/cat', 04:19:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:10 INFO - 'PWD': '/builds/slave/test', 04:19:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:19:10 INFO - 'SHELL': '/bin/bash', 04:19:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vt2zdjYSIw/Listeners', 04:19:10 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:19:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:19:10 INFO - 'USER': 'cltbld', 04:19:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:19:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:10 INFO - 'XPC_FLAGS': '0x0', 04:19:10 INFO - 'XPC_SERVICE_NAME': '0', 04:19:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:10 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)) 04:19:10 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)) 04:19:10 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)) 04:19:10 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)) 04:19:10 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)) 04:19:10 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)) 04:19:10 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)) 04:19:10 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)) 04:19:10 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)) 04:19:10 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)) 04:19:10 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)) 04:19:10 INFO - Cleaning up... 04:19:10 INFO - Return code: 0 04:19:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:19:10 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')]} 04:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:10 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')]} 04:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:10 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 0x102fdcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fdf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a348fb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dbad30>, '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 0x102ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dafbe8>, '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.2p3scKLJDZ/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.Vt2zdjYSIw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:19:10 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 04:19:10 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 04:19:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2p3scKLJDZ/Render', 04:19:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:19:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:19:10 INFO - 'HOME': '/Users/cltbld', 04:19:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:19:10 INFO - 'LOGNAME': 'cltbld', 04:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:10 INFO - 'MOZ_NO_REMOTE': '1', 04:19:10 INFO - 'NO_EM_RESTART': '1', 04:19:10 INFO - 'PAGER': '/bin/cat', 04:19:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:10 INFO - 'PWD': '/builds/slave/test', 04:19:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:19:10 INFO - 'SHELL': '/bin/bash', 04:19:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vt2zdjYSIw/Listeners', 04:19:10 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:19:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:19:10 INFO - 'USER': 'cltbld', 04:19:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:19:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:10 INFO - 'XPC_FLAGS': '0x0', 04:19:10 INFO - 'XPC_SERVICE_NAME': '0', 04:19:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:19:10 INFO - Cleaning up... 04:19:10 INFO - Return code: 0 04:19:10 INFO - Running post-action listener: _resource_record_post_action 04:19:10 INFO - Running post-action listener: _start_resource_monitoring 04:19:10 INFO - Starting resource monitoring. 04:19:10 INFO - [mozharness: 2017-03-27 11:19:10.743749Z] Finished create-virtualenv step (success) 04:19:10 INFO - [mozharness: 2017-03-27 11:19:10.744691Z] Running install step. 04:19:10 INFO - Running pre-action listener: _resource_record_pre_action 04:19:10 INFO - Running main action method: install 04:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:19:11 INFO - Reading from file tmpfile_stdout 04:19:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:19:11 INFO - Reading from file tmpfile_stdout 04:19:11 INFO - Output received: 04:19:11 INFO - Usage: mozinstall [options] installer 04:19:11 INFO - Options: 04:19:11 INFO - -h, --help show this help message and exit 04:19:11 INFO - -d DEST, --destination=DEST 04:19:11 INFO - Directory to install application into. [default: 04:19:11 INFO - "/builds/slave/test"] 04:19:11 INFO - --app=APP Application being installed. [default: firefox] 04:19:11 INFO - mkdir: /builds/slave/test/build/application 04:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:19:31 INFO - Reading from file tmpfile_stdout 04:19:31 INFO - Output received: 04:19:31 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:19:31 INFO - Running post-action listener: _resource_record_post_action 04:19:31 INFO - [mozharness: 2017-03-27 11:19:31.777952Z] Finished install step (success) 04:19:31 INFO - [mozharness: 2017-03-27 11:19:31.778119Z] Running run-tests step. 04:19:31 INFO - Running pre-action listener: _resource_record_pre_action 04:19:31 INFO - Running main action method: run_tests 04:19:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:19:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:19:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:19:31 INFO - 2017-03-27 04:19:31.792 screenresolution[1628:7465] starting screenresolution argv=screenresolution get 04:19:31 INFO - 2017-03-27 04:19:31.794 screenresolution[1628:7465] Display 0: 1600x1200x32@60 04:19:31 INFO - 2017-03-27 04:19:31.800 screenresolution[1629:7467] starting screenresolution argv=screenresolution list 04:19:31 INFO - Available Modes on Display 0 04:19:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:19:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:19:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:19:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:19:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:19:32 INFO - Intel Iris: 04:19:32 INFO - Chipset Model: Intel Iris 04:19:32 INFO - Type: GPU 04:19:32 INFO - Bus: Built-In 04:19:32 INFO - VRAM (Dynamic, Max): 1536 MB 04:19:32 INFO - Vendor: Intel (0x8086) 04:19:32 INFO - Device ID: 0x0a2e 04:19:32 INFO - Revision ID: 0x0009 04:19:32 INFO - Displays: 04:19:32 INFO - Display: 04:19:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:19:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:19:32 INFO - Display Serial Number: 1600x1200 60 04:19:32 INFO - Main Display: Yes 04:19:32 INFO - Mirror: Off 04:19:32 INFO - Online: Yes 04:19:32 INFO - Rotation: Supported 04:19:32 INFO - Return code: 0 04:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:19:32 INFO - Python 2.7.3 04:19:32 INFO - Return code: 0 04:19:32 INFO - grabbing minidump binary from tooltool 04:19: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')]} 04:19:32 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 0x102dbad30>, '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 0x102ce1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102dafbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:19:32 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 04:19:32 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 04:19:32 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 04:19:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:19:32 INFO - Return code: 0 04:19:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:19:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:19:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:19:32 INFO - ENV: RUST_BACKTRACE is now 1 04:19:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:19:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--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 04:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0177 --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 04:19:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2p3scKLJDZ/Render', 04:19:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:19:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:19:32 INFO - 'HOME': '/Users/cltbld', 04:19:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:19:32 INFO - 'LOGNAME': 'cltbld', 04:19:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:19:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:32 INFO - 'MOZ_NO_REMOTE': '1', 04:19:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:19:32 INFO - 'NO_EM_RESTART': '1', 04:19:32 INFO - 'PAGER': '/bin/cat', 04:19:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:32 INFO - 'PWD': '/builds/slave/test', 04:19:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:19:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:19:32 INFO - 'RUST_BACKTRACE': '1', 04:19:32 INFO - 'SHELL': '/bin/bash', 04:19:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vt2zdjYSIw/Listeners', 04:19:32 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:19:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:19:32 INFO - 'USER': 'cltbld', 04:19:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:19:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:32 INFO - 'XPC_FLAGS': '0x0', 04:19:32 INFO - 'XPC_SERVICE_NAME': '0', 04:19:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:19:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--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 04:19:32 INFO - mozversion application_buildid: 20170327030203 04:19:32 INFO - mozversion application_changeset: cc53710589fb500610495da5258b7b9221edf681 04:19:32 INFO - mozversion application_display_name: Nightly 04:19:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:19:32 INFO - mozversion application_name: Firefox 04:19:32 INFO - mozversion application_remotingname: firefox 04:19:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:19:32 INFO - mozversion application_vendor: Mozilla 04:19:32 INFO - mozversion application_version: 55.0a1 04:19:32 INFO - mozversion platform_buildid: 20170327030203 04:19:32 INFO - mozversion platform_changeset: cc53710589fb500610495da5258b7b9221edf681 04:19:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:19:32 INFO - mozversion platform_version: 55.0a1 04:19:32 INFO - using testdate: 1490613572 04:19:32 INFO - actual date: 1490613572 04:19:32 INFO - starting webserver on 'localhost:49242' 04:19:32 INFO - SUITE-START | Running 2 tests 04:19:32 INFO - TEST-START | dromaeo_css 04:19:32 INFO - operating with platform_type : mac_ 04:19:32 INFO - Initialising browser for dromaeo_css test... 04:19:32 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp9CC4UW/profile http://localhost:49242/getInfo.html) 04:19:35 INFO - PID 1639 | 2017-03-27 04:19:35.546 plugin-container[1641:7640] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 04:19:35 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:19:35 INFO - PID 1639 | 2017-03-27 04:19:35.547 plugin-container[1641:7640] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 04:19:35 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:19:35 INFO - PID 1639 | 2017-03-27 04:19:35.547 plugin-container[1641:7640] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:19:35 INFO - PID 1639 | __metrics Screen width/height:1600/1200 04:19:35 INFO - PID 1639 | colorDepth:24 04:19:35 INFO - PID 1639 | Browser inner width/height: 1024/689 04:19:35 INFO - PID 1639 | __metrics 04:19:35 ERROR - PID 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:19:35 ERROR - PID 1639 | 1490613575686 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < forceQuit@jar:file:///var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp9CC4UW/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp9CC4UW/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp9CC4UW/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp9CC4UW/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:19:36 INFO - TEST-INFO | 1639: exit 0 04:19:36 INFO - Browser initialized. 04:19:36 INFO - Running cycle 1/1 for dromaeo_css test... 04:19:36 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp9CC4UW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:38 INFO - PID 1643 | 2017-03-27 04:19:38.910 plugin-container[1644:7779] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 04:19:38 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:19:38 INFO - PID 1643 | 2017-03-27 04:19:38.910 plugin-container[1644:7779] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a17, name = 'com.apple.CFPasteboardClient' 04:19:38 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:19:38 INFO - PID 1643 | 2017-03-27 04:19:38.910 plugin-container[1644:7779] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:19:48 INFO - PID 1643 | RSS: Main: 227778560 04:19:48 INFO - PID 1643 | 04:22:52 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 04:22:54 INFO - PID 1643 | RSS: Main: 251174912 04:22:54 INFO - PID 1643 | 04:24:36 INFO - PID 1643 | ************************* 04:24:36 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 04:24:36 INFO - PID 1643 | 04:24:36 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:24:36 INFO - PID 1643 | Full stack: 04:24:36 INFO - PID 1643 | ************************* 04:24:36 INFO - PID 1643 | ************************* 04:24:36 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 04:24:36 INFO - PID 1643 | 04:24:36 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:24:36 INFO - PID 1643 | Full stack: 04:24:36 INFO - PID 1643 | ************************* 04:24:36 INFO - PID 1643 | ************************* 04:24:36 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 04:24:36 INFO - PID 1643 | 04:24:36 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:24:36 INFO - PID 1643 | Full stack: 04:24:36 INFO - PID 1643 | ************************* 04:24:36 INFO - PID 1643 | ************************* 04:24:36 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 04:24:36 INFO - PID 1643 | 04:24:36 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:24:36 INFO - PID 1643 | Full stack: 04:24:36 INFO - PID 1643 | ************************* 04:25:56 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 04:25:57 INFO - PID 1643 | RSS: Main: 258686976 04:25:57 INFO - PID 1643 | 04:28:59 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 04:29:00 INFO - PID 1643 | RSS: Main: 269774848 04:29:00 INFO - PID 1643 | 04:32:02 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 04:32:02 INFO - PID 1643 | RSS: Main: 262434816 04:32:02 INFO - PID 1643 | 04:35:05 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 04:35:06 INFO - PID 1643 | RSS: Main: 272642048 04:35:06 INFO - PID 1643 | 04:38:09 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 04:38:09 INFO - PID 1643 | RSS: Main: 266436608 04:38:09 INFO - PID 1643 | 04:38:09 INFO - PID 1643 | __start_tp_report 04:38:09 INFO - PID 1643 | _x_x_mozilla_page_load 04:38:09 INFO - PID 1643 | _x_x_mozilla_page_load_details 04:38:09 INFO - PID 1643 | |i|pagename|runs| 04:38:09 INFO - PID 1643 | |0;dojo.html;3026.8486575671222;3598.802065886376;3618.240169564391;3629.0383048492154;3652.945205821913;5416.241726158331;5689.203511508382;6201.59689620175;6220.284667263266;6245.968770156149;6188.947878860593;6219.657918814475;6232;6282.560220784536;6283.497320214383;4717.9292310615365;5695.060315048023;5825.708714564276;5850.853728656775;5919.940800591982;5718.799842005531;5771.82684519463;5904.88190236195;5905.616134951214;5955;4736.029114031615;5685.800996965087;5738.885222295572;5907.734151963172;5920.763169473216;5717.599768016241;5718.971405142947;5774.5091667208335;5781.364049954502;5834.008218602848;4182.2681030819485;5293.417724050351;5518.33779946405;5677.148427735831;5745.626534275259;5760.510356619692;6011.549133814981;6025.246844144482;6179.3202747697715;6296.716647750863;6613.702383392759;6740.460763138937;6808.7276508939585;6826.522143449961;6828.624425656587;5752.395998420147;6887.380135787803;6914.9654251728925;6932.341427564374;6932.6533673316135;6319.526035547352;6328.841778955517;6330.208723909512;6334.3032266450655;6343.555951083472;6672.366125218096;6816;6954.4436445084275;6971.51199416036;6995.090638217;5654.090399701158;6395.392437718409;6470.741170353227;6615.569987950767;6684.064231007663;6662.833429164213;6784.321567843176;6816.62508562024;6904.827379315457;6914.170299564084;6760.222574403908;6760.797176084725;6781.830454238683;6789.796306110825;6804.183497980274;6398;6584.407403333723;6603.471722262208;6716.5634233774645;6794.592324460548;5395.136778115482;5419.566434685215;5432.782688692487;5465;5471.534919531805;4789.161896668069;4808.326834243208;4831.202851529459;4841.1285968526;4841.95158048422;6159.599626024294;6168.784092556829;6312.179416675803;6322.620642761357;6337.33457986914;6835.077264569319;6836.555623884432;6862.4853136015;6879.2432832388395;6883.346082122191;6311.495080393649;6320.115183874262;6321.0834429008455;6323.30443651198;6324.810255692337;5865.384134665884;5979.880402392015;6088.786892458743;6096.756129754849;6149.446549810538;6769.255381908085;6944.062551555476;6968.5122041458635;6983.231844497;6995.300469952964;6904.758333458305;6913.308669133247;6914.204866440223;6915.377616014583;6917.204521480095;6881.208661003849;6922.550034247758;6970.930290697231;6995.685194166173;7000.929990700028;6523.608583484816;6575.980722987944;6724.092247546714;6772.796816095525;6777.728890844508;6844.178698556006;6905.930940690529;6910.723571057101;6918.204406493116;6963.059986901906;6353.936460635335;6446.484281257394;6547.672616369257;6556.082148499309;6694.330566943267;6443;6469.320721324381;6579.901301480578;6603.042558829039;6647.135872336566;6321.747130114744;6471.676416179078;6484.1894763154605;6487.967560162169;6498.642574658439;6575.178102737158;6619.238787539302;6626.701798418986;6628.83427914306;6647.567908085959;6247.5001999839;6292.150559674568;6385.96807015962;6440.35596440371;6442.742290308335 04:38:09 INFO - PID 1643 | |1;ext.html;723.6924307169452;794.7218473534263;817.2930415190862;1251;1263.8357013588231;35399.82300088499;36398;36409.81795091021;36432.81783591081;36452.90641280766;36498.8175059125;36520.26959460809;36678;36741.89774306768;36807.07982300444;7826.295633392993;7998.720044798433;8372.079071302152;8589.423173048091;8605.139486051406;8433.367497437686;8520.957395213016;8578.656853725843;8580;8580.013298470692;8483.490990540588;8488.108748581402;8580.914190858073;8582.14178582143;8583.871241931376;8477.194666506672;8519.190676885686;8562.01536823264;8627.870581941275;8636.956815215946;8251.927249457593;8415.28470080044;8419.579021048985;8472.703455379095;8479.364047696448;32215.83892080548;33766.6623333766;34444.82777586121;37892;37944;3022.9619232671025;3053.2672158681758;3056.7401770849506;3067.018554062701;3081.4145312390574;27396;27648.755805988578;27685.169444916686;27792.16623501298;27820.026299079636;2785.206216228365;2791.4696207720467;2794.5249307617755;2802.453521563296;2807.4244779820087;339576;341897.29051354586;343492.2825385882;343522.28238858894;344679;48636.27045594319;48762.756186218845;48792.7560362203;48870.75564622225;48924.75537622289;50055.74526165317;50328.24507632388;50331.74834125806;50434.74782626063;50498.24252636213;14079;14302.284885755671;14385.496507622183;14423.278836058154;14475.710485790436;11688.064954803594;11691.240069395462;11735.295882247092;11746.353950532632;11779;12847.421866016051;13122.803157952638;13301.73396532064;13337.866621333857;13448.924086073092;5875.4124587541755;5887.411258874164;5948.613340132878;5950.345461999176;5966.642001479839;949.3971328206638;961.0917682789697;986.452518852044;987.511181964932;997.9550920208608;22718.659220111713;22997;23851.880740596185;23965.28104156878;23972.801359931935;972.9270304727174;1027.9588816447408;1078.7788503356794;1127.881572434899;1128.328644456547;11858.466369013242;12078.57724979639;15250.084994900342;15769.132697701736;15917;474534;475862;477678;478270;478721;50680.23979640308;51024.489755101975;54211.72894135504;54855.177172342446;54990.350289491376;1127.6786115956913;1433.269032793283;1466.4061055272632;1471.2570152073135;1472.9631759206106;24104.035838566262;27727.30681732973;28109.156725297456;28373.43253134967;28896.7110328894;37890.8105459471;38228.80885595554;38245.04387390338;38393.80803095967;38443.615563844;488744;490523;490938.54530728544;491284;491443;32531.837340813145;33215.66784332126;33352.33295334031;33384.998450046536;33441.82953596613;40971;41409;41719.7914010428;41872.581274186865;41874;25450.109246176296;27957.64508259022;28040.439191215653;28931.566026509197;29555.408891821615;28495.857520712263;29429.027081343746;29626.555601666423;29660.703392965796;29668.851655741582;34054.14864628305;35072.47391289184;35191.64808351986;35241.64758352384;35255.11862203363;28763.568546472237;28801.71198288074;29557.408851822413;29924.401511970074;29940.550891737075;22301.553968920205;22745.772542275026;23446.882765586062;23698.05207791669;23854.403639909142 04:38:09 INFO - PID 1643 | |2;jquery.html;373.54241054707984;398.75078076202374;419.54060303967145;430.19553435076404;448.0546047839059;19885;20526.2815801447;21665.67501487477;22038.669419958715;22090.558188836214;22260.220892268775;22500.662490062623;23028.8848555757;23076.65385019222;23222.767772322273;5970.253718285204;6257.499400048008;6265.0915617235705;6276.968615156918;6277.5291853110975;5887.587868849182;6127.234095738033;6127.816165515042;6195.256569211679;6204.317525072239;5966.40335966402;6136.938630613704;6164.291106522763;6173.969130154343;6184.876302473948;6117.724702388381;6204.9689751551405;6221.5333849961435;6255.15555400022;6257.217847769029;5473.917891231635;5485.451454854522;5496.615236933416;5518.19986102013;5576.33084029915;26187.869060654575;26597.867010665017;26644.73355266442;26698.466030679472;27078;2049.0471930552217;2059.4336557446823;2070.523779530716;2077.5637116205617;2130.137294395772;15425.845741542666;16079.678406431924;16485.34058637665;16696.74954875678;16827.15864206797;1672.6069373697171;1704.463094125359;1711.0845697551874;1735.4186347573577;1777.3423833181675;139417.9087313691;151832;152377.9999999989;152561;154595.22702386416;10683;10696.358218506915;12592.4333404997;12847.743045139232;12952.352382381032;13788.793168102486;16577.41979030728;16602.83397166037;16618.50144495667;16651.50045498637;7036.331548502884;9032.909670903207;9032.909670903207;9108.453492790453;9305.162535371848;8604.655813767504;8724.382685194543;8729.694460693845;8888.822223555622;8894.911050889537;6569.967150164219;7383.335499805044;7898.433009271895;7977.282044615897;7997.800054998672;1824.4070677029754;1827.232562323827;2054.9211663876285;2106.315447479575;2126.6070723676016;856.7643897927995;915.6108653822232;937.6952490440634;941.8728471656376;969.7478655549467;19842.801571984095;20320.79679203189;20758.377248682562;20971.58056838885;21221.257255995966;934.3786382055993;967.0451618017212;996.1433167475965;1003.8895721470633;1004.251832384878;9286.582103805345;10666;10770.976757208053;10780.083692886035;10787.190960677981;723045;726589;735818;750922;753185;134422.32788835993;157015.21492392465;164684.17657911874;165167;165801.68396632;1016.2936758952604;1197.167968262067;1224.155332820351;1240.7704574653717;1245.726549047991;17153.742693859353;21038.89480552649;21090.15639374469;21188.179664343927;21343.78656213418;60444.69777651084;60610.69694651499;60984;61235;61322.46693832512;63251.683741581;68244.6587767058;77143;83479;94829;8380.95809520973;8507.276881464897;8630.78423039429;8705.8694119587;8933.28533717314;13539.932300338436;13592.388342524808;13631.454741810216;13979.860201397856;14045.648858778612;11694;11818.749843792682;11932.16474846787;12024.33866137371;12138.575149869712;10371.118454931415;10768.784624307627;11083.50124244427;11176.832347514957;11265.943670281596;10082.8487572685;11783.17517773782;11845.763084738084;11976.700582485508;12265.38673066361;8349.081601024003;8382.245597896219;8580.14198580137;8982.101789821227;9049.728508144766;11279.436028198394;11580.305181689126;11787.939085482347;11822.586209482626;11831.290122592673 04:38:09 INFO - PID 1643 | |3;mootools.html;1340.269553093564;1387.805707200992;1390.84005339386;1392.9442822287108;1409.8449170591234;10561.683149505508;10795.028447439729;11003;11019.338839669625;11097.944510277457;10806.72983175421;11065.114790816735;11070.225084244086;11089.667309980694;11091.55633774648;2444.217850287904;2493.252024392675;2493.30187547487;2495.987520062397;2502.5495410826043;2341.590221711202;2406.0736616402637;2458.4222707663685;2477.009196321477;2479.876006199692;2410.144398738449;2435.7320694723567;2438.366024833538;2450.301664025753;2455.2756936703627;2372.4424760181346;2410.7227668818045;2419.346776370379;2424.87875606219;2470.5800013997664;2298.2071185440996;2372.1934542255717;2436.671049408325;2444.1934161726585;2458.4714286428325;9235.307351948632;10952.945235273774;11029;11035.95158459945;11043.226974111816;6197.752089916398;6363.427291543737;6441.516886233504;6460.3216662250725;6461.61230326182;3971.483707118085;4004.599540046001;4071.246819338432;4104.035551645361;4106.322456794655;1171.94140292985;1182.5565412970136;1202.7594481103727;1235.2526721333643;1235.9505619775198;13536.864631353757;13887.02790804644;15230.010049346756;15325.386984520606;15370.615734606725;5270.789168433296;5398.055340315429;5444.972775136178;5449.945500544944;5474.124140137638;11534.711632209093;11573.363465009337;11589.942050289694;11598.420078996185;11599.710007249887;6107.267127944675;6213.65824879627;6321.514444105632;6333.334999825044;6354.046892966092;5937.643741375531;5939.584229104008;6033.18551995475;6036.396360363929;6047.667378294236;4276.657867370665;4277.337012763027;4298.2263192625005;4320.3519472078815;4325.848595299212;1103.3986477369854;1259.601841955447;1275.3113318807925;1295.8833704966598;1296.6693493159373;700.3731660164125;732.2018999290799;756.092688773474;793.087948858817;814.8207394373228;5881.441263080001;6005.939940600625;6090.086487026982;6194.566380353423;6204.317525072239;583.125312031952;587.7942720048035;772.9961350193213;915.9129882661136;938.8732521109699;3350.815705136241;3805.9153141355137;4129.710920235615;4265.1469706058915;4309.547497512779;13676.521321753691;14206;14217.50238741639;14235.78646320306;14245.501407450689;13878.583642490741;13945.023848330722;14172.362243699059;14189.716205675828;14197.36111874968;9834.950825245827;10175.491225438698;10186.949065254626;10195.949020255;10201.74495637615;6403.711832967434;6545;6617.239017513048;6724.4284235840505;6881.827954300982;12257.632271031884;12470.189437686522;12614.36928153607;12620.621381358575;12654.87345126537;11770.941145294219;11901.642950711492;12105.213161144497;12830.037747169186;12941.417636206581;8776.78058048554;9063.954680226556;9221.907780922373;9229.630814767334;9244.537773111451;8289.709860154866;10051.648192313234;10081.647142349982;10190.082892539707;10199.235057370579;7419.740309089156;8548.829023419372;8562.48625082497;8756.956215218883;8805.955970220108;8498.32013438911;8519.105493923049;8625.784355391166;8654.870176947225;8673.696420625249;6525.738970441129;7844.4116691247245;7863.606819658879;7921.049474062919;7942.364610831235;5902.9072165972875;5931.466168044896;6030.427109424598;6075.301340345917;6163.537734669828;5729.570282228933;5838.2702162229725;5988.610740301867;6010.9699451502465;6172.969135154295 04:38:09 INFO - PID 1643 | |4;prototype.html;400.38340954929413;402.35623003194894;402.8710812539987;404.1190205352332;405.62479706271694;5803.912941305874;6336.334684858087;6416.6470844103615;6442.7745028924;6449.066858490189;5707.429257074291;5881.264841894763;5997.88004239915;6075.848103797407;6248.718807653655;4487.282034874429;4864.197407427788;4869.733869194018;4890.5109489051165;4890.535399137077;4250.766207858566;4778.713277203362;4909.214525675875;4918.336024636682;4927.039227350668;4810.542998415162;4812.927806082912;4818.542238487338;4839.395075615548;4840.9273860891935;4328.588784065524;4687.929681054787;4774.665773395864;4826.710397376169;4828.7102773833685;4244.236037513247;4274.358846173068;4276.3799249109015;4284.550122237151;4293.613574778254;4586.88532786683;5771.480566749013;6079.875223083744;6089.360617135181;6144.446999770043;4584.991301913574;4915;5137.7412533929055;5159.922601160985;5480.725498917945;6556.409923106943;6648.800535983928;6670.999350097476;6674.791873482692;6825.249222585511;3726.4782930389765;3841.2125514269505;3959.6436320730986;4204.054087830214;4471.441069866267;5219.217117432378;6583.604983700945;6653.7005834737065;6828.5902845829405;7120.430365570794;4283.2290187765875;4409.911801763947;4444.73331600105;4452.487963884195;4469.994251293433;3772.0569857535615;4079.9592004079577;4396.296592545177;4457.375967364572;4530.07133537624;4513.796879140446;5149.742512874342;5217.843464696065;5304.496072873071;5387.084195686664;5005.449400565934;6145.5638677200195;6610.471162307004;6645.800625981228;6714.194296684332;1490.411287541415;1496.368957835964;1576.7004269189047;1581.6915701438338;1584.2395650087792;928.7399528132133;935.3218916285774;1032.2258306270298;1033.8655974723238;1038.6416686243233;6277.52918531112;6338.904916426257;6341.175647165839;6344.238691356974;6364.745410183634;6128.743607560439;6169.722362493699;6792.3886850182735;7027.2242464227365;7048.850100719227;5372.91940620891;5971;6194.442500175006;6302.653354065479;6366.9681651591445;3639.7816131032223;3678.8528458861347;3684.7604905681046;3686.391745362039;3696.611855755161;6100.603460775035;6321.65230912295;6759.817032019377;6857.074294970115;7233.8553228935125;6117.480014198754;7309.451791115687;7312.23221561739;7339;7340.743073992385;6992.056072430157;7188.6046267455795;7252.637368131678;7297.854042919218;7300.744473943387;7020.929790702027;7045.894311585433;7070.964645176947;7099.396551293198;7147.213806481179;6754.628495432602;6906.274841141608;6930.13373328334;6934.8613027740175;6997;5619.606627536034;5945.40545945402;6372.617642941438;7211.855762884608;7274.96362518184;4527.388802511618;4541.636669066401;4549.9317510236715;4552.476465206543;4553.3800628501085;5778.537716982715;6822.3859852613505;7077.009218709488;7088.503804733619;7104.822379440556;6781.525293229624;6790.898136528055;6801.421879140131;6817;6850.314968503109;5719.7426115824055;6469.676516174267;6817.625030623363;6822.226221182429;6853.383195512428;5550.833474995757;5729.570282228766;5821.38875418075;6641.568298060611;6672.999050142517;5599.580031497572;6662.167229096363;6805.727770889109;6818;6866.210385805496;5960.910586341295;6051.878962420815;6442.8389290268115;6612.404883560503;6658.300878407697 04:38:09 INFO - PID 1643 | |5;yui.html;681.1927865479406;711.9145702515699;728.6065524616707;731.8975343451917;738.9113306403231;14665.780013299796;15037.248137593131;15366.769498457532;15400.691986160284;15500.612484687861;13562.728745425085;13577.117487363315;13661.521846735366;13818;14146.292685365743;918.485648037098;937.0395344771596;942.7737343037691;943.7876477792511;944.6976967370445;911.7128104647015;932.9207017403529;936.8454205056191;946.3186505715873;957.5978089202551;978.3787295067613;988.2439933450916;991.7570195302161;994.3735446668588;994.756284710247;852.3351785607236;989.2284018465608;989.8861630912393;989.990100098997;990.1484723138095;731.6159016516318;736.0541703910503;736.3483317264206;737.2664199121855;737.2737853214579;15501.302441390164;15909.761353579706;15928.203589820463;16198.271077801528;16495.752563711554;14622.780658290134;14731.852681473156;14757.704845903128;14768.409263629443;14802.703945921128;11672.241304315192;11677.941610291895;11780.410979451079;11962.641120766304;12070.336131512764;2962.8157679028336;3018.24543864034;3028.8334141622204;3038.6353637563634;3039.285767844555;93051;107184.46407767989;109693.90306096917;110202.3469647956;112359;11003.284786488852;11373.374464404536;11474.655760327203;11701.414929253504;11713.707157320965;17028.48914532566;24689;24836.751632483807;24876.626850597255;24999.00003999856;7634.198409167068;7719.073711154698;7742.187070357644;7798.1811909749795;7873.212678732196;3931.233409485123;3961.7622942622957;3964.1278918637854;4020.537638171589;4035.616616421435;4033.5361433434946;4104.994276402301;4140.60664236897;4157.501099868035;4170.687198460128;843.7300063979468;846.7290467050485;848.4442690038035;856.3791251342726;868.2793281576277;543.3479824210963;545.9972700136553;563.3859093588009;595.3421469276387;598.5181928547561;9693.660721874701;10154.087124821088;10171.321731914299;10430.791384172275;10445.554167019285;523.5966219572776;549.8322713829166;555.1783360626296;579.6145563200424;580.7212537981792;4385.956140438619;4457.888552786141;4777.307290442866;4836.188788563603;4893.192623217201;106235.88431635084;107211;107507;108175.37736933952;109294;65795.35511612248;73211.63394182995;87474.56262718646;92407.53796231111;92887;78341.21658783339;79344.80982785263;79534.602326988;79948.60025699834;80588.59705701552;9300.56068980317;9434.811303774024;9458.43249405038;9459.95270023673;9497.620095196115;39245.803770980965;39792.60207397889;39832;40195.79412617626;40379.59620403876;50003.74998125132;51060;51460;52043;61250;13183.340832958122;13670.658233544242;13734.313284335944;14301.925086106537;14490.710185796435;14354.49759258421;14442.566722998326;14568.344424501134;14641.487547936198;14668.70662586721;13631.167178630814;13669.453221871014;13802.240876751875;14104.224267665377;14125.081869678437;13277;13358.666033349244;13745.175289482662;14164.575062748134;14224.715505690036;13343.199408035549;13385.263810490516;13453.730925381242;13822.101563398346;14158.92920535432;8614.65541378338;9581.185599224144;9599.712008639473;9859.605615775288;10370.325928814604;7470.439717021137;9892.477418258586;10954.178436617445;11297.71755706114;11323.433828308716 04:38:09 INFO - PID 1643 | __end_tp_report 04:38:09 INFO - PID 1643 | __start_cc_report 04:38:09 INFO - PID 1643 | _x_x_mozilla_cycle_collect,431 04:38:09 INFO - PID 1643 | __end_cc_report 04:38:09 INFO - PID 1643 | __startTimestamp1490614689387__endTimestamp 04:38:09 INFO - PID 1643 | 04:38:09 INFO - PID 1643 | ------- Summary: start ------- 04:38:09 INFO - PID 1643 | Number of tests: 6 04:38:09 INFO - PID 1643 | 04:38:09 INFO - PID 1643 | [#0] dojo.html Cycles:165 Average:6233.79 Median:6395.39 stddev:747.61 (11.7%) stddev-sans-first:706.31 04:38:09 INFO - PID 1643 | Values: 3026.8 3598.8 3618.2 3629.0 3652.9 5416.2 5689.2 6201.6 6220.3 6246.0 6188.9 6219.7 6232.0 6282.6 6283.5 4717.9 5695.1 5825.7 5850.9 5919.9 5718.8 5771.8 5904.9 5905.6 5955.0 4736.0 5685.8 5738.9 5907.7 5920.8 5717.6 5719.0 5774.5 5781.4 5834.0 4182.3 5293.4 5518.3 5677.1 5745.6 5760.5 6011.5 6025.2 6179.3 6296.7 6613.7 6740.5 6808.7 6826.5 6828.6 5752.4 6887.4 6915.0 6932.3 6932.7 6319.5 6328.8 6330.2 6334.3 6343.6 6672.4 6816.0 6954.4 6971.5 6995.1 5654.1 6395.4 6470.7 6615.6 6684.1 6662.8 6784.3 6816.6 6904.8 6914.2 6760.2 6760.8 6781.8 6789.8 6804.2 6398.0 6584.4 6603.5 6716.6 6794.6 5395.1 5419.6 5432.8 5465.0 5471.5 4789.2 4808.3 4831.2 4841.1 4842.0 6159.6 6168.8 6312.2 6322.6 6337.3 6835.1 6836.6 6862.5 6879.2 6883.3 6311.5 6320.1 6321.1 6323.3 6324.8 5865.4 5979.9 6088.8 6096.8 6149.4 6769.3 6944.1 6968.5 6983.2 6995.3 6904.8 6913.3 6914.2 6915.4 6917.2 6881.2 6922.6 6970.9 6995.7 7000.9 6523.6 6576.0 6724.1 6772.8 6777.7 6844.2 6905.9 6910.7 6918.2 6963.1 6353.9 6446.5 6547.7 6556.1 6694.3 6443.0 6469.3 6579.9 6603.0 6647.1 6321.7 6471.7 6484.2 6488.0 6498.6 6575.2 6619.2 6626.7 6628.8 6647.6 6247.5 6292.2 6386.0 6440.4 6442.7 04:38:09 INFO - PID 1643 | 04:38:09 INFO - PID 1643 | [#1] ext.html Cycles:180 Average:56087.21 Median:35132.06 stddev:117682.14 (335.0%) stddev-sans-first:117938.86 04:38:09 INFO - PID 1643 | Values: 723.7 794.7 817.3 1251.0 1263.8 35399.8 36398.0 36409.8 36432.8 36452.9 36498.8 36520.3 36678.0 36741.9 36807.1 7826.3 7998.7 8372.1 8589.4 8605.1 8433.4 8521.0 8578.7 8580.0 8580.0 8483.5 8488.1 8580.9 8582.1 8583.9 8477.2 8519.2 8562.0 8627.9 8637.0 8251.9 8415.3 8419.6 8472.7 8479.4 32215.8 33766.7 34444.8 37892.0 37944.0 3023.0 3053.3 3056.7 3067.0 3081.4 27396.0 27648.8 27685.2 27792.2 27820.0 2785.2 2791.5 2794.5 2802.5 2807.4 339576.0 341897.3 343492.3 343522.3 344679.0 48636.3 48762.8 48792.8 48870.8 48924.8 50055.7 50328.2 50331.7 50434.7 50498.2 14079.0 14302.3 14385.5 14423.3 14475.7 11688.1 11691.2 11735.3 11746.4 11779.0 12847.4 13122.8 13301.7 13337.9 13448.9 5875.4 5887.4 5948.6 5950.3 5966.6 949.4 961.1 986.5 987.5 998.0 22718.7 22997.0 23851.9 23965.3 23972.8 972.9 1028.0 1078.8 1127.9 1128.3 11858.5 12078.6 15250.1 15769.1 15917.0 474534.0 475862.0 477678.0 478270.0 478721.0 50680.2 51024.5 54211.7 54855.2 54990.4 1127.7 1433.3 1466.4 1471.3 1473.0 24104.0 27727.3 28109.2 28373.4 28896.7 37890.8 38228.8 38245.0 38393.8 38443.6 488744.0 490523.0 490938.5 491284.0 491443.0 32531.8 33215.7 33352.3 33385.0 33441.8 40971.0 41409.0 41719.8 41872.6 41874.0 25450.1 27957.6 28040.4 28931.6 29555.4 28495.9 29429.0 29626.6 29660.7 29668.9 34054.1 35072.5 35191.6 35241.6 35255.1 28763.6 28801.7 29557.4 29924.4 29940.6 22301.6 22745.8 23446.9 23698.1 23854.4 04:38:09 INFO - PID 1643 | 04:38:09 INFO - PID 1643 | [#2] jquery.html Cycles:180 Average:41441.68 Median:22175.39 stddev:123354.75 (556.3%) stddev-sans-first:123662.24 04:38:09 INFO - PID 1643 | Values: 373.5 398.8 419.5 430.2 448.1 19885.0 20526.3 21665.7 22038.7 22090.6 22260.2 22500.7 23028.9 23076.7 23222.8 5970.3 6257.5 6265.1 6277.0 6277.5 5887.6 6127.2 6127.8 6195.3 6204.3 5966.4 6136.9 6164.3 6174.0 6184.9 6117.7 6205.0 6221.5 6255.2 6257.2 5473.9 5485.5 5496.6 5518.2 5576.3 26187.9 26597.9 26644.7 26698.5 27078.0 2049.0 2059.4 2070.5 2077.6 2130.1 15425.8 16079.7 16485.3 16696.7 16827.2 1672.6 1704.5 1711.1 1735.4 1777.3 139417.9 151832.0 152378.0 152561.0 154595.2 10683.0 10696.4 12592.4 12847.7 12952.4 13788.8 16577.4 16602.8 16618.5 16651.5 7036.3 9032.9 9032.9 9108.5 9305.2 8604.7 8724.4 8729.7 8888.8 8894.9 6570.0 7383.3 7898.4 7977.3 7997.8 1824.4 1827.2 2054.9 2106.3 2126.6 856.8 915.6 937.7 941.9 969.7 19842.8 20320.8 20758.4 20971.6 21221.3 934.4 967.0 996.1 1003.9 1004.3 9286.6 10666.0 10771.0 10780.1 10787.2 723045.0 726589.0 735818.0 750922.0 753185.0 134422.3 157015.2 164684.2 165167.0 165801.7 1016.3 1197.2 1224.2 1240.8 1245.7 17153.7 21038.9 21090.2 21188.2 21343.8 60444.7 60610.7 60984.0 61235.0 61322.5 63251.7 68244.7 77143.0 83479.0 94829.0 8381.0 8507.3 8630.8 8705.9 8933.3 13539.9 13592.4 13631.5 13979.9 14045.6 11694.0 11818.7 11932.2 12024.3 12138.6 10371.1 10768.8 11083.5 11176.8 11265.9 10082.8 11783.2 11845.8 11976.7 12265.4 8349.1 8382.2 8580.1 8982.1 9049.7 11279.4 11580.3 11787.9 11822.6 11831.3 04:38:09 INFO - PID 1643 | 04:38:09 INFO - PID 1643 | [#3] mootools.html Cycles:180 Average:6779.69 Median:2499.27 stddev:4177.80 (167.2%) stddev-sans-first:4169.52 04:38:09 INFO - PID 1643 | Values: 1340.3 1387.8 1390.8 1392.9 1409.8 10561.7 10795.0 11003.0 11019.3 11097.9 10806.7 11065.1 11070.2 11089.7 11091.6 2444.2 2493.3 2493.3 2496.0 2502.5 2341.6 2406.1 2458.4 2477.0 2479.9 2410.1 2435.7 2438.4 2450.3 2455.3 2372.4 2410.7 2419.3 2424.9 2470.6 2298.2 2372.2 2436.7 2444.2 2458.5 9235.3 10952.9 11029.0 11036.0 11043.2 6197.8 6363.4 6441.5 6460.3 6461.6 3971.5 4004.6 4071.2 4104.0 4106.3 1171.9 1182.6 1202.8 1235.3 1236.0 13536.9 13887.0 15230.0 15325.4 15370.6 5270.8 5398.1 5445.0 5449.9 5474.1 11534.7 11573.4 11589.9 11598.4 11599.7 6107.3 6213.7 6321.5 6333.3 6354.0 5937.6 5939.6 6033.2 6036.4 6047.7 4276.7 4277.3 4298.2 4320.4 4325.8 1103.4 1259.6 1275.3 1295.9 1296.7 700.4 732.2 756.1 793.1 814.8 5881.4 6005.9 6090.1 6194.6 6204.3 583.1 587.8 773.0 915.9 938.9 3350.8 3805.9 4129.7 4265.1 4309.5 13676.5 14206.0 14217.5 14235.8 14245.5 13878.6 13945.0 14172.4 14189.7 14197.4 9835.0 10175.5 10186.9 10195.9 10201.7 6403.7 6545.0 6617.2 6724.4 6881.8 12257.6 12470.2 12614.4 12620.6 12654.9 11770.9 11901.6 12105.2 12830.0 12941.4 8776.8 9064.0 9221.9 9229.6 9244.5 8289.7 10051.6 10081.6 10190.1 10199.2 7419.7 8548.8 8562.5 8757.0 8806.0 8498.3 8519.1 8625.8 8654.9 8673.7 6525.7 7844.4 7863.6 7921.0 7942.4 5902.9 5931.5 6030.4 6075.3 6163.5 5729.6 5838.3 5988.6 6011.0 6173.0 04:38:09 INFO - PID 1643 | 04:38:09 INFO - PID 1643 | [#4] prototype.html Cycles:180 Average:5396.81 Median:5984.44 stddev:1699.18 (28.4%) stddev-sans-first:1662.05 04:38:09 INFO - PID 1643 | Values: 400.4 402.4 402.9 404.1 405.6 5803.9 6336.3 6416.6 6442.8 6449.1 5707.4 5881.3 5997.9 6075.8 6248.7 4487.3 4864.2 4869.7 4890.5 4890.5 4250.8 4778.7 4909.2 4918.3 4927.0 4810.5 4812.9 4818.5 4839.4 4840.9 4328.6 4687.9 4774.7 4826.7 4828.7 4244.2 4274.4 4276.4 4284.6 4293.6 4586.9 5771.5 6079.9 6089.4 6144.4 4585.0 4915.0 5137.7 5159.9 5480.7 6556.4 6648.8 6671.0 6674.8 6825.2 3726.5 3841.2 3959.6 4204.1 4471.4 5219.2 6583.6 6653.7 6828.6 7120.4 4283.2 4409.9 4444.7 4452.5 4470.0 3772.1 4080.0 4396.3 4457.4 4530.1 4513.8 5149.7 5217.8 5304.5 5387.1 5005.4 6145.6 6610.5 6645.8 6714.2 1490.4 1496.4 1576.7 1581.7 1584.2 928.7 935.3 1032.2 1033.9 1038.6 6277.5 6338.9 6341.2 6344.2 6364.7 6128.7 6169.7 6792.4 7027.2 7048.9 5372.9 5971.0 6194.4 6302.7 6367.0 3639.8 3678.9 3684.8 3686.4 3696.6 6100.6 6321.7 6759.8 6857.1 7233.9 6117.5 7309.5 7312.2 7339.0 7340.7 6992.1 7188.6 7252.6 7297.9 7300.7 7020.9 7045.9 7071.0 7099.4 7147.2 6754.6 6906.3 6930.1 6934.9 6997.0 5619.6 5945.4 6372.6 7211.9 7275.0 4527.4 4541.6 4549.9 4552.5 4553.4 5778.5 6822.4 7077.0 7088.5 7104.8 6781.5 6790.9 6801.4 6817.0 6850.3 5719.7 6469.7 6817.6 6822.2 6853.4 5550.8 5729.6 5821.4 6641.6 6673.0 5599.6 6662.2 6805.7 6818.0 6866.2 5960.9 6051.9 6442.8 6612.4 6658.3 04:38:09 INFO - PID 1643 | 04:38:09 INFO - PID 1643 | [#5] yui.html Cycles:180 Average:19868.80 Median:4034.58 stddev:28778.61 (713.3%) stddev-sans-first:28823.28 04:38:09 INFO - PID 1643 | Values: 681.2 711.9 728.6 731.9 738.9 14665.8 15037.2 15366.8 15400.7 15500.6 13562.7 13577.1 13661.5 13818.0 14146.3 918.5 937.0 942.8 943.8 944.7 911.7 932.9 936.8 946.3 957.6 978.4 988.2 991.8 994.4 994.8 852.3 989.2 989.9 990.0 990.1 731.6 736.1 736.3 737.3 737.3 15501.3 15909.8 15928.2 16198.3 16495.8 14622.8 14731.9 14757.7 14768.4 14802.7 11672.2 11677.9 11780.4 11962.6 12070.3 2962.8 3018.2 3028.8 3038.6 3039.3 93051.0 107184.5 109693.9 110202.3 112359.0 11003.3 11373.4 11474.7 11701.4 11713.7 17028.5 24689.0 24836.8 24876.6 24999.0 7634.2 7719.1 7742.2 7798.2 7873.2 3931.2 3961.8 3964.1 4020.5 4035.6 4033.5 4105.0 4140.6 4157.5 4170.7 843.7 846.7 848.4 856.4 868.3 543.3 546.0 563.4 595.3 598.5 9693.7 10154.1 10171.3 10430.8 10445.6 523.6 549.8 555.2 579.6 580.7 4386.0 4457.9 4777.3 4836.2 4893.2 106235.9 107211.0 107507.0 108175.4 109294.0 65795.4 73211.6 87474.6 92407.5 92887.0 78341.2 79344.8 79534.6 79948.6 80588.6 9300.6 9434.8 9458.4 9460.0 9497.6 39245.8 39792.6 39832.0 40195.8 40379.6 50003.7 51060.0 51460.0 52043.0 61250.0 13183.3 13670.7 13734.3 14301.9 14490.7 14354.5 14442.6 14568.3 14641.5 14668.7 13631.2 13669.5 13802.2 14104.2 14125.1 13277.0 13358.7 13745.2 14164.6 14224.7 13343.2 13385.3 13453.7 13822.1 14158.9 8614.7 9581.2 9599.7 9859.6 10370.3 7470.4 9892.5 10954.2 11297.7 11323.4 04:38:09 INFO - PID 1643 | -------- Summary: end -------- 04:38:09 INFO - PID 1643 | 04:38:10 INFO - TEST-INFO | 1643: exit 0 04:38:10 INFO - TEST-OK | dromaeo_css | took 1117698ms 04:38:10 INFO - TEST-START | kraken 04:38:10 INFO - operating with platform_type : mac_ 04:38:10 INFO - Initialising browser for kraken test... 04:38:10 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp8bsio2/profile http://localhost:49242/getInfo.html) 04:38:13 INFO - PID 1654 | 2017-03-27 04:38:13.096 plugin-container[1656:10175] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 04:38:13 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:38:13 INFO - PID 1654 | 2017-03-27 04:38:13.097 plugin-container[1656:10175] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 04:38:13 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:38:13 INFO - PID 1654 | 2017-03-27 04:38:13.097 plugin-container[1656:10175] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:38:13 INFO - PID 1654 | __metrics Screen width/height:1600/1200 04:38:13 INFO - PID 1654 | colorDepth:24 04:38:13 INFO - PID 1654 | Browser inner width/height: 1024/689 04:38:13 INFO - PID 1654 | __metrics 04:38:13 ERROR - PID 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:38:13 ERROR - PID 1654 | 1490614693303 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < forceQuit@jar:file:///var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp8bsio2/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp8bsio2/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp8bsio2/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp8bsio2/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:38:14 INFO - TEST-INFO | 1654: exit 0 04:38:14 INFO - Browser initialized. 04:38:14 INFO - Running cycle 1/1 for kraken test... 04:38:14 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp8bsio2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:38:16 INFO - PID 1657 | 2017-03-27 04:38:16.580 plugin-container[1658:10298] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 04:38:16 INFO - PID 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:38:16 INFO - PID 1657 | 2017-03-27 04:38:16.581 plugin-container[1658:10298] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.CFPasteboardClient' 04:38:16 INFO - PID 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:38:16 INFO - PID 1657 | 2017-03-27 04:38:16.581 plugin-container[1658:10298] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:38:26 INFO - PID 1657 | RSS: Main: 228286464 04:38:26 INFO - PID 1657 | 04:38:28 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 04:38:29 INFO - PID 1657 | RSS: Main: 241614848 04:38:29 INFO - PID 1657 | 04:38:32 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 04:38:33 INFO - PID 1657 | RSS: Main: 250249216 04:38:33 INFO - PID 1657 | 04:38:36 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 04:38:37 INFO - PID 1657 | RSS: Main: 253001728 04:38:37 INFO - PID 1657 | 04:38:39 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 04:38:40 INFO - PID 1657 | RSS: Main: 254062592 04:38:40 INFO - PID 1657 | 04:38:42 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:38:42 INFO - PID 1657 | RSS: Main: 255660032 04:38:42 INFO - PID 1657 | 04:38:45 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 04:38:46 INFO - PID 1657 | RSS: Main: 261324800 04:38:46 INFO - PID 1657 | 04:38:49 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 04:38:50 INFO - PID 1657 | RSS: Main: 261959680 04:38:50 INFO - PID 1657 | 04:38:53 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 04:38:54 INFO - PID 1657 | RSS: Main: 261984256 04:38:54 INFO - PID 1657 | 04:38:55 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:38:56 INFO - PID 1657 | RSS: Main: 261824512 04:38:56 INFO - PID 1657 | 04:38:58 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:38:59 INFO - PID 1657 | RSS: Main: 262144000 04:38:59 INFO - PID 1657 | 04:39:01 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:39:02 INFO - PID 1657 | RSS: Main: 261881856 04:39:02 INFO - PID 1657 | 04:39:04 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:39:05 INFO - PID 1657 | RSS: Main: 262512640 04:39:05 INFO - PID 1657 | 04:39:09 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:39:09 INFO - PID 1657 | RSS: Main: 262234112 04:39:09 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 04:39:11 INFO - PID 1657 | RSS: Main: 264953856 04:39:11 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | __start_tp_report 04:39:11 INFO - PID 1657 | _x_x_mozilla_page_load 04:39:11 INFO - PID 1657 | _x_x_mozilla_page_load_details 04:39:11 INFO - PID 1657 | |i|pagename|runs| 04:39:11 INFO - PID 1657 | |0;ai-astar;104;117;117;119;116;136;153;116;116;116 04:39:11 INFO - PID 1657 | |1;audio-beat-detection;148;118;101;181;141;120;135;142;170;100 04:39:11 INFO - PID 1657 | |2;audio-dft;214;263;225;240;276;192;199;196;196;199 04:39:11 INFO - PID 1657 | |3;audio-fft;78;62;85;111;76;62;60;51;78;51 04:39:11 INFO - PID 1657 | |4;audio-oscillator;89;71;82;73;72;71;84;70;73;67 04:39:11 INFO - PID 1657 | |5;imaging-gaussian-blur;91;80;136;137;105;134;76;132;135;92 04:39:11 INFO - PID 1657 | |6;imaging-darkroom;97;99;97;99;97;106;112;99;98;98 04:39:11 INFO - PID 1657 | |7;imaging-desaturate;91;91;92;114;148;96;87;147;149;91 04:39:11 INFO - PID 1657 | |8;json-parse-financial;68;66;74;69;58;77;90;99;74;56 04:39:11 INFO - PID 1657 | |9;json-stringify-tinderbox;58;58;60;67;58;72;82;77;80;79 04:39:11 INFO - PID 1657 | |10;stanford-crypto-aes;87;88;78;96;98;101;108;71;74;88 04:39:11 INFO - PID 1657 | |11;stanford-crypto-ccm;146;144;142;141;144;144;160;149;199;133 04:39:11 INFO - PID 1657 | |12;stanford-crypto-pbkdf2;234;230;193;194;211;189;188;183;197;202 04:39:11 INFO - PID 1657 | |13;stanford-crypto-sha256-iterative;71;71;70;67;70;69;57;58;59;89 04:39:11 INFO - PID 1657 | __end_tp_report 04:39:11 INFO - PID 1657 | __start_cc_report 04:39:11 INFO - PID 1657 | _x_x_mozilla_cycle_collect,1017 04:39:11 INFO - PID 1657 | __end_cc_report 04:39:11 INFO - PID 1657 | __startTimestamp1490614751649__endTimestamp 04:39:11 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | ------- Summary: start ------- 04:39:11 INFO - PID 1657 | Number of tests: 14 04:39:11 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | [#0] ai-astar Cycles:10 Average:121.00 Median:117.00 stddev:13.64 (11.7%) stddev-sans-first:13.00 04:39:11 INFO - PID 1657 | Values: 104.0 117.0 117.0 119.0 116.0 136.0 153.0 116.0 116.0 116.0 04:39:11 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:141.50 stddev:26.85 (19.0%) stddev-sans-first:28.10 04:39:11 INFO - PID 1657 | Values: 148.0 118.0 101.0 181.0 141.0 120.0 135.0 142.0 170.0 100.0 04:39:11 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | [#2] audio-dft Cycles:10 Average:220.00 Median:219.50 stddev:30.30 (13.8%) stddev-sans-first:32.06 04:39:11 INFO - PID 1657 | Values: 214.0 263.0 225.0 240.0 276.0 192.0 199.0 196.0 196.0 199.0 04:39:11 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | [#3] audio-fft Cycles:10 Average:71.40 Median:69.00 stddev:18.26 (26.5%) stddev-sans-first:19.21 04:39:11 INFO - PID 1657 | Values: 78.0 62.0 85.0 111.0 76.0 62.0 60.0 51.0 78.0 51.0 04:39:11 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:73.00 stddev:7.18 (9.8%) stddev-sans-first:5.61 04:39:11 INFO - PID 1657 | Values: 89.0 71.0 82.0 73.0 72.0 71.0 84.0 70.0 73.0 67.0 04:39:11 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:111.80 Median:106.50 stddev:25.44 (23.9%) stddev-sans-first:25.84 04:39:11 INFO - PID 1657 | Values: 91.0 80.0 136.0 137.0 105.0 134.0 76.0 132.0 135.0 92.0 04:39:11 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | [#6] imaging-darkroom Cycles:10 Average:100.20 Median:98.00 stddev:4.92 (5.0%) stddev-sans-first:5.08 04:39:11 INFO - PID 1657 | Values: 97.0 99.0 97.0 99.0 97.0 106.0 112.0 99.0 98.0 98.0 04:39:11 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | [#7] imaging-desaturate Cycles:10 Average:110.60 Median:91.00 stddev:26.83 (29.5%) stddev-sans-first:27.50 04:39:11 INFO - PID 1657 | Values: 91.0 91.0 92.0 114.0 148.0 96.0 87.0 147.0 149.0 91.0 04:39:11 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | [#8] json-parse-financial Cycles:10 Average:73.10 Median:74.00 stddev:13.28 (17.9%) stddev-sans-first:13.96 04:39:11 INFO - PID 1657 | Values: 68.0 66.0 74.0 69.0 58.0 77.0 90.0 99.0 74.0 56.0 04:39:11 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:74.50 stddev:10.06 (13.5%) stddev-sans-first:9.84 04:39:11 INFO - PID 1657 | Values: 58.0 58.0 60.0 67.0 58.0 72.0 82.0 77.0 80.0 79.0 04:39:11 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:87.50 stddev:12.07 (13.8%) stddev-sans-first:12.78 04:39:11 INFO - PID 1657 | Values: 87.0 88.0 78.0 96.0 98.0 101.0 108.0 71.0 74.0 88.0 04:39:11 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:150.20 Median:145.00 stddev:18.44 (12.7%) stddev-sans-first:19.49 04:39:11 INFO - PID 1657 | Values: 146.0 144.0 142.0 141.0 144.0 144.0 160.0 149.0 199.0 133.0 04:39:11 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:202.10 Median:199.50 stddev:17.59 (8.8%) stddev-sans-first:14.38 04:39:11 INFO - PID 1657 | Values: 234.0 230.0 193.0 194.0 211.0 189.0 188.0 183.0 197.0 202.0 04:39:11 INFO - PID 1657 | 04:39:11 INFO - PID 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:70.00 stddev:9.26 (13.2%) stddev-sans-first:9.76 04:39:11 INFO - PID 1657 | Values: 71.0 71.0 70.0 67.0 70.0 69.0 57.0 58.0 59.0 89.0 04:39:11 INFO - PID 1657 | -------- Summary: end -------- 04:39:11 INFO - PID 1657 | 04:39:12 INFO - TEST-INFO | 1657: exit 0 04:39:12 INFO - TEST-OK | kraken | took 62594ms 04:39:12 INFO - SUITE-END | took 1180s 04:39:12 INFO - Completed test suite (00:19:40) 04:39:12 INFO - javascript benchmark 04:39:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7728.138194350028, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3026.8486575671222, 3598.802065886376, 3618.240169564391, 3629.0383048492154, 3652.945205821913, 5416.241726158331, 5689.203511508382, 6201.59689620175, 6220.284667263266, 6245.968770156149, 6188.947878860593, 6219.657918814475, 6232.0, 6282.560220784536, 6283.497320214383, 4717.9292310615365, 5695.060315048023, 5825.708714564276, 5850.853728656775, 5919.940800591982, 5718.799842005531, 5771.82684519463, 5904.88190236195, 5905.616134951214, 5955.0, 4736.029114031615, 5685.800996965087, 5738.885222295572, 5907.734151963172, 5920.763169473216, 5717.599768016241, 5718.971405142947, 5774.5091667208335, 5781.364049954502, 5834.008218602848, 4182.2681030819485, 5293.417724050351, 5518.33779946405, 5677.148427735831, 5745.626534275259, 5760.510356619692, 6011.549133814981, 6025.246844144482, 6179.3202747697715, 6296.716647750863, 6613.702383392759, 6740.460763138937, 6808.7276508939585, 6826.522143449961, 6828.624425656587, 5752.395998420147, 6887.380135787803, 6914.9654251728925, 6932.341427564374, 6932.6533673316135, 6319.526035547352, 6328.841778955517, 6330.208723909512, 6334.3032266450655, 6343.555951083472, 6672.366125218096, 6816.0, 6954.4436445084275, 6971.51199416036, 6995.090638217, 5654.090399701158, 6395.392437718409, 6470.741170353227, 6615.569987950767, 6684.064231007663, 6662.833429164213, 6784.321567843176, 6816.62508562024, 6904.827379315457, 6914.170299564084, 6760.222574403908, 6760.797176084725, 6781.830454238683, 6789.796306110825, 6804.183497980274, 6398.0, 6584.407403333723, 6603.471722262208, 6716.5634233774645, 6794.592324460548, 5395.136778115482, 5419.566434685215, 5432.782688692487, 5465.0, 5471.534919531805, 4789.161896668069, 4808.326834243208, 4831.202851529459, 4841.1285968526, 4841.95158048422, 6159.599626024294, 6168.784092556829, 6312.179416675803, 6322.620642761357, 6337.33457986914, 6835.077264569319, 6836.555623884432, 6862.4853136015, 6879.2432832388395, 6883.346082122191, 6311.495080393649, 6320.115183874262, 6321.0834429008455, 6323.30443651198, 6324.810255692337, 5865.384134665884, 5979.880402392015, 6088.786892458743, 6096.756129754849, 6149.446549810538, 6769.255381908085, 6944.062551555476, 6968.5122041458635, 6983.231844497, 6995.300469952964, 6904.758333458305, 6913.308669133247, 6914.204866440223, 6915.377616014583, 6917.204521480095, 6881.208661003849, 6922.550034247758, 6970.930290697231, 6995.685194166173, 7000.929990700028, 6523.608583484816, 6575.980722987944, 6724.092247546714, 6772.796816095525, 6777.728890844508, 6844.178698556006, 6905.930940690529, 6910.723571057101, 6918.204406493116, 6963.059986901906, 6353.936460635335, 6446.484281257394, 6547.672616369257, 6556.082148499309, 6694.330566943267, 6443.0, 6469.320721324381, 6579.901301480578, 6603.042558829039, 6647.135872336566, 6321.747130114744, 6471.676416179078, 6484.1894763154605, 6487.967560162169, 6498.642574658439, 6575.178102737158, 6619.238787539302, 6626.701798418986, 6628.83427914306, 6647.567908085959, 6247.5001999839, 6292.150559674568, 6385.96807015962, 6440.35596440371, 6442.742290308335], "value": 6184.076865990021, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.6924307169452, 794.7218473534263, 817.2930415190862, 1251.0, 1263.8357013588231, 35399.82300088499, 36398.0, 36409.81795091021, 36432.81783591081, 36452.90641280766, 36498.8175059125, 36520.26959460809, 36678.0, 36741.89774306768, 36807.07982300444, 7826.295633392993, 7998.720044798433, 8372.079071302152, 8589.423173048091, 8605.139486051406, 8433.367497437686, 8520.957395213016, 8578.656853725843, 8580.0, 8580.013298470692, 8483.490990540588, 8488.108748581402, 8580.914190858073, 8582.14178582143, 8583.871241931376, 8477.194666506672, 8519.190676885686, 8562.01536823264, 8627.870581941275, 8636.956815215946, 8251.927249457593, 8415.28470080044, 8419.579021048985, 8472.703455379095, 8479.364047696448, 32215.83892080548, 33766.6623333766, 34444.82777586121, 37892.0, 37944.0, 3022.9619232671025, 3053.2672158681758, 3056.7401770849506, 3067.018554062701, 3081.4145312390574, 27396.0, 27648.755805988578, 27685.169444916686, 27792.16623501298, 27820.026299079636, 2785.206216228365, 2791.4696207720467, 2794.5249307617755, 2802.453521563296, 2807.4244779820087, 339576.0, 341897.29051354586, 343492.2825385882, 343522.28238858894, 344679.0, 48636.27045594319, 48762.756186218845, 48792.7560362203, 48870.75564622225, 48924.75537622289, 50055.74526165317, 50328.24507632388, 50331.74834125806, 50434.74782626063, 50498.24252636213, 14079.0, 14302.284885755671, 14385.496507622183, 14423.278836058154, 14475.710485790436, 11688.064954803594, 11691.240069395462, 11735.295882247092, 11746.353950532632, 11779.0, 12847.421866016051, 13122.803157952638, 13301.73396532064, 13337.866621333857, 13448.924086073092, 5875.4124587541755, 5887.411258874164, 5948.613340132878, 5950.345461999176, 5966.642001479839, 949.3971328206638, 961.0917682789697, 986.452518852044, 987.511181964932, 997.9550920208608, 22718.659220111713, 22997.0, 23851.880740596185, 23965.28104156878, 23972.801359931935, 972.9270304727174, 1027.9588816447408, 1078.7788503356794, 1127.881572434899, 1128.328644456547, 11858.466369013242, 12078.57724979639, 15250.084994900342, 15769.132697701736, 15917.0, 474534.0, 475862.0, 477678.0, 478270.0, 478721.0, 50680.23979640308, 51024.489755101975, 54211.72894135504, 54855.177172342446, 54990.350289491376, 1127.6786115956913, 1433.269032793283, 1466.4061055272632, 1471.2570152073135, 1472.9631759206106, 24104.035838566262, 27727.30681732973, 28109.156725297456, 28373.43253134967, 28896.7110328894, 37890.8105459471, 38228.80885595554, 38245.04387390338, 38393.80803095967, 38443.615563844, 488744.0, 490523.0, 490938.54530728544, 491284.0, 491443.0, 32531.837340813145, 33215.66784332126, 33352.33295334031, 33384.998450046536, 33441.82953596613, 40971.0, 41409.0, 41719.7914010428, 41872.581274186865, 41874.0, 25450.109246176296, 27957.64508259022, 28040.439191215653, 28931.566026509197, 29555.408891821615, 28495.857520712263, 29429.027081343746, 29626.555601666423, 29660.703392965796, 29668.851655741582, 34054.14864628305, 35072.47391289184, 35191.64808351986, 35241.64758352384, 35255.11862203363, 28763.568546472237, 28801.71198288074, 29557.408851822413, 29924.401511970074, 29940.550891737075, 22301.553968920205, 22745.772542275026, 23446.882765586062, 23698.05207791669, 23854.403639909142], "value": 17723.720043875037, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.54241054707984, 398.75078076202374, 419.54060303967145, 430.19553435076404, 448.0546047839059, 19885.0, 20526.2815801447, 21665.67501487477, 22038.669419958715, 22090.558188836214, 22260.220892268775, 22500.662490062623, 23028.8848555757, 23076.65385019222, 23222.767772322273, 5970.253718285204, 6257.499400048008, 6265.0915617235705, 6276.968615156918, 6277.5291853110975, 5887.587868849182, 6127.234095738033, 6127.816165515042, 6195.256569211679, 6204.317525072239, 5966.40335966402, 6136.938630613704, 6164.291106522763, 6173.969130154343, 6184.876302473948, 6117.724702388381, 6204.9689751551405, 6221.5333849961435, 6255.15555400022, 6257.217847769029, 5473.917891231635, 5485.451454854522, 5496.615236933416, 5518.19986102013, 5576.33084029915, 26187.869060654575, 26597.867010665017, 26644.73355266442, 26698.466030679472, 27078.0, 2049.0471930552217, 2059.4336557446823, 2070.523779530716, 2077.5637116205617, 2130.137294395772, 15425.845741542666, 16079.678406431924, 16485.34058637665, 16696.74954875678, 16827.15864206797, 1672.6069373697171, 1704.463094125359, 1711.0845697551874, 1735.4186347573577, 1777.3423833181675, 139417.9087313691, 151832.0, 152377.9999999989, 152561.0, 154595.22702386416, 10683.0, 10696.358218506915, 12592.4333404997, 12847.743045139232, 12952.352382381032, 13788.793168102486, 16577.41979030728, 16602.83397166037, 16618.50144495667, 16651.50045498637, 7036.331548502884, 9032.909670903207, 9032.909670903207, 9108.453492790453, 9305.162535371848, 8604.655813767504, 8724.382685194543, 8729.694460693845, 8888.822223555622, 8894.911050889537, 6569.967150164219, 7383.335499805044, 7898.433009271895, 7977.282044615897, 7997.800054998672, 1824.4070677029754, 1827.232562323827, 2054.9211663876285, 2106.315447479575, 2126.6070723676016, 856.7643897927995, 915.6108653822232, 937.6952490440634, 941.8728471656376, 969.7478655549467, 19842.801571984095, 20320.79679203189, 20758.377248682562, 20971.58056838885, 21221.257255995966, 934.3786382055993, 967.0451618017212, 996.1433167475965, 1003.8895721470633, 1004.251832384878, 9286.582103805345, 10666.0, 10770.976757208053, 10780.083692886035, 10787.190960677981, 723045.0, 726589.0, 735818.0, 750922.0, 753185.0, 134422.32788835993, 157015.21492392465, 164684.17657911874, 165167.0, 165801.68396632, 1016.2936758952604, 1197.167968262067, 1224.155332820351, 1240.7704574653717, 1245.726549047991, 17153.742693859353, 21038.89480552649, 21090.15639374469, 21188.179664343927, 21343.78656213418, 60444.69777651084, 60610.69694651499, 60984.0, 61235.0, 61322.46693832512, 63251.683741581, 68244.6587767058, 77143.0, 83479.0, 94829.0, 8380.95809520973, 8507.276881464897, 8630.78423039429, 8705.8694119587, 8933.28533717314, 13539.932300338436, 13592.388342524808, 13631.454741810216, 13979.860201397856, 14045.648858778612, 11694.0, 11818.749843792682, 11932.16474846787, 12024.33866137371, 12138.575149869712, 10371.118454931415, 10768.784624307627, 11083.50124244427, 11176.832347514957, 11265.943670281596, 10082.8487572685, 11783.17517773782, 11845.763084738084, 11976.700582485508, 12265.38673066361, 8349.081601024003, 8382.245597896219, 8580.14198580137, 8982.101789821227, 9049.728508144766, 11279.436028198394, 11580.305181689126, 11787.939085482347, 11822.586209482626, 11831.290122592673], "value": 10382.291507338297, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.269553093564, 1387.805707200992, 1390.84005339386, 1392.9442822287108, 1409.8449170591234, 10561.683149505508, 10795.028447439729, 11003.0, 11019.338839669625, 11097.944510277457, 10806.72983175421, 11065.114790816735, 11070.225084244086, 11089.667309980694, 11091.55633774648, 2444.217850287904, 2493.252024392675, 2493.30187547487, 2495.987520062397, 2502.5495410826043, 2341.590221711202, 2406.0736616402637, 2458.4222707663685, 2477.009196321477, 2479.876006199692, 2410.144398738449, 2435.7320694723567, 2438.366024833538, 2450.301664025753, 2455.2756936703627, 2372.4424760181346, 2410.7227668818045, 2419.346776370379, 2424.87875606219, 2470.5800013997664, 2298.2071185440996, 2372.1934542255717, 2436.671049408325, 2444.1934161726585, 2458.4714286428325, 9235.307351948632, 10952.945235273774, 11029.0, 11035.95158459945, 11043.226974111816, 6197.752089916398, 6363.427291543737, 6441.516886233504, 6460.3216662250725, 6461.61230326182, 3971.483707118085, 4004.599540046001, 4071.246819338432, 4104.035551645361, 4106.322456794655, 1171.94140292985, 1182.5565412970136, 1202.7594481103727, 1235.2526721333643, 1235.9505619775198, 13536.864631353757, 13887.02790804644, 15230.010049346756, 15325.386984520606, 15370.615734606725, 5270.789168433296, 5398.055340315429, 5444.972775136178, 5449.945500544944, 5474.124140137638, 11534.711632209093, 11573.363465009337, 11589.942050289694, 11598.420078996185, 11599.710007249887, 6107.267127944675, 6213.65824879627, 6321.514444105632, 6333.334999825044, 6354.046892966092, 5937.643741375531, 5939.584229104008, 6033.18551995475, 6036.396360363929, 6047.667378294236, 4276.657867370665, 4277.337012763027, 4298.2263192625005, 4320.3519472078815, 4325.848595299212, 1103.3986477369854, 1259.601841955447, 1275.3113318807925, 1295.8833704966598, 1296.6693493159373, 700.3731660164125, 732.2018999290799, 756.092688773474, 793.087948858817, 814.8207394373228, 5881.441263080001, 6005.939940600625, 6090.086487026982, 6194.566380353423, 6204.317525072239, 583.125312031952, 587.7942720048035, 772.9961350193213, 915.9129882661136, 938.8732521109699, 3350.815705136241, 3805.9153141355137, 4129.710920235615, 4265.1469706058915, 4309.547497512779, 13676.521321753691, 14206.0, 14217.50238741639, 14235.78646320306, 14245.501407450689, 13878.583642490741, 13945.023848330722, 14172.362243699059, 14189.716205675828, 14197.36111874968, 9834.950825245827, 10175.491225438698, 10186.949065254626, 10195.949020255, 10201.74495637615, 6403.711832967434, 6545.0, 6617.239017513048, 6724.4284235840505, 6881.827954300982, 12257.632271031884, 12470.189437686522, 12614.36928153607, 12620.621381358575, 12654.87345126537, 11770.941145294219, 11901.642950711492, 12105.213161144497, 12830.037747169186, 12941.417636206581, 8776.78058048554, 9063.954680226556, 9221.907780922373, 9229.630814767334, 9244.537773111451, 8289.709860154866, 10051.648192313234, 10081.647142349982, 10190.082892539707, 10199.235057370579, 7419.740309089156, 8548.829023419372, 8562.48625082497, 8756.956215218883, 8805.955970220108, 8498.32013438911, 8519.105493923049, 8625.784355391166, 8654.870176947225, 8673.696420625249, 6525.738970441129, 7844.4116691247245, 7863.606819658879, 7921.049474062919, 7942.364610831235, 5902.9072165972875, 5931.466168044896, 6030.427109424598, 6075.301340345917, 6163.537734669828, 5729.570282228933, 5838.2702162229725, 5988.610740301867, 6010.9699451502465, 6172.969135154295], "value": 5156.696232773222, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.38340954929413, 402.35623003194894, 402.8710812539987, 404.1190205352332, 405.62479706271694, 5803.912941305874, 6336.334684858087, 6416.6470844103615, 6442.7745028924, 6449.066858490189, 5707.429257074291, 5881.264841894763, 5997.88004239915, 6075.848103797407, 6248.718807653655, 4487.282034874429, 4864.197407427788, 4869.733869194018, 4890.5109489051165, 4890.535399137077, 4250.766207858566, 4778.713277203362, 4909.214525675875, 4918.336024636682, 4927.039227350668, 4810.542998415162, 4812.927806082912, 4818.542238487338, 4839.395075615548, 4840.9273860891935, 4328.588784065524, 4687.929681054787, 4774.665773395864, 4826.710397376169, 4828.7102773833685, 4244.236037513247, 4274.358846173068, 4276.3799249109015, 4284.550122237151, 4293.613574778254, 4586.88532786683, 5771.480566749013, 6079.875223083744, 6089.360617135181, 6144.446999770043, 4584.991301913574, 4915.0, 5137.7412533929055, 5159.922601160985, 5480.725498917945, 6556.409923106943, 6648.800535983928, 6670.999350097476, 6674.791873482692, 6825.249222585511, 3726.4782930389765, 3841.2125514269505, 3959.6436320730986, 4204.054087830214, 4471.441069866267, 5219.217117432378, 6583.604983700945, 6653.7005834737065, 6828.5902845829405, 7120.430365570794, 4283.2290187765875, 4409.911801763947, 4444.73331600105, 4452.487963884195, 4469.994251293433, 3772.0569857535615, 4079.9592004079577, 4396.296592545177, 4457.375967364572, 4530.07133537624, 4513.796879140446, 5149.742512874342, 5217.843464696065, 5304.496072873071, 5387.084195686664, 5005.449400565934, 6145.5638677200195, 6610.471162307004, 6645.800625981228, 6714.194296684332, 1490.411287541415, 1496.368957835964, 1576.7004269189047, 1581.6915701438338, 1584.2395650087792, 928.7399528132133, 935.3218916285774, 1032.2258306270298, 1033.8655974723238, 1038.6416686243233, 6277.52918531112, 6338.904916426257, 6341.175647165839, 6344.238691356974, 6364.745410183634, 6128.743607560439, 6169.722362493699, 6792.3886850182735, 7027.2242464227365, 7048.850100719227, 5372.91940620891, 5971.0, 6194.442500175006, 6302.653354065479, 6366.9681651591445, 3639.7816131032223, 3678.8528458861347, 3684.7604905681046, 3686.391745362039, 3696.611855755161, 6100.603460775035, 6321.65230912295, 6759.817032019377, 6857.074294970115, 7233.8553228935125, 6117.480014198754, 7309.451791115687, 7312.23221561739, 7339.0, 7340.743073992385, 6992.056072430157, 7188.6046267455795, 7252.637368131678, 7297.854042919218, 7300.744473943387, 7020.929790702027, 7045.894311585433, 7070.964645176947, 7099.396551293198, 7147.213806481179, 6754.628495432602, 6906.274841141608, 6930.13373328334, 6934.8613027740175, 6997.0, 5619.606627536034, 5945.40545945402, 6372.617642941438, 7211.855762884608, 7274.96362518184, 4527.388802511618, 4541.636669066401, 4549.9317510236715, 4552.476465206543, 4553.3800628501085, 5778.537716982715, 6822.3859852613505, 7077.009218709488, 7088.503804733619, 7104.822379440556, 6781.525293229624, 6790.898136528055, 6801.421879140131, 6817.0, 6850.314968503109, 5719.7426115824055, 6469.676516174267, 6817.625030623363, 6822.226221182429, 6853.383195512428, 5550.833474995757, 5729.570282228766, 5821.38875418075, 6641.568298060611, 6672.999050142517, 5599.580031497572, 6662.167229096363, 6805.727770889109, 6818.0, 6866.210385805496, 5960.910586341295, 6051.878962420815, 6442.8389290268115, 6612.404883560503, 6658.300878407697], "value": 4864.898781347446, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.1927865479406, 711.9145702515699, 728.6065524616707, 731.8975343451917, 738.9113306403231, 14665.780013299796, 15037.248137593131, 15366.769498457532, 15400.691986160284, 15500.612484687861, 13562.728745425085, 13577.117487363315, 13661.521846735366, 13818.0, 14146.292685365743, 918.485648037098, 937.0395344771596, 942.7737343037691, 943.7876477792511, 944.6976967370445, 911.7128104647015, 932.9207017403529, 936.8454205056191, 946.3186505715873, 957.5978089202551, 978.3787295067613, 988.2439933450916, 991.7570195302161, 994.3735446668588, 994.756284710247, 852.3351785607236, 989.2284018465608, 989.8861630912393, 989.990100098997, 990.1484723138095, 731.6159016516318, 736.0541703910503, 736.3483317264206, 737.2664199121855, 737.2737853214579, 15501.302441390164, 15909.761353579706, 15928.203589820463, 16198.271077801528, 16495.752563711554, 14622.780658290134, 14731.852681473156, 14757.704845903128, 14768.409263629443, 14802.703945921128, 11672.241304315192, 11677.941610291895, 11780.410979451079, 11962.641120766304, 12070.336131512764, 2962.8157679028336, 3018.24543864034, 3028.8334141622204, 3038.6353637563634, 3039.285767844555, 93051.0, 107184.46407767989, 109693.90306096917, 110202.3469647956, 112359.0, 11003.284786488852, 11373.374464404536, 11474.655760327203, 11701.414929253504, 11713.707157320965, 17028.48914532566, 24689.0, 24836.751632483807, 24876.626850597255, 24999.00003999856, 7634.198409167068, 7719.073711154698, 7742.187070357644, 7798.1811909749795, 7873.212678732196, 3931.233409485123, 3961.7622942622957, 3964.1278918637854, 4020.537638171589, 4035.616616421435, 4033.5361433434946, 4104.994276402301, 4140.60664236897, 4157.501099868035, 4170.687198460128, 843.7300063979468, 846.7290467050485, 848.4442690038035, 856.3791251342726, 868.2793281576277, 543.3479824210963, 545.9972700136553, 563.3859093588009, 595.3421469276387, 598.5181928547561, 9693.660721874701, 10154.087124821088, 10171.321731914299, 10430.791384172275, 10445.554167019285, 523.5966219572776, 549.8322713829166, 555.1783360626296, 579.6145563200424, 580.7212537981792, 4385.956140438619, 4457.888552786141, 4777.307290442866, 4836.188788563603, 4893.192623217201, 106235.88431635084, 107211.0, 107507.0, 108175.37736933952, 109294.0, 65795.35511612248, 73211.63394182995, 87474.56262718646, 92407.53796231111, 92887.0, 78341.21658783339, 79344.80982785263, 79534.602326988, 79948.60025699834, 80588.59705701552, 9300.56068980317, 9434.811303774024, 9458.43249405038, 9459.95270023673, 9497.620095196115, 39245.803770980965, 39792.60207397889, 39832.0, 40195.79412617626, 40379.59620403876, 50003.74998125132, 51060.0, 51460.0, 52043.0, 61250.0, 13183.340832958122, 13670.658233544242, 13734.313284335944, 14301.925086106537, 14490.710185796435, 14354.49759258421, 14442.566722998326, 14568.344424501134, 14641.487547936198, 14668.70662586721, 13631.167178630814, 13669.453221871014, 13802.240876751875, 14104.224267665377, 14125.081869678437, 13277.0, 13358.666033349244, 13745.175289482662, 14164.575062748134, 14224.715505690036, 13343.199408035549, 13385.263810490516, 13453.730925381242, 13822.101563398346, 14158.92920535432, 8614.65541378338, 9581.185599224144, 9599.712008639473, 9859.605615775288, 10370.325928814604, 7470.439717021137, 9892.477418258586, 10954.178436617445, 11297.71755706114, 11323.433828308716], "value": 7461.907709134934, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1597.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 117.0, 119.0, 116.0, 136.0, 153.0, 116.0, 116.0, 116.0], "value": 121.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 101.0, 181.0, 141.0, 120.0, 135.0, 142.0, 170.0, 100.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 263.0, 225.0, 240.0, 276.0, 192.0, 199.0, 196.0, 196.0, 199.0], "value": 220.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 62.0, 85.0, 111.0, 76.0, 62.0, 60.0, 51.0, 78.0, 51.0], "value": 71.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 82.0, 73.0, 72.0, 71.0, 84.0, 70.0, 73.0, 67.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 80.0, 136.0, 137.0, 105.0, 134.0, 76.0, 132.0, 135.0, 92.0], "value": 111.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 99.0, 97.0, 99.0, 97.0, 106.0, 112.0, 99.0, 98.0, 98.0], "value": 100.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 92.0, 114.0, 148.0, 96.0, 87.0, 147.0, 149.0, 91.0], "value": 110.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 74.0, 69.0, 58.0, 77.0, 90.0, 99.0, 74.0, 56.0], "value": 73.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 60.0, 67.0, 58.0, 72.0, 82.0, 77.0, 80.0, 79.0], "value": 69.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 78.0, 96.0, 98.0, 101.0, 108.0, 71.0, 74.0, 88.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 144.0, 142.0, 141.0, 144.0, 144.0, 160.0, 149.0, 199.0, 133.0], "value": 150.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [234.0, 230.0, 193.0, 194.0, 211.0, 189.0, 188.0, 183.0, 197.0, 202.0], "value": 202.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 70.0, 67.0, 70.0, 69.0, 57.0, 58.0, 59.0, 89.0], "value": 68.1, "unit": "score"}]}]} 04:39:12 INFO - Return code: 0 04:39:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:39:12 ERROR - # TBPL SUCCESS # 04:39:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:39:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:39:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:39:12 INFO - 2017-03-27 04:39:12.958 screenresolution[1662:10692] starting screenresolution argv=screenresolution get 04:39:12 INFO - 2017-03-27 04:39:12.961 screenresolution[1662:10692] Display 0: 1600x1200x32@60 04:39:12 INFO - 2017-03-27 04:39:12.967 screenresolution[1663:10695] starting screenresolution argv=screenresolution list 04:39:12 INFO - Available Modes on Display 0 04:39:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:39:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:39:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:39:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:39:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:39:13 INFO - Intel Iris: 04:39:13 INFO - Chipset Model: Intel Iris 04:39:13 INFO - Type: GPU 04:39:13 INFO - Bus: Built-In 04:39:13 INFO - VRAM (Dynamic, Max): 1536 MB 04:39:13 INFO - Vendor: Intel (0x8086) 04:39:13 INFO - Device ID: 0x0a2e 04:39:13 INFO - Revision ID: 0x0009 04:39:13 INFO - Displays: 04:39:13 INFO - Display: 04:39:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:39:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:39:13 INFO - Display Serial Number: 1600x1200 60 04:39:13 INFO - Main Display: Yes 04:39:13 INFO - Mirror: Off 04:39:13 INFO - Online: Yes 04:39:13 INFO - Rotation: Supported 04:39:13 INFO - Return code: 0 04:39:13 INFO - Running post-action listener: _resource_record_post_action 04:39:13 INFO - [mozharness: 2017-03-27 11:39:13.211541Z] Finished run-tests step (success) 04:39:13 INFO - Running post-run listener: _resource_record_post_run 04:39:13 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37988352; Write bytes: 516429824; Read time: 384; Write time: 2468 04:39:13 INFO - TinderboxPrint: CPU usage
54.2% 04:39:13 INFO - TinderboxPrint: I/O read bytes / time
37,988,352 / 384 04:39:13 INFO - TinderboxPrint: I/O write bytes / time
516,429,824 / 2,468 04:39:13 INFO - TinderboxPrint: CPU idle
2,204.4 (45.8%) 04:39:13 INFO - TinderboxPrint: CPU system
965.4 (20.1%) 04:39:13 INFO - TinderboxPrint: CPU user
1,639.8 (34.1%) 04:39:13 INFO - TinderboxPrint: Swap in / out
249,184,256 / 0 04:39:13 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 212775424; Write bytes: 213878272; Read time: 17006; Write time: 463 04:39:13 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 35698688; Write bytes: 301277696; Read time: 358; Write time: 2000 04:39:13 INFO - Running post-run listener: _upload_blobber_files 04:39:13 INFO - Blob upload gear active. 04:39:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:39:13 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 04:39:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:39:15 INFO - (blobuploader) - INFO - Open directory for files ... 04:39:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:39:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:39:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:18 INFO - (blobuploader) - INFO - Done attempting. 04:39:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:39:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:39:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:22 INFO - (blobuploader) - INFO - Done attempting. 04:39:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:39:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:39:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:25 INFO - (blobuploader) - INFO - Done attempting. 04:39:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:39:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:39:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:31 INFO - (blobuploader) - INFO - Done attempting. 04:39:31 INFO - (blobuploader) - INFO - Iteration through files over. 04:39:31 INFO - Return code: 0 04:39:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:39:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:39:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14f0bf859d2c6f079006fd31456d84702c00d87959623abe7c3de8a5f910ce47df5901e9a0e361e3caffb98ca5a2034ba737e061fb7627400d2a48034e8956bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb5a297f50366c7cdf24ca48dfde885645374279a16119e4fffe378a2dceff277767fc75e8c4613b8d480e557fe9ccabe0211d25d97fce0fdfdb2d859c24f68b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a692e5659212a225e58d61c4f8c429062dc2a1a906eed11ac567e5b566a346aea792fb3288ea227bb23afdac1b03015de2f10c7dbb28f540acaaf7a69a690b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68e0b8505744902ac6379e2e87321168a9c9d32444363d7af8ccb2371929f775e40366db1b8368201b8244569a7f4e952af8af26babd2e83e55216bc1d5de275"} 04:39:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:39:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:39:31 INFO - Contents: 04:39:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14f0bf859d2c6f079006fd31456d84702c00d87959623abe7c3de8a5f910ce47df5901e9a0e361e3caffb98ca5a2034ba737e061fb7627400d2a48034e8956bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb5a297f50366c7cdf24ca48dfde885645374279a16119e4fffe378a2dceff277767fc75e8c4613b8d480e557fe9ccabe0211d25d97fce0fdfdb2d859c24f68b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a692e5659212a225e58d61c4f8c429062dc2a1a906eed11ac567e5b566a346aea792fb3288ea227bb23afdac1b03015de2f10c7dbb28f540acaaf7a69a690b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68e0b8505744902ac6379e2e87321168a9c9d32444363d7af8ccb2371929f775e40366db1b8368201b8244569a7f4e952af8af26babd2e83e55216bc1d5de275"} 04:39:31 INFO - Running post-run listener: copy_logs_to_upload_dir 04:39:31 INFO - Copying logs to upload dir... 04:39:31 INFO - mkdir: /builds/slave/test/build/upload/logs 04:39:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1297.885842 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2017-03-27 04:39:31.745782) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 04:39:31.749845) ========= 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.2p3scKLJDZ/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.Vt2zdjYSIw/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14f0bf859d2c6f079006fd31456d84702c00d87959623abe7c3de8a5f910ce47df5901e9a0e361e3caffb98ca5a2034ba737e061fb7627400d2a48034e8956bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb5a297f50366c7cdf24ca48dfde885645374279a16119e4fffe378a2dceff277767fc75e8c4613b8d480e557fe9ccabe0211d25d97fce0fdfdb2d859c24f68b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a692e5659212a225e58d61c4f8c429062dc2a1a906eed11ac567e5b566a346aea792fb3288ea227bb23afdac1b03015de2f10c7dbb28f540acaaf7a69a690b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68e0b8505744902ac6379e2e87321168a9c9d32444363d7af8ccb2371929f775e40366db1b8368201b8244569a7f4e952af8af26babd2e83e55216bc1d5de275"} build_url:https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010988 build_url: 'https://queue.taskcluster.net/v1/task/Qfo7j77YQzeNWv8maZjXtA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14f0bf859d2c6f079006fd31456d84702c00d87959623abe7c3de8a5f910ce47df5901e9a0e361e3caffb98ca5a2034ba737e061fb7627400d2a48034e8956bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb5a297f50366c7cdf24ca48dfde885645374279a16119e4fffe378a2dceff277767fc75e8c4613b8d480e557fe9ccabe0211d25d97fce0fdfdb2d859c24f68b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a692e5659212a225e58d61c4f8c429062dc2a1a906eed11ac567e5b566a346aea792fb3288ea227bb23afdac1b03015de2f10c7dbb28f540acaaf7a69a690b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68e0b8505744902ac6379e2e87321168a9c9d32444363d7af8ccb2371929f775e40366db1b8368201b8244569a7f4e952af8af26babd2e83e55216bc1d5de275"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 04:39:31.784642) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:39:31.784980) ========= 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.2p3scKLJDZ/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.Vt2zdjYSIw/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.005251 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 04:39:31.833585) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 04:39:31.833919) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 04:39:31.834305) ========= ========= Total master_lag: 0.20 =========