builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0106 starttime: 1493872297.8 results: success (0) buildid: 20170503201922 builduid: ac67df80deed47a18214dc6749d92291 revision: 4a6a71f4aa22e4dc3961884ce505ce34bdd799a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 21:31:37.804771) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 21:31:37.805291) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 21:31:37.805611) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 21:31:37.833227) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:31:37.833608) ========= 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.gsShQHZFsi/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.Y2A8TvLAO4/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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-05-03 21:31:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.15M=0.001s 2017-05-03 21:31:38 (8.15 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124015 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:31:37.982716) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:31:37.983088) ========= 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.gsShQHZFsi/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.Y2A8TvLAO4/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.021557 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:31:38.032680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 21:31:38.033097) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4a6a71f4aa22e4dc3961884ce505ce34bdd799a2 --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 4a6a71f4aa22e4dc3961884ce505ce34bdd799a2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gsShQHZFsi/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.Y2A8TvLAO4/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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-05-03 21:31:38,147 truncating revision to first 12 chars 2017-05-03 21:31:38,148 Setting DEBUG logging. 2017-05-03 21:31:38,148 attempt 1/10 2017-05-03 21:31:38,148 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4a6a71f4aa22?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-03 21:31:39,178 unpacking tar archive at: mozilla-central-4a6a71f4aa22/testing/mozharness/ program finished with exit code 0 elapsedTime=1.289898 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 21:31:39.347319) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 21:31:39.347688) ========= script_repo_revision: 4a6a71f4aa22e4dc3961884ce505ce34bdd799a2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 21:31:39.348122) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 21:31:39.348526) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 21:31:39.369133) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2017-05-03 21:31:39.369461) ========= /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.gsShQHZFsi/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.Y2A8TvLAO4/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 21:31:39 INFO - MultiFileLogger online at 20170503 21:31:39 in /builds/slave/test 21:31:39 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 21:31:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:31:39 INFO - {'append_to_log': False, 21:31:39 INFO - 'base_work_dir': '/builds/slave/test', 21:31:39 INFO - 'blob_upload_branch': 'Firefox', 21:31:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:31:39 INFO - 'branch': 'Firefox', 21:31:39 INFO - 'buildbot_json_path': 'buildprops.json', 21:31:39 INFO - 'config_files': ('talos/mac_config.py',), 21:31:39 INFO - 'default_actions': ('clobber', 21:31:39 INFO - 'read-buildbot-config', 21:31:39 INFO - 'download-and-extract', 21:31:39 INFO - 'populate-webroot', 21:31:39 INFO - 'create-virtualenv', 21:31:39 INFO - 'install', 21:31:39 INFO - 'run-tests'), 21:31:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:31:39 INFO - 'download_minidump_stackwalk': True, 21:31:39 INFO - 'download_symbols': 'ondemand', 21:31:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:31:39 INFO - 'tooltool.py': '/tools/tooltool.py', 21:31:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:31:39 INFO - '/tools/misc-python/virtualenv.py')}, 21:31:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:31:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:31:39 INFO - 'gecko_profile': False, 21:31:39 INFO - 'gecko_profile_interval': 0, 21:31:39 INFO - 'installer_path': 'installer.exe', 21:31:39 INFO - 'log_level': 'info', 21:31:39 INFO - 'log_name': 'talos', 21:31:39 INFO - 'log_to_console': True, 21:31:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:31:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:31:39 INFO - 'opt_config_files': (), 21:31:39 INFO - 'pip_index': False, 21:31:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:31:39 INFO - 'cmd': ('bash', 21:31:39 INFO - '-c', 21:31:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:31:39 INFO - 'enabled': True, 21:31:39 INFO - 'halt_on_failure': False, 21:31:39 INFO - 'name': 'check_screen_resolution'},), 21:31:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:31:39 INFO - 'cmd': ('bash', 21:31:39 INFO - '-c', 21:31:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:31:39 INFO - 'enabled': True, 21:31:39 INFO - 'halt_on_failure': False, 21:31:39 INFO - 'name': 'check_screen_resolution'},), 21:31:39 INFO - 'run_cmd_checks_enabled': True, 21:31:39 INFO - 'suite': 'dromaeojs-e10s', 21:31:39 INFO - 'system_bits': '32', 21:31:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:31:39 INFO - 'title': 't-yosemite-r7-0106', 21:31:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:31:39 INFO - 'use_talos_json': True, 21:31:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:31:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:31:39 INFO - 'work_dir': 'build'} 21:31:39 INFO - [mozharness: 2017-05-04 04:31:39.610607Z] Running clobber step. 21:31:39 INFO - Running pre-action listener: _resource_record_pre_action 21:31:39 INFO - Running main action method: clobber 21:31:39 INFO - rmtree: /builds/slave/test/build 21:31:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:31:41 INFO - Running post-action listener: _resource_record_post_action 21:31:41 INFO - [mozharness: 2017-05-04 04:31:41.384624Z] Finished clobber step (success) 21:31:41 INFO - [mozharness: 2017-05-04 04:31:41.384753Z] Running read-buildbot-config step. 21:31:41 INFO - Running pre-action listener: _resource_record_pre_action 21:31:41 INFO - Running main action method: read_buildbot_config 21:31:41 INFO - Using buildbot properties: 21:31:41 INFO - { 21:31:41 INFO - "project": "", 21:31:41 INFO - "product": "firefox", 21:31:41 INFO - "script_repo_revision": "production", 21:31:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 21:31:41 INFO - "repository": "", 21:31:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 21:31:41 INFO - "buildid": "20170503201922", 21:31:41 INFO - "pgo_build": "False", 21:31:41 INFO - "basedir": "/builds/slave/test", 21:31:41 INFO - "buildnumber": 210, 21:31:41 INFO - "slavename": "t-yosemite-r7-0106", 21:31:41 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 21:31:41 INFO - "platform": "yosemite_r7", 21:31:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:31:41 INFO - "branch": "mozilla-central", 21:31:41 INFO - "repo_path": "mozilla-central", 21:31:41 INFO - "revision": "4a6a71f4aa22e4dc3961884ce505ce34bdd799a2", 21:31:41 INFO - "stage_platform": "macosx64", 21:31:41 INFO - "builduid": "ac67df80deed47a18214dc6749d92291", 21:31:41 INFO - "slavebuilddir": "test" 21:31:41 INFO - } 21:31:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 21:31:41 INFO - Running post-action listener: _resource_record_post_action 21:31:41 INFO - [mozharness: 2017-05-04 04:31:41.387970Z] Finished read-buildbot-config step (success) 21:31:41 INFO - [mozharness: 2017-05-04 04:31:41.388091Z] Running download-and-extract step. 21:31:41 INFO - Running pre-action listener: _resource_record_pre_action 21:31:41 INFO - Running main action method: download_and_extract 21:31:41 INFO - mkdir: /builds/slave/test/build/tests 21:31: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')]} 21:31:41 INFO - trying https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 21:31:41 INFO - Downloading https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/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 21:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/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 21:31:42 INFO - Downloaded 1325 bytes. 21:31:42 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 21:31:42 INFO - Using the following test package requirements: 21:31:42 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:31:42 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 21:31:42 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 21:31:42 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:31:42 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 21:31:42 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:31:42 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 21:31:42 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:31:42 INFO - u'jsshell-mac.zip'], 21:31:42 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:31:42 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 21:31:42 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 21:31:42 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:31:42 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 21:31:42 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:31:42 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 21:31:42 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:31:42 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 21:31:42 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:31:42 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 21:31:42 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:31:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 21:31:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:31:42 INFO - Fetch https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 21:31:43 INFO - Content-Length response header: 52700528 21:31:43 INFO - Bytes received: 52700528 21:32:00 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 21:32:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 21:32:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:32:00 INFO - Fetch https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 21:32:01 INFO - Content-Length response header: 52700528 21:32:01 INFO - Bytes received: 52700528 21:32:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 21:32:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:32:17 INFO - Fetch https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 21:32:18 INFO - Content-Length response header: 14408809 21:32:18 INFO - Bytes received: 14408809 21:32:19 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')]} 21:32:19 INFO - trying https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:32:19 INFO - Downloading https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 21:32:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/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 21:32:21 INFO - Downloaded 70883965 bytes. 21:32:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:32:21 INFO - mkdir: /builds/slave/test/properties 21:32:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:32:21 INFO - Writing to file /builds/slave/test/properties/build_url 21:32:21 INFO - Contents: 21:32:21 INFO - build_url:https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:32:21 INFO - Running post-action listener: _resource_record_post_action 21:32:21 INFO - Running post-action listener: set_extra_try_arguments 21:32:21 INFO - [mozharness: 2017-05-04 04:32:21.748748Z] Finished download-and-extract step (success) 21:32:21 INFO - [mozharness: 2017-05-04 04:32:21.748869Z] Running populate-webroot step. 21:32:21 INFO - Running pre-action listener: _resource_record_pre_action 21:32:21 INFO - Running main action method: populate_webroot 21:32:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:32:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:32:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:32:21 INFO - '--tppagecycles', 21:32:21 INFO - '7'], 21:32:21 INFO - 'tests': ['tsvgm']}}, 21:32:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:32:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:32:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:32:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:32:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:32:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:32:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:32:21 INFO - 'talos_options': ['--disable-e10s'], 21:32:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:32:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:32:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:32:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:32:21 INFO - 'talos_options': ['--disable-e10s'], 21:32:21 INFO - 'tests': ['damp', 'tps']}, 21:32:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:32:21 INFO - 'tests': ['damp', 'tps']}, 21:32:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:32:21 INFO - 'tests': ['dromaeo_dom']}, 21:32:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:32:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:32:21 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:32:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:32:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:32:21 INFO - 'tests': ['a11yr', 21:32:21 INFO - 'ts_paint', 21:32:21 INFO - 'tpaint', 21:32:21 INFO - 'sessionrestore', 21:32:21 INFO - 'sessionrestore_no_auto_restore', 21:32:21 INFO - 'tabpaint']}, 21:32:21 INFO - 'other-e10s': {'tests': ['a11yr', 21:32:21 INFO - 'ts_paint', 21:32:21 INFO - 'tpaint', 21:32:21 INFO - 'sessionrestore', 21:32:21 INFO - 'sessionrestore_no_auto_restore', 21:32:21 INFO - 'tabpaint']}, 21:32:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:32:21 INFO - 'ts_paint', 21:32:21 INFO - 'tpaint', 21:32:21 INFO - 'sessionrestore', 21:32:21 INFO - 'sessionrestore_no_auto_restore', 21:32:21 INFO - 'tabpaint']}, 21:32:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:32:21 INFO - 'ts_paint', 21:32:21 INFO - 'tpaint', 21:32:21 INFO - 'sessionrestore', 21:32:21 INFO - 'sessionrestore_no_auto_restore', 21:32:21 INFO - 'tabpaint']}, 21:32:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:32:21 INFO - 'tests': ['a11yr', 21:32:21 INFO - 'ts_paint', 21:32:21 INFO - 'tpaint', 21:32:21 INFO - 'sessionrestore', 21:32:21 INFO - 'sessionrestore_no_auto_restore', 21:32:21 INFO - 'tabpaint']}, 21:32:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:32:21 INFO - 'tests': ['a11yr', 21:32:21 INFO - 'ts_paint', 21:32:21 INFO - 'tpaint', 21:32:21 INFO - 'sessionrestore', 21:32:21 INFO - 'sessionrestore_no_auto_restore', 21:32:21 INFO - 'tabpaint']}, 21:32:21 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 21:32:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 21:32:21 INFO - 'bloom_basic_ref']}, 21:32:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:32:21 INFO - 'tests': ['tsvgx', 21:32:21 INFO - 'tsvgr_opacity', 21:32:21 INFO - 'tart', 21:32:21 INFO - 'tscrollx', 21:32:21 INFO - 'cart', 21:32:21 INFO - 'tsvg_static']}, 21:32:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:32:21 INFO - 'tsvgr_opacity', 21:32:21 INFO - 'tart', 21:32:21 INFO - 'tscrollx', 21:32:21 INFO - 'cart', 21:32:21 INFO - 'tsvg_static']}, 21:32:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:32:21 INFO - 'talos_options': ['--disable-e10s'], 21:32:21 INFO - 'tests': ['tp5o']}, 21:32:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:32:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:32:21 INFO - 'talos_options': ['--disable-e10s', 21:32:21 INFO - '--xperf_path', 21:32:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:32:21 INFO - 'tests': ['tp5n']}, 21:32:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:32:21 INFO - 'talos_options': ['--xperf_path', 21:32:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:32:21 INFO - 'tests': ['tp5n']}}, 21:32:21 INFO - 'talos.zip': {'path': '', 21:32:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:32:21 INFO - Running post-action listener: _resource_record_post_action 21:32:21 INFO - [mozharness: 2017-05-04 04:32:21.767642Z] Finished populate-webroot step (success) 21:32:21 INFO - [mozharness: 2017-05-04 04:32:21.767751Z] Running create-virtualenv step. 21:32:21 INFO - Running pre-action listener: _resource_record_pre_action 21:32:21 INFO - Running main action method: create_virtualenv 21:32:21 INFO - Creating virtualenv /builds/slave/test/build/venv 21:32:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:32:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:32:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:32:21 INFO - Using real prefix '/tools/python27' 21:32:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:32:22 INFO - Installing distribute.............................................................................................................................................................................................done. 21:32:25 INFO - Installing pip.................done. 21:32:25 INFO - Return code: 0 21:32:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:32:25 INFO - Reading from file tmpfile_stdout 21:32:25 INFO - Output received: 21:32:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:32:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe53157a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ffd30>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019f4be8>, '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.gsShQHZFsi/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.Y2A8TvLAO4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 21:32:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:32:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsShQHZFsi/Render', 21:32:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:25 INFO - 'HOME': '/Users/cltbld', 21:32:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:25 INFO - 'LOGNAME': 'cltbld', 21:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:25 INFO - 'MOZ_NO_REMOTE': '1', 21:32:25 INFO - 'NO_EM_RESTART': '1', 21:32:25 INFO - 'PAGER': '/bin/cat', 21:32:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:25 INFO - 'PWD': '/builds/slave/test', 21:32:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:25 INFO - 'SHELL': '/bin/bash', 21:32:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2A8TvLAO4/Listeners', 21:32:25 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 21:32:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:25 INFO - 'USER': 'cltbld', 21:32:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:25 INFO - 'XPC_FLAGS': '0x0', 21:32:25 INFO - 'XPC_SERVICE_NAME': '0', 21:32:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:32:25 INFO - Cleaning up... 21:32:25 INFO - Return code: 0 21:32:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe53157a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ffd30>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019f4be8>, '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.gsShQHZFsi/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.Y2A8TvLAO4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 21:32:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:32:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsShQHZFsi/Render', 21:32:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:25 INFO - 'HOME': '/Users/cltbld', 21:32:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:25 INFO - 'LOGNAME': 'cltbld', 21:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:25 INFO - 'MOZ_NO_REMOTE': '1', 21:32:25 INFO - 'NO_EM_RESTART': '1', 21:32:25 INFO - 'PAGER': '/bin/cat', 21:32:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:25 INFO - 'PWD': '/builds/slave/test', 21:32:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:25 INFO - 'SHELL': '/bin/bash', 21:32:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2A8TvLAO4/Listeners', 21:32:25 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 21:32:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:25 INFO - 'USER': 'cltbld', 21:32:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:25 INFO - 'XPC_FLAGS': '0x0', 21:32:25 INFO - 'XPC_SERVICE_NAME': '0', 21:32:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:26 INFO - Downloading/unpacking psutil>=3.1.1 21:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:32:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:32:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:32:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:32:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:32:28 INFO - Installing collected packages: psutil 21:32:28 INFO - Running setup.py install for psutil 21:32:28 INFO - building 'psutil._psutil_osx' extension 21:32:28 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 21:32:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 21:32:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 21:32:29 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 21:32:29 INFO - building 'psutil._psutil_posix' extension 21:32:29 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 21:32:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:32:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:32:29 INFO - ^ 21:32:29 INFO - 1 warning generated. 21:32:29 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 21:32:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:32:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:32:29 INFO - Successfully installed psutil 21:32:29 INFO - Cleaning up... 21:32:29 INFO - Return code: 0 21:32:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:32:29 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')]} 21:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:29 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')]} 21:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:29 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 0x101c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe53157a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ffd30>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019f4be8>, '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.gsShQHZFsi/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.Y2A8TvLAO4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 21:32:29 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 21:32:29 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 21:32:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsShQHZFsi/Render', 21:32:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:29 INFO - 'HOME': '/Users/cltbld', 21:32:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:29 INFO - 'LOGNAME': 'cltbld', 21:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:29 INFO - 'MOZ_NO_REMOTE': '1', 21:32:29 INFO - 'NO_EM_RESTART': '1', 21:32:29 INFO - 'PAGER': '/bin/cat', 21:32:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:29 INFO - 'PWD': '/builds/slave/test', 21:32:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:29 INFO - 'SHELL': '/bin/bash', 21:32:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2A8TvLAO4/Listeners', 21:32:29 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 21:32:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:29 INFO - 'USER': 'cltbld', 21:32:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:29 INFO - 'XPC_FLAGS': '0x0', 21:32:29 INFO - 'XPC_SERVICE_NAME': '0', 21:32:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:32:29 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 21:32:29 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 21:32:29 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 21:32:29 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 21:32:29 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 21:32:29 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 21:32:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:32:31 INFO - Installing collected packages: mozsystemmonitor 21:32:31 INFO - Running setup.py install for mozsystemmonitor 21:32:31 INFO - Successfully installed mozsystemmonitor 21:32:31 INFO - Cleaning up... 21:32:31 INFO - Return code: 0 21:32:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:32:31 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')]} 21:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:31 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')]} 21:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:32 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 0x101c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe53157a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ffd30>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019f4be8>, '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.gsShQHZFsi/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.Y2A8TvLAO4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 21:32:32 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 21:32:32 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 21:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsShQHZFsi/Render', 21:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:32 INFO - 'HOME': '/Users/cltbld', 21:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:32 INFO - 'LOGNAME': 'cltbld', 21:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:32 INFO - 'MOZ_NO_REMOTE': '1', 21:32:32 INFO - 'NO_EM_RESTART': '1', 21:32:32 INFO - 'PAGER': '/bin/cat', 21:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:32 INFO - 'PWD': '/builds/slave/test', 21:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:32 INFO - 'SHELL': '/bin/bash', 21:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2A8TvLAO4/Listeners', 21:32:32 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 21:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:32 INFO - 'USER': 'cltbld', 21:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:32 INFO - 'XPC_FLAGS': '0x0', 21:32:32 INFO - 'XPC_SERVICE_NAME': '0', 21:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:32 INFO - Downloading/unpacking jsonschema==2.5.1 21:32:32 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 21:32:32 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 21:32:32 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 21:32:32 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 21:32:32 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 21:32:32 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 21:32:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:32:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:32:34 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 21:32:34 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 21:32:34 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 21:32:34 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 21:32:34 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 21:32:34 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 21:32:34 INFO - Downloading functools32-3.2.3-2.tar.gz 21:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:32:34 INFO - warning: no files found matching '*.txt' 21:32:34 INFO - no previously-included directories found matching 'build' 21:32:34 INFO - no previously-included directories found matching 'dist' 21:32:34 INFO - no previously-included directories found matching '.git*' 21:32:34 INFO - Installing collected packages: jsonschema, functools32 21:32:34 INFO - Running setup.py install for functools32 21:32:34 INFO - warning: no files found matching '*.txt' 21:32:34 INFO - no previously-included directories found matching 'build' 21:32:34 INFO - no previously-included directories found matching 'dist' 21:32:34 INFO - no previously-included directories found matching '.git*' 21:32:34 INFO - Successfully installed jsonschema functools32 21:32:34 INFO - Cleaning up... 21:32:34 INFO - Return code: 0 21:32:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:32: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')]} 21:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32: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')]} 21:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe53157a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ffd30>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019f4be8>, '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.gsShQHZFsi/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.Y2A8TvLAO4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 21:32:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:32:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsShQHZFsi/Render', 21:32:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:34 INFO - 'HOME': '/Users/cltbld', 21:32:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:34 INFO - 'LOGNAME': 'cltbld', 21:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:34 INFO - 'MOZ_NO_REMOTE': '1', 21:32:34 INFO - 'NO_EM_RESTART': '1', 21:32:34 INFO - 'PAGER': '/bin/cat', 21:32:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:34 INFO - 'PWD': '/builds/slave/test', 21:32:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:34 INFO - 'SHELL': '/bin/bash', 21:32:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2A8TvLAO4/Listeners', 21:32:34 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 21:32:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:34 INFO - 'USER': 'cltbld', 21:32:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:34 INFO - 'XPC_FLAGS': '0x0', 21:32:34 INFO - 'XPC_SERVICE_NAME': '0', 21:32:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:32:35 INFO - Cleaning up... 21:32:35 INFO - Return code: 0 21:32:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:32:35 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')]} 21:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:35 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')]} 21:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:35 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 0x101c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe53157a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ffd30>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019f4be8>, '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.gsShQHZFsi/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.Y2A8TvLAO4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 21:32:35 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 21:32:35 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 21:32:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsShQHZFsi/Render', 21:32:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:35 INFO - 'HOME': '/Users/cltbld', 21:32:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:35 INFO - 'LOGNAME': 'cltbld', 21:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:35 INFO - 'MOZ_NO_REMOTE': '1', 21:32:35 INFO - 'NO_EM_RESTART': '1', 21:32:35 INFO - 'PAGER': '/bin/cat', 21:32:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:35 INFO - 'PWD': '/builds/slave/test', 21:32:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:35 INFO - 'SHELL': '/bin/bash', 21:32:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2A8TvLAO4/Listeners', 21:32:35 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 21:32:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:35 INFO - 'USER': 'cltbld', 21:32:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:35 INFO - 'XPC_FLAGS': '0x0', 21:32:35 INFO - 'XPC_SERVICE_NAME': '0', 21:32:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:35 INFO - Downloading/unpacking blobuploader==1.2.4 21:32:35 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 21:32:35 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 21:32:35 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 21:32:35 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 21:32:35 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 21:32:35 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 21:32:36 INFO - Downloading blobuploader-1.2.4.tar.gz 21:32:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:32:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:32:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:32:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:32:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:32:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:32:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:32:37 INFO - Downloading docopt-0.6.1.tar.gz 21:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:32:37 INFO - Installing collected packages: blobuploader, requests, docopt 21:32:37 INFO - Running setup.py install for blobuploader 21:32:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:32:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:32:37 INFO - Running setup.py install for requests 21:32:38 INFO - Running setup.py install for docopt 21:32:38 INFO - Successfully installed blobuploader requests docopt 21:32:38 INFO - Cleaning up... 21:32:38 INFO - Return code: 0 21:32:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:32:38 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')]} 21:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:38 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')]} 21:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:38 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 0x101c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe53157a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ffd30>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019f4be8>, '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.gsShQHZFsi/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.Y2A8TvLAO4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 21:32:38 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 21:32:38 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 21:32:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsShQHZFsi/Render', 21:32:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:38 INFO - 'HOME': '/Users/cltbld', 21:32:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:38 INFO - 'LOGNAME': 'cltbld', 21:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:38 INFO - 'MOZ_NO_REMOTE': '1', 21:32:38 INFO - 'NO_EM_RESTART': '1', 21:32:38 INFO - 'PAGER': '/bin/cat', 21:32:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:38 INFO - 'PWD': '/builds/slave/test', 21:32:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:38 INFO - 'SHELL': '/bin/bash', 21:32:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2A8TvLAO4/Listeners', 21:32:38 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 21:32:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:38 INFO - 'USER': 'cltbld', 21:32:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:38 INFO - 'XPC_FLAGS': '0x0', 21:32:38 INFO - 'XPC_SERVICE_NAME': '0', 21:32:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:32:38 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-tMG1Cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:32:38 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-JmFfSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:32:38 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-I9X6WX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:32:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-tXWDZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:32:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-GYynXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:32:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-93n_lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:32:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-cQu2N2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:32:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-2PSUmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:32:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-0vq5FT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:32:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-3H1w5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:32:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-akiNsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:32:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-rTUKio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:32:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-uhC9mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:32:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-ADWFPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:32:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-spe4tZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:32:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-qSRNK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:32:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-HrHpdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:32:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:32:40 INFO - Running setup.py install for manifestparser 21:32:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:32:40 INFO - Running setup.py install for mozcrash 21:32:40 INFO - Running setup.py install for mozdebug 21:32:40 INFO - Running setup.py install for mozdevice 21:32:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:32:41 INFO - Running setup.py install for mozfile 21:32:41 INFO - Running setup.py install for mozhttpd 21:32:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:32:41 INFO - Running setup.py install for mozinfo 21:32:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:32:41 INFO - Running setup.py install for mozInstall 21:32:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:32:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:32:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:32:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:32:41 INFO - Running setup.py install for mozleak 21:32:41 INFO - Running setup.py install for mozlog 21:32:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:32:41 INFO - Running setup.py install for moznetwork 21:32:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:32:42 INFO - Running setup.py install for mozprocess 21:32:42 INFO - Running setup.py install for mozprofile 21:32:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:32:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:32:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:32:42 INFO - Running setup.py install for mozrunner 21:32:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:32:42 INFO - Running setup.py install for mozscreenshot 21:32:42 INFO - Running setup.py install for moztest 21:32:42 INFO - Running setup.py install for mozversion 21:32:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:32:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:32:43 INFO - Cleaning up... 21:32:43 INFO - Return code: 0 21:32:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:32:43 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')]} 21:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:43 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')]} 21:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:43 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 0x101c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe53157a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ffd30>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019f4be8>, '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.gsShQHZFsi/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.Y2A8TvLAO4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 21:32:43 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 21:32:43 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 21:32:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsShQHZFsi/Render', 21:32:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:43 INFO - 'HOME': '/Users/cltbld', 21:32:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:43 INFO - 'LOGNAME': 'cltbld', 21:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:43 INFO - 'MOZ_NO_REMOTE': '1', 21:32:43 INFO - 'NO_EM_RESTART': '1', 21:32:43 INFO - 'PAGER': '/bin/cat', 21:32:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:43 INFO - 'PWD': '/builds/slave/test', 21:32:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:43 INFO - 'SHELL': '/bin/bash', 21:32:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2A8TvLAO4/Listeners', 21:32:43 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 21:32:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:43 INFO - 'USER': 'cltbld', 21:32:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:43 INFO - 'XPC_FLAGS': '0x0', 21:32:43 INFO - 'XPC_SERVICE_NAME': '0', 21:32:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:32:43 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-a7J_FE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:32:43 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)) 21:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:32:43 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-aLr13c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:32:43 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)) 21:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:32:43 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-MbaKkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:32:43 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)) 21:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:32:43 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-xxrym0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 21:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:32:43 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-2KJTTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:32:43 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)) 21:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:32:43 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-xWwW_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:32:43 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)) 21:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:32:43 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-_Jlw2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:32:44 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)) 21:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:32:44 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-SxvJ5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:32:44 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)) 21:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:32:44 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-fdfS13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:32:44 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)) 21:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:32:44 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-llv_Jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:32:44 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)) 21:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:32:44 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-sEsdBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:32:44 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)) 21:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:32:44 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-SukB6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:32:44 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)) 21:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:32:44 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-V0wJss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:32:44 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)) 21:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:32:44 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-cTRMjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:32:44 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)) 21:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:32:44 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-YNyTHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:32:44 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)) 21:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:32:44 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-AMbaHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:32:45 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)) 21:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:32:45 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Dbk93R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:32:45 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)) 21:32:45 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)) 21:32:45 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)) 21:32:45 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)) 21:32:45 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:32:45 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:32:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:32:45 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 21:32:45 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 21:32:45 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 21:32:45 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 21:32:45 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 21:32:45 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 21:32:46 INFO - Downloading blessings-1.6.tar.gz 21:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:32:46 INFO - Installing collected packages: blessings 21:32:46 INFO - Running setup.py install for blessings 21:32:46 INFO - Successfully installed blessings 21:32:46 INFO - Cleaning up... 21:32:46 INFO - Return code: 0 21:32:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:32:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:32:47 INFO - Reading from file tmpfile_stdout 21:32:47 INFO - Current package versions: 21:32:47 INFO - blessings == 1.6 21:32:47 INFO - blobuploader == 1.2.4 21:32:47 INFO - docopt == 0.6.1 21:32:47 INFO - functools32 == 3.2.3-2 21:32:47 INFO - jsonschema == 2.5.1 21:32:47 INFO - manifestparser == 1.1 21:32:47 INFO - mozInstall == 1.12 21:32:47 INFO - mozcrash == 1.0 21:32:47 INFO - mozdebug == 0.1 21:32:47 INFO - mozdevice == 0.50 21:32:47 INFO - mozfile == 1.2 21:32:47 INFO - mozhttpd == 0.7 21:32:47 INFO - mozinfo == 0.9 21:32:47 INFO - mozleak == 0.1 21:32:47 INFO - mozlog == 3.4 21:32:47 INFO - moznetwork == 0.27 21:32:47 INFO - mozprocess == 0.25 21:32:47 INFO - mozprofile == 0.28 21:32:47 INFO - mozrunner == 6.13 21:32:47 INFO - mozscreenshot == 0.1 21:32:47 INFO - mozsystemmonitor == 0.3 21:32:47 INFO - moztest == 0.8 21:32:47 INFO - mozversion == 1.4 21:32:47 INFO - psutil == 3.1.1 21:32:47 INFO - requests == 1.2.3 21:32:47 INFO - wsgiref == 0.1.2 21:32:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:47 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 0x101c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe53157a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ffd30>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019f4be8>, '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.gsShQHZFsi/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.Y2A8TvLAO4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 21:32:47 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 21:32:47 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 21:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsShQHZFsi/Render', 21:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:47 INFO - 'HOME': '/Users/cltbld', 21:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:47 INFO - 'LOGNAME': 'cltbld', 21:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:47 INFO - 'MOZ_NO_REMOTE': '1', 21:32:47 INFO - 'NO_EM_RESTART': '1', 21:32:47 INFO - 'PAGER': '/bin/cat', 21:32:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:47 INFO - 'PWD': '/builds/slave/test', 21:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:47 INFO - 'SHELL': '/bin/bash', 21:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2A8TvLAO4/Listeners', 21:32:47 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 21:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:47 INFO - 'USER': 'cltbld', 21:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:47 INFO - 'XPC_FLAGS': '0x0', 21:32:47 INFO - 'XPC_SERVICE_NAME': '0', 21:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:47 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)) 21:32:47 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)) 21:32:47 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)) 21:32:47 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)) 21:32:47 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)) 21:32:47 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)) 21:32:47 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)) 21:32:47 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)) 21:32:47 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)) 21:32:47 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)) 21:32:47 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)) 21:32:47 INFO - Cleaning up... 21:32:47 INFO - Return code: 0 21:32:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:47 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 0x101c21b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c24768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe53157a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ffd30>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019f4be8>, '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.gsShQHZFsi/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.Y2A8TvLAO4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 21:32:47 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 21:32:47 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 21:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsShQHZFsi/Render', 21:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:47 INFO - 'HOME': '/Users/cltbld', 21:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:47 INFO - 'LOGNAME': 'cltbld', 21:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:47 INFO - 'MOZ_NO_REMOTE': '1', 21:32:47 INFO - 'NO_EM_RESTART': '1', 21:32:47 INFO - 'PAGER': '/bin/cat', 21:32:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:47 INFO - 'PWD': '/builds/slave/test', 21:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:47 INFO - 'SHELL': '/bin/bash', 21:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2A8TvLAO4/Listeners', 21:32:47 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 21:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:47 INFO - 'USER': 'cltbld', 21:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:47 INFO - 'XPC_FLAGS': '0x0', 21:32:47 INFO - 'XPC_SERVICE_NAME': '0', 21:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:32:47 INFO - Cleaning up... 21:32:47 INFO - Return code: 0 21:32:47 INFO - Running post-action listener: _resource_record_post_action 21:32:47 INFO - Running post-action listener: _start_resource_monitoring 21:32:47 INFO - Starting resource monitoring. 21:32:47 INFO - [mozharness: 2017-05-04 04:32:47.609408Z] Finished create-virtualenv step (success) 21:32:47 INFO - [mozharness: 2017-05-04 04:32:47.610361Z] Running install step. 21:32:47 INFO - Running pre-action listener: _resource_record_pre_action 21:32:47 INFO - Running main action method: install 21:32:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:32:47 INFO - Reading from file tmpfile_stdout 21:32:47 INFO - Detecting whether we're running mozinstall >=1.0... 21:32:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:32:47 INFO - Reading from file tmpfile_stdout 21:32:47 INFO - Output received: 21:32:47 INFO - Usage: mozinstall [options] installer 21:32:47 INFO - Options: 21:32:47 INFO - -h, --help show this help message and exit 21:32:47 INFO - -d DEST, --destination=DEST 21:32:47 INFO - Directory to install application into. [default: 21:32:47 INFO - "/builds/slave/test"] 21:32:47 INFO - --app=APP Application being installed. [default: firefox] 21:32:47 INFO - mkdir: /builds/slave/test/build/application 21:32:47 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'] 21:32:47 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 21:33:07 INFO - Reading from file tmpfile_stdout 21:33:07 INFO - Output received: 21:33:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:33:07 INFO - Running post-action listener: _resource_record_post_action 21:33:07 INFO - [mozharness: 2017-05-04 04:33:07.338494Z] Finished install step (success) 21:33:07 INFO - [mozharness: 2017-05-04 04:33:07.338614Z] Running run-tests step. 21:33:07 INFO - Running pre-action listener: _resource_record_pre_action 21:33:07 INFO - Running main action method: run_tests 21:33:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:33:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:33:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:33:07 INFO - 2017-05-03 21:33:07.353 screenresolution[2293:26130] starting screenresolution argv=screenresolution get 21:33:07 INFO - 2017-05-03 21:33:07.356 screenresolution[2293:26130] Display 0: 1600x1200x32@60 21:33:07 INFO - 2017-05-03 21:33:07.360 screenresolution[2294:26132] starting screenresolution argv=screenresolution list 21:33:07 INFO - Available Modes on Display 0 21:33:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:33:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:33:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:33:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:33:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:33:07 INFO - Intel Iris: 21:33:07 INFO - Chipset Model: Intel Iris 21:33:07 INFO - Type: GPU 21:33:07 INFO - Bus: Built-In 21:33:07 INFO - VRAM (Dynamic, Max): 1536 MB 21:33:07 INFO - Vendor: Intel (0x8086) 21:33:07 INFO - Device ID: 0x0a2e 21:33:07 INFO - Revision ID: 0x0009 21:33:07 INFO - Displays: 21:33:07 INFO - Display: 21:33:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:33:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:33:07 INFO - Display Serial Number: 1600x1200 60 21:33:07 INFO - Main Display: Yes 21:33:07 INFO - Mirror: Off 21:33:07 INFO - Online: Yes 21:33:07 INFO - Rotation: Supported 21:33:07 INFO - Return code: 0 21:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:33:07 INFO - Python 2.7.3 21:33:07 INFO - Return code: 0 21:33:07 INFO - grabbing minidump binary from tooltool 21:33:07 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')]} 21:33:07 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 0x1019ffd30>, '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 0x101925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019f4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:33:07 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 21:33:07 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 21:33:07 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 21:33:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:33:07 INFO - Return code: 0 21:33:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:33:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:33:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:33:07 INFO - ENV: RUST_BACKTRACE is now 1 21:33:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:33:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 21:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0106 --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 21:33:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsShQHZFsi/Render', 21:33:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:33:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:33:07 INFO - 'HOME': '/Users/cltbld', 21:33:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:33:07 INFO - 'LOGNAME': 'cltbld', 21:33:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:33:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:07 INFO - 'MOZ_NO_REMOTE': '1', 21:33:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:33:07 INFO - 'NO_EM_RESTART': '1', 21:33:07 INFO - 'PAGER': '/bin/cat', 21:33:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:07 INFO - 'PWD': '/builds/slave/test', 21:33:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:33:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:33:07 INFO - 'RUST_BACKTRACE': '1', 21:33:07 INFO - 'SHELL': '/bin/bash', 21:33:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2A8TvLAO4/Listeners', 21:33:07 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 21:33:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:33:07 INFO - 'USER': 'cltbld', 21:33:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:33:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:07 INFO - 'XPC_FLAGS': '0x0', 21:33:07 INFO - 'XPC_SERVICE_NAME': '0', 21:33:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:33:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 21:33:07 INFO - mozversion application_buildid: 20170503201922 21:33:07 INFO - mozversion application_changeset: 4a6a71f4aa22e4dc3961884ce505ce34bdd799a2 21:33:07 INFO - mozversion application_display_name: Nightly 21:33:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:33:07 INFO - mozversion application_name: Firefox 21:33:07 INFO - mozversion application_remotingname: firefox 21:33:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:33:07 INFO - mozversion application_vendor: Mozilla 21:33:07 INFO - mozversion application_version: 55.0a1 21:33:07 INFO - mozversion platform_buildid: 20170503201922 21:33:07 INFO - mozversion platform_changeset: 4a6a71f4aa22e4dc3961884ce505ce34bdd799a2 21:33:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:33:07 INFO - mozversion platform_version: 55.0a1 21:33:07 INFO - using testdate: 1493872387 21:33:07 INFO - actual date: 1493872387 21:33:07 INFO - starting webserver on 'localhost:55856' 21:33:07 INFO - SUITE-START | Running 2 tests 21:33:07 INFO - TEST-START | dromaeo_css 21:33:07 INFO - operating with platform_type : mac_ 21:33:07 INFO - Initialising browser for dromaeo_css test... 21:33:07 INFO - TEST-INFO | started process 2304 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmp9_ghg7/profile http://localhost:55856/getInfo.html) 21:33:10 INFO - PID 2304 | 2017-05-03 21:33:10.617 plugin-container[2306:26309] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 21:33:10 INFO - PID 2304 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:33:10 INFO - PID 2304 | 2017-05-03 21:33:10.621 plugin-container[2306:26309] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9f0b, name = 'com.apple.CFPasteboardClient' 21:33:10 INFO - PID 2304 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:33:10 INFO - PID 2304 | 2017-05-03 21:33:10.622 plugin-container[2306:26309] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:33:10 INFO - PID 2304 | __metrics Screen width/height:1600/1200 21:33:10 INFO - PID 2304 | colorDepth:24 21:33:10 INFO - PID 2304 | Browser inner width/height: 1024/691 21:33:10 INFO - PID 2304 | __metrics 21:33:11 INFO - PID 2304 | 2017-05-03 21:33:11.176 plugin-container[2307:26362] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3f, name = 'com.apple.tsm.portname' 21:33:11 INFO - PID 2304 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:33:11 INFO - PID 2304 | 2017-05-03 21:33:11.177 plugin-container[2307:26362] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4423, name = 'com.apple.CFPasteboardClient' 21:33:11 INFO - PID 2304 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:33:11 INFO - PID 2304 | 2017-05-03 21:33:11.177 plugin-container[2307:26362] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:33:11 INFO - TEST-INFO | 2304: exit 0 21:33:11 INFO - Browser initialized. 21:33:11 INFO - Running cycle 1/1 for dromaeo_css test... 21:33:11 INFO - TEST-INFO | started process 2308 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmp9_ghg7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:33:14 INFO - PID 2308 | 2017-05-03 21:33:14.412 plugin-container[2309:26467] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x954f, name = 'com.apple.tsm.portname' 21:33:14 INFO - PID 2308 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:33:14 INFO - PID 2308 | 2017-05-03 21:33:14.413 plugin-container[2309:26467] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 21:33:14 INFO - PID 2308 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:33:14 INFO - PID 2308 | 2017-05-03 21:33:14.413 plugin-container[2309:26467] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:33:14 INFO - PID 2308 | 2017-05-03 21:33:14.856 plugin-container[2310:26509] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9243, name = 'com.apple.tsm.portname' 21:33:14 INFO - PID 2308 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:33:14 INFO - PID 2308 | 2017-05-03 21:33:14.857 plugin-container[2310:26509] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 21:33:14 INFO - PID 2308 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:33:14 INFO - PID 2308 | 2017-05-03 21:33:14.857 plugin-container[2310:26509] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:33:24 INFO - PID 2308 | RSS: Main: 234475520 21:33:24 INFO - PID 2308 | 21:36:27 INFO - PID 2308 | Cycle 1(1): loaded http://localhost:55856/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55856/tests/dromaeo/cssquery-ext.html) 21:36:29 INFO - PID 2308 | RSS: Main: 249651200 21:36:29 INFO - PID 2308 | 21:39:31 INFO - PID 2308 | Cycle 1(1): loaded http://localhost:55856/tests/dromaeo/cssquery-ext.html (next: http://localhost:55856/tests/dromaeo/cssquery-jquery.html) 21:39:31 INFO - PID 2308 | RSS: Main: 255082496 21:39:31 INFO - PID 2308 | 21:42:33 INFO - PID 2308 | Cycle 1(1): loaded http://localhost:55856/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55856/tests/dromaeo/cssquery-mootools.html) 21:42:33 INFO - PID 2308 | RSS: Main: 265887744 21:42:33 INFO - PID 2308 | 21:45:35 INFO - PID 2308 | Cycle 1(1): loaded http://localhost:55856/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55856/tests/dromaeo/cssquery-prototype.html) 21:45:36 INFO - PID 2308 | RSS: Main: 258555904 21:45:36 INFO - PID 2308 | 21:48:39 INFO - PID 2308 | Cycle 1(1): loaded http://localhost:55856/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55856/tests/dromaeo/cssquery-yui.html) 21:48:39 INFO - PID 2308 | RSS: Main: 262123520 21:48:39 INFO - PID 2308 | 21:51:41 INFO - PID 2308 | Cycle 1(1): loaded http://localhost:55856/tests/dromaeo/cssquery-yui.html (next: http://localhost:55856/tests/dromaeo/cssquery-dojo.html) 21:51:41 INFO - PID 2308 | RSS: Main: 260808704 21:51:41 INFO - PID 2308 | 21:51:41 INFO - PID 2308 | __start_tp_report 21:51:41 INFO - PID 2308 | _x_x_mozilla_page_load 21:51:41 INFO - PID 2308 | _x_x_mozilla_page_load_details 21:51:41 INFO - PID 2308 | |i|pagename|runs| 21:51:41 INFO - PID 2308 | |0;dojo.html;3083.3370825272564;3541.8229088545568;3575.1240945968243;3614.6204648511907;3618.638136186382;5345.7594408251625;6086.786962456309;6098.280951554085;6111.983045594949;6200.658963756991;6156.538259630534;6176.073588961658;6184.474319682821;6247.7813276535335;6256.562040657156;5001.874953126165;5260.789568417259;5389.946100538984;5415.268938693275;5430.5927055471;5518.6688798672;5538.363088244843;5539.639923404966;5560.944390556083;5601.915971260434;5347.839564813062;5457.399686034533;5457.727113644302;5492.176173573976;5493.642913210629;5473.7263136843;5482.342118945712;5491.066518691832;5508.862278443031;5511.118221084607;5424.620276580641;5434.402215756264;5444.265024221759;5445.292112025411;5452.91820622691;6132.141500189932;6162.0140777475835;6219.844503887393;6227;6263.342349053375;6402.23173219212;6530.216374035099;6548.410643042102;6603.669816509156;6659.600423974577;6733.595984240961;6754.358335958076;6757.797266082025;6768.221654509745;6775.322467753185;6220;6235.750569977241;6284.931561634533;6293.1504246927;6297.590656607306;6621.702023408958;6752.257251702309;6845.486588505882;6872.381485666314;6916.308369163144;6371.649559274192;6448.161738973903;6474.4496717778575;6484.481241500669;6594.307597702172;6686.665666716742;6786.117804685458;6793.796186114326;6810.216825065082;6833.829154271183;6627.635480048547;6655.234648015444;6670.132882725312;6677.432418244503;6680.0981867448245;5489.945100549024;6442.2591401989375;6511.479081673455;6566.67166641666;6694.430973367318;5275.024120537712;5294.364676238876;5316.9202461963105;5330.200469929541;5351.3578370595;3728.6271372862498;4695.859124226278;4716.3632909557455;4736.502667219961;4747.311639812208;6155.969220153871;6213.502919766408;6277.435030847246;6352.396522330371;6355.650439225887;6629.635370054693;6710.396064354134;6724.394804467622;6759.121314229119;6779.389854912983;6327.3988971047675;6329.177206963065;6338.112664227012;6349.777757778548;6358.936410635834;5907.261592300963;5918.822435326947;5936.079907614327;5945.702714864239;5957.642541447527;5724.713764311851;6691.665416729144;6811.250762416031;6955.339242771928;7031.578105313493;5821.650700957956;6621.404073633396;6768.424683901923;6774.4580433564215;6860.0738900247825;6962.686679099554;6979.8604027918145;7001.50989430735;7006.054182685476;7008.824779380557;5828.921649494857;6309.684515774285;6517.120188774645;6658.7336506539195;6698.430633396216;6741.52809303344;6766.086578311865;6816.693248803915;6816.829579260559;6845.623490708059;5125.589952803842;6374.872502549831;6438.323975982455;6586.2755096940255;6589.24223714279;6375.649339286384;6581.868362632625;6590.70341834609;6600.306967768315;6605.438537724347;6236.126942228001;6397.808065758035;6432.453241474527;6470.352964703492;6480.513961452815;6425.903611445926;6470.094186813944;6485.124508191334;6555.344465553407;6583.572067815577;6412.198475190601;6429.485641148791;6445.065465507569;6451.129097571956;6453.354664533509 21:51:41 INFO - PID 2308 | |1;ext.html;792.184050428059;824.3322908444161;852.126570265478;1211.103783200432;1284.1524593768115;35746;38825.805870970675;38960.41559376605;38970;38984;38900.416493752615;39260.214795704065;39293.41059884104;39298.803505982505;39317;7838.686452541891;8282.544460054694;8474;8479.788005299886;8501.022382426007;7611.467197296191;8578.270846978014;8582.828343433128;8584.785380365478;8585.098564650716;8529.061803201643;8535.658573657078;8537.231649151576;8593.742187734346;8609.354298427612;8510.446820956618;8560.657573697044;8563.143685631449;8579.184977427165;8579.571021448934;8323.12729635827;8324.875126873041;8377.874331885027;8383.664653413856;8409.789755256106;31522.52716209259;37816.81091594552;37977.81011094927;38014.61985380166;38142.283597238194;3595.3168897909577;3632.8183590820354;3636.690881275095;3637.8181090945614;3650.5619325680823;30475.628596713203;30567.69432305671;30813.383732325226;30828.38343233145;30840.074797756104;2703.7296270373004;3165.7942233754734;3166.8733250669948;3176.8252746098956;3204.6314673812576;229283;245614;249569;269830.999999998;298773.5061324701;49236.50763492319;49351.25973110406;49547.752261238464;49570;49855.0028999418;51185;51519.22721159185;51683.22475162875;51746.48253517417;51788.223176652384;13862.514811981533;13978.930105349407;14086.859131408759;14090.929545352412;14123;11376.715582110348;11504.367259800623;11517.48171332292;11536.019438347666;11564.710882228012;13605.659858503617;13714.0400171987;13715.45138194481;13731.794023089662;13872.861271387359;4945.7141143303;5821.563382746311;5832.212651292106;5876.177335173079;5929.288485381696;996.8953259907605;1013.5489707080426;1036.6889933020063;1066.3814987307344;1068.983965240522;21884.45288867759;23008.884955575115;24221.63667544988;24270.87864560666;24472.510549789262;1127.7067962329688;1135.6990397544491;1138.618562781461;1163.1973937982764;1165.182315587686;10678.1991350649;12270.141090123605;12330.260184388966;12340.136190466761;12363.876361236453;320091;321953.3902330473;322112;322129;323365;54652;54833.903321933336;55129;55146.72426637841;55376;1472.536151112396;1497.5806774103487;1536.3086611025083;1543.9459618913284;1547.1877264436262;18027.549311267325;23898.64152037686;24008;24027.27918162458;24998.875005624854;32590.51114233336;37482.50069997169;38110.8094459537;38221;38426;283261;283924;284387.57806210837;284840;285408;34438.48342274918;34469.310613787085;35873.28253434969;35936;35949;43946.78026609847;44795.32807007832;46077.53922460866;46400.53599463962;46402.53597464117;24844.503109937337;30528.931487397833;30893.845530772203;31331.37337253288;31440.685593143775;27742.583861241696;30929.381412372077;31058.844705776326;31247.218819529695;31319.43402829895;38010.95912326952;38031.239375211786;38071.61928380681;38073.80963095167;38173.80913095417;24012;24314.635280470455;28754.904395331512;30063.69936300609;32443.513347299337;23019.309420717404;23739.1691290804;24857.92558930404;24926.750732492445;24945.875270623532 21:51:41 INFO - PID 2308 | |2;jquery.html;415.4972483295213;435.9529521914681;437.3265171635681;446.2012996735842;462.9282461218512;19452.805471945278;21084.051217695203;21743.782562174372;21946.45133871654;21971.450713732145;21833.454163645918;22687.432814179654;22711.772882271172;22963.19628812992;23333.183338583152;5193.065248255312;5992.340842507331;6245.188125543673;6361.642743221686;6384.680765961683;6074.96962515189;6276.780312689057;6310.368963103699;6317.210348706411;6344.270408902966;6228.283747369065;6241.65670888101;6274.309825919146;6280.685965701719;6284.71718772654;5371.704556249405;6101.9389806102035;6275.68621568922;6277.497800175975;6299.055141728754;4722.362481065046;5388.353397592314;5474.808381706661;5556.361018482886;5592.0773072443;27179.320516987034;27293.72706272932;27884.442311153663;28018;28098.578521321993;2233.7766223377694;2285.5771682238674;2291.5302363015544;2296.3684986628646;2299.1033496936043;17842.10789460522;17992.460226193234;18144.4556663299;18256.269749210147;18434;2158.4819643285655;2188.6060509108356;2233.8101261392803;2235.284708893155;2242.473018840571;153520.23239883842;153993.46006539903;154228;155026;156822;12155.270683759003;12737.36313184337;12763.872361276453;12773.297468639128;12820.80768788469;16378.26297816601;16562.668746625;16602.83397166037;16628.919120257146;16633.750493742602;8836.116388361112;9026.86459703105;9030.413023153475;9123.361364704408;9157.679481218258;8622;8630.82738345242;8659.826803463895;8788.8681669775;8805.987311459265;7932;8042.718504852302;8043.517388956681;8070.717524886601;8084;2164.686120512517;2177.074743234119;2182.33438801164;2182.705334779816;2196.890155492251;910.8770316007386;920.6455514626783;988.2094324540338;1014.4572653630272;1022.616518805448;21144.78855211459;21511.46221344479;21648.78351216499;21755.80343081146;21932.561348772935;1025.1183981775666;1043.2123746571442;1043.956043956044;1059.1791361694748;1072.651388298806;9896.653617123366;11099.667009989713;11130.332180069221;11152.944235278772;11177.049950754114;554565;557499;559079;561631;567146;129332.0600190998;131978;134118;137217;139770.30114849564;1198.9460474278678;1236.4744983382027;1247.3451437995125;1250.5498020712537;1250.612310183864;21448.571028579652;22278.331650050524;22834;22881.542369152856;22955.77044229603;56428;57457.425425745205;57703;58282.7085864568;58737.4126258749;80426.59786701029;80563;80892.78660819975;81348.37303253783;82238.35523289621;8922;8953.238974687225;9082.40964337316;9116.270698343984;9120.498372589305;13885.930570347084;14013.5095271665;14046;14200.431982720576;14288.714225715636;9578.473183974947;9665.855012174683;11466.082713382742;12149.514019439477;12208.511659533518;9025.729228123168;9802.85295720579;11287.322760634388;11370.43147842588;11453.083753299883;11932.463039163085;11956.282623042645;12098.03215742756;12164.148509604596;12200.877991219973;8683.956580217058;8846.601902914255;8936;8937.89959359563;8980.910190898006;11647.59233426826;11942.507186601675;11964.282143071443;11979.76040479203;12084.274943503418 21:51:41 INFO - PID 2308 | |3;mootools.html;1249.5813902342716;1301.0502333296688;1463.6999415119908;1488.8213414390275;1490.6198919275587;11189.944050279757;11399.886001139987;11895.940520297409;11924.344161071138;11946.701332466693;11561.306321620708;11729.70675733107;11777.941110294458;11779.469923853425;11935.58225462109;2500.4749002709455;2531.936701582457;2539.961900571493;2542.478791847667;2549.5665736824785;2467.4078221226955;2512.4095837478176;2515.874206289678;2515.949681006379;2522.583773677341;2472;2489.7136829264687;2523.49530093981;2525.0783464035585;2531.860747658878;2051.200031987526;2219.8456802462792;2446.7675570820743;2471.7157526884457;2479.962800557984;2398.3764221302586;2473.0973194783955;2491.327341617753;2529.620556916459;2533.733957934409;11666.183367164302;11740.882591174064;11749.588764393291;11751.529938802438;11774.468489274846;6619.834504137387;6782.932170678279;6842.247352791189;6850.349216824394;6859.622720750357;4000.759954402716;4326.891827704332;4372.562743725602;4377.430933978594;4398.076403955173;1239.2997956154743;1262.1228246368778;1301.1412467771227;1307.7711400504872;1311.5344052861287;15245.237738113161;15722.371105155666;16586.419475318427;16748.41380551687;16752.078635675032;5364.81973965727;5609.943900561024;5822.621529600562;5834.3290521589715;5853.180554722342;10334.431606261727;11793;11799.646010619523;11879.346635934933;11893.762124757457;6538.051982462516;6602.075709400688;6618.7021584028835;6629.436497897636;6632.502562307846;6056.788012419544;6123.938760612336;6206.348333425016;6262.058761783862;6292.905606415908;3694.150345420568;4258.914821703549;4417.072414792865;4436.534163912807;4479.059397526491;1269.7016201192712;1293.204679122333;1293.9158954667917;1308.8822006019504;1311.4229738914846;798.865610832619;803.9799005024804;813.8616435205911;817.4196320612313;842.3892677808662;4990;6166.7224974876235;6189.907151392733;6436.645984470805;6518.57629254097;547.7644612816448;572.9312482502127;574.4341823304043;577.0680351232812;581.9621724587888;4219.97890010548;4328.091100868853;4453.910921781546;4488.663350248745;4565.566271204297;11087.33475991443;12393.62819115428;14553.927230363992;15110.035695359753;15135.621609459851;12930.577636459982;14995.025323353948;15090.849091508944;15142.924285378724;15209.923950380176;8583.39916205872;8696.608652610521;8698.434601750992;8700.60847261862;8711.21599056088;6270.278917924497;7005.404540614105;7240.746573869889;7285.23505031964;7320.15818180916;13434.261115638343;13516.79724804109;13657.795133072814;13658.521951731642;13694.863051369359;13775.035747497579;13856.653583660085;13886.861131388558;13990.810781083723;14217.64455888611;9178;9448.574814133242;9456.243500520079;9482.85775713351;9484;10536.10443112344;10682.198835087243;10739.731506712395;10777.838332425177;10910.181736369645;9234.676786312446;9277.907220927704;9291.256699463891;9375;9457.858132127885;8666.396716607447;8915.375923685539;9019.233365163773;9061.728148155566;9112;6971.5468494547695;7146.64266786669;8189.303909167787;8349.039860415887;8373.874391884248;6024.90962635552;6036.396360363929;6145.8156255312415;6205.6586887721605;6216.098665693358;5495.807646732345;5899;5947.375525569926;6124.418180272867;6390.616563006234 21:51:41 INFO - PID 2308 | |4;prototype.html;346.70183642067803;405.61061381074165;409.23473105293107;411.93720201879154;422.0946070678395;6121.877562448748;6157.384261573846;6348.460380867632;6384.201974753156;6394.904076438851;5662.5753068519925;6159.661218632985;6221.40896614822;6251.6874156292115;6290.21372328459;4803.742241146655;4804.951950480486;4823.4435749053055;4847.733374664392;4852.902941941159;4235.53409124996;4657.20827459331;4752.334673145762;4827.927581086269;4854.56308932196;4599.655025873073;4785.569298763111;4793.041391721652;4825.951740482603;4830.71015739055;4168.228877657628;4393.912121757547;4771.522847715235;4781.282807578874;4863.319135321058;3999.560048394674;4236.661067114624;4304.7632380219075;4307.418498502693;4320.611144996934;5174.835661976025;5302.390225124122;6142.8771424571705;6183.072539119124;6228.532860035471;4966.553010229097;5528.226048353234;5737.856553586152;5750.597458177929;5789.652620842763;5614.522765564931;6708.12794336738;6726.562773419712;6794.490413219029;6825.35159159884;4366.345048242789;4640.280756482751;4881.95118048822;4919.852404427873;4925.3350797642215;6606.900896486556;6767.35710107539;7065.230969095891;7111.395531379839;7155.749548765768;3851.614838516126;5064.41759197697;5071.163258062452;5078.238264260391;5098.643094983389;4340.891477713082;5183.896322073538;5188.507091826346;5193.37679478465;5213.661112027706;5033.899322013539;5494.478024587658;5671.602987790815;5718.456746609066;5795.362510123883;5341.946580534222;6137.5703700741415;6467.253841462779;6719.462443004548;6719.764808231688;1597.8734991830731;1738.9217485213196;1762.175731387265;1790.3644206306833;1791.4983804534752;1097.5554900265406;1102.20090434436;1209.0629761934572;1227.8035514317844;1233.6730766346925;5097.719625420637;5471.7264136793;5954.404559544011;6049.727762250709;6342.619442833445;5421.728913554307;5672.688002159838;6966.79099627012;7058.61177635235;7063.823404414828;5469.398366179717;6318.336574659595;6319.377458354823;6323.407402964763;6345.270293916166;3514.8242587870504;3595.8381872815785;3627.4196128619296;3635.927281454409;3641.7997010164695;7162.068931038932;7168.856622867514;7173.067501224912;7201.675924583406;7240.312170343809;6562.77030303937;6864.24493305736;7112.857742845114;7199.496035277481;7214.891776623354;7252.41980641558;7284.635768211462;7349.742759003409;7354.926450735531;7355.963220183865;6953.061336719478;7049.519600883872;7078.823029424306;7114.039604653305;7145.928540714526;5730.484256416942;6830.7553911891455;6850.0409942607075;6866.588004719732;6891.862162756817;5985.311689155803;6047.969760151171;7261.709531618887;7298.78137131932;7330.926690733025;3698.1139618794073;3824.847006119724;3989.9626097214355;4310.116426132573;4529.00361920377;5843.769826005786;6151;6689;6986.231514533296;7001.404880585207;5457.590680698884;6378.938109707459;6419.4864410846085;6669.733210671713;6701.798946031627;5931.703414829328;6588.40704336612;6722.361375669304;6722.394984451227;6746.414592570643;5205.776642489088;6349.904751428639;6575.2767195607485;6607.702653380513;6647.235567909753;5650.689212093374;5904.202932604044;6825.761098361533;6827.89758153638;6857.074294970115;6484.967575162283;6631.502637302126;6642.202935647753;6649.700763465559;6662.933370666231 21:51:41 INFO - PID 2308 | |5;yui.html;832.8750687396894;842.8609279468892;847.7326397036431;854.3891117850737;876.4259410086394;13751.587452376432;16642;16647.417340393087;18253.36113236037;18845.905770471163;17771.289148434047;17953;18080.186391612377;18163.545911352223;18352.541186470313;1004.8442491413842;1023.7542989682497;1025.6410256410234;1028.9485525723721;1031.1183937733242;1011.2971484818055;1019.7450637340664;1021.6679579136774;1024.7182024943127;1030.3766221436;1079.098952374768;1090.345792524483;1091.5961094395084;1092.3336764573603;1097.8517900083507;1073.098597178374;1090.2749671468503;1090.3294473898575;1090.5092708281227;1092.9071028962549;777.7550071727388;779.4894344204498;801.7915342011061;805.8025783682976;807.4065561812064;16722.498325050266;16764.748528772077;16821.41125060617;16954;16968.98186108825;16978.83021169785;17114.743278850827;17243.79293449459;17421.041842698647;17458;13737.24445155516;13754.724905501835;14065.71868562623;14103.294835258299;14103.942204334613;3390.237196630763;3445.207602251471;3464.2725027744204;3464.566929133858;3469.1847415857255;104464;137507;138499.61252905973;139343;141170;13173;13193.670158245928;13276.601701948957;13287.601371958857;13422.865771342162;23792;23816.40458988539;25628;25885.35286617812;26038.609420858702;7514.812129696801;7538.509996850187;7575.318221360104;7614.466987310835;7620.847583048308;3785.9242815143543;3862.478565393692;3863.130795570974;3866.8066596670055;3871.806409679561;4223.894402639959;4244.787760612019;4262.7655478948955;4311.913761724811;4319.568043195718;860.5310105992249;871.8212766383003;876.268315956171;877.4165180155126;881.9735407937773;651.2705769538147;663.5288944849211;663.9734410623618;677.7085853083222;691.3328637864485;10706.678799636024;11212.225360250617;11323;11447;11708.473118709679;644.5681393466389;653.8855700252436;658.3876994395163;674.254948282151;683.5010442377093;4746;5148.150555158357;5269.947300527022;5340.75966581497;5472.151816468374;97681;99760;108704.4564777171;109125.90489141195;111079;76600.61699691466;80844.19155808366;84360.57819710985;85349.86625334417;87191;69423.65288173629;83397.16602834016;84358;84458;84740.57629711812;9251.537423128952;10140.83380411262;10455.895441045492;12051.397430128634;12215.755684886075;38605.84182474418;38927.6107238924;39147.80426097851;39242;39578.60421395749;56617.71691141683;61499.69250153899;80761.19238807536;81653.05948994402;82135.17864821514;15471.458498952483;15847.207639617742;16092.839071609134;16102.597435063748;16381.754273685667;17004.234809433357;17079.658406831546;17817.1982260796;17914.91042544831;18075.548111296797;16956.49130526086;17175.398861039805;17280;17304.48086557355;17562.648747024734;14843.92578037146;17379.826201738328;17662.470125896245;17750.644987099928;17798.733019004467;15104.54686359411;16062.43781467643;16389.262483188046;17175.398861039805;17237;10120;10979.945100274448;11422.371769552423;11750;11945.581904633644;12543.87456125427;13044.478220871439;13515.137967861156;13723.313834308445;14044.157350558999 21:51:41 INFO - PID 2308 | __end_tp_report 21:51:41 INFO - PID 2308 | __start_cc_report 21:51:41 INFO - PID 2308 | _x_x_mozilla_cycle_collect,409 21:51:41 INFO - PID 2308 | __end_cc_report 21:51:41 INFO - PID 2308 | __startTimestamp1493873501721__endTimestamp 21:51:41 INFO - PID 2308 | 21:51:41 INFO - PID 2308 | ------- Summary: start ------- 21:51:41 INFO - PID 2308 | Number of tests: 6 21:51:41 INFO - PID 2308 | 21:51:41 INFO - PID 2308 | [#0] dojo.html Cycles:165 Average:6132.03 Median:6371.65 stddev:752.39 (11.8%) stddev-sans-first:715.68 21:51:41 INFO - PID 2308 | Values: 3083.3 3541.8 3575.1 3614.6 3618.6 5345.8 6086.8 6098.3 6112.0 6200.7 6156.5 6176.1 6184.5 6247.8 6256.6 5001.9 5260.8 5389.9 5415.3 5430.6 5518.7 5538.4 5539.6 5560.9 5601.9 5347.8 5457.4 5457.7 5492.2 5493.6 5473.7 5482.3 5491.1 5508.9 5511.1 5424.6 5434.4 5444.3 5445.3 5452.9 6132.1 6162.0 6219.8 6227.0 6263.3 6402.2 6530.2 6548.4 6603.7 6659.6 6733.6 6754.4 6757.8 6768.2 6775.3 6220.0 6235.8 6284.9 6293.2 6297.6 6621.7 6752.3 6845.5 6872.4 6916.3 6371.6 6448.2 6474.4 6484.5 6594.3 6686.7 6786.1 6793.8 6810.2 6833.8 6627.6 6655.2 6670.1 6677.4 6680.1 5489.9 6442.3 6511.5 6566.7 6694.4 5275.0 5294.4 5316.9 5330.2 5351.4 3728.6 4695.9 4716.4 4736.5 4747.3 6156.0 6213.5 6277.4 6352.4 6355.7 6629.6 6710.4 6724.4 6759.1 6779.4 6327.4 6329.2 6338.1 6349.8 6358.9 5907.3 5918.8 5936.1 5945.7 5957.6 5724.7 6691.7 6811.3 6955.3 7031.6 5821.7 6621.4 6768.4 6774.5 6860.1 6962.7 6979.9 7001.5 7006.1 7008.8 5828.9 6309.7 6517.1 6658.7 6698.4 6741.5 6766.1 6816.7 6816.8 6845.6 5125.6 6374.9 6438.3 6586.3 6589.2 6375.6 6581.9 6590.7 6600.3 6605.4 6236.1 6397.8 6432.5 6470.4 6480.5 6425.9 6470.1 6485.1 6555.3 6583.6 6412.2 6429.5 6445.1 6451.1 6453.4 21:51:41 INFO - PID 2308 | 21:51:41 INFO - PID 2308 | [#1] ext.html Cycles:180 Average:44206.01 Median:177904.26 stddev:75960.65 (42.7%) stddev-sans-first:76103.80 21:51:41 INFO - PID 2308 | Values: 792.2 824.3 852.1 1211.1 1284.2 35746.0 38825.8 38960.4 38970.0 38984.0 38900.4 39260.2 39293.4 39298.8 39317.0 7838.7 8282.5 8474.0 8479.8 8501.0 7611.5 8578.3 8582.8 8584.8 8585.1 8529.1 8535.7 8537.2 8593.7 8609.4 8510.4 8560.7 8563.1 8579.2 8579.6 8323.1 8324.9 8377.9 8383.7 8409.8 31522.5 37816.8 37977.8 38014.6 38142.3 3595.3 3632.8 3636.7 3637.8 3650.6 30475.6 30567.7 30813.4 30828.4 30840.1 2703.7 3165.8 3166.9 3176.8 3204.6 229283.0 245614.0 249569.0 269831.0 298773.5 49236.5 49351.3 49547.8 49570.0 49855.0 51185.0 51519.2 51683.2 51746.5 51788.2 13862.5 13978.9 14086.9 14090.9 14123.0 11376.7 11504.4 11517.5 11536.0 11564.7 13605.7 13714.0 13715.5 13731.8 13872.9 4945.7 5821.6 5832.2 5876.2 5929.3 996.9 1013.5 1036.7 1066.4 1069.0 21884.5 23008.9 24221.6 24270.9 24472.5 1127.7 1135.7 1138.6 1163.2 1165.2 10678.2 12270.1 12330.3 12340.1 12363.9 320091.0 321953.4 322112.0 322129.0 323365.0 54652.0 54833.9 55129.0 55146.7 55376.0 1472.5 1497.6 1536.3 1543.9 1547.2 18027.5 23898.6 24008.0 24027.3 24998.9 32590.5 37482.5 38110.8 38221.0 38426.0 283261.0 283924.0 284387.6 284840.0 285408.0 34438.5 34469.3 35873.3 35936.0 35949.0 43946.8 44795.3 46077.5 46400.5 46402.5 24844.5 30528.9 30893.8 31331.4 31440.7 27742.6 30929.4 31058.8 31247.2 31319.4 38011.0 38031.2 38071.6 38073.8 38173.8 24012.0 24314.6 28754.9 30063.7 32443.5 23019.3 23739.2 24857.9 24926.8 24945.9 21:51:41 INFO - PID 2308 | 21:51:41 INFO - PID 2308 | [#2] jquery.html Cycles:180 Average:36268.60 Median:12586.54 stddev:94998.67 (754.8%) stddev-sans-first:95227.02 21:51:41 INFO - PID 2308 | Values: 415.5 436.0 437.3 446.2 462.9 19452.8 21084.1 21743.8 21946.5 21971.5 21833.5 22687.4 22711.8 22963.2 23333.2 5193.1 5992.3 6245.2 6361.6 6384.7 6075.0 6276.8 6310.4 6317.2 6344.3 6228.3 6241.7 6274.3 6280.7 6284.7 5371.7 6101.9 6275.7 6277.5 6299.1 4722.4 5388.4 5474.8 5556.4 5592.1 27179.3 27293.7 27884.4 28018.0 28098.6 2233.8 2285.6 2291.5 2296.4 2299.1 17842.1 17992.5 18144.5 18256.3 18434.0 2158.5 2188.6 2233.8 2235.3 2242.5 153520.2 153993.5 154228.0 155026.0 156822.0 12155.3 12737.4 12763.9 12773.3 12820.8 16378.3 16562.7 16602.8 16628.9 16633.8 8836.1 9026.9 9030.4 9123.4 9157.7 8622.0 8630.8 8659.8 8788.9 8806.0 7932.0 8042.7 8043.5 8070.7 8084.0 2164.7 2177.1 2182.3 2182.7 2196.9 910.9 920.6 988.2 1014.5 1022.6 21144.8 21511.5 21648.8 21755.8 21932.6 1025.1 1043.2 1044.0 1059.2 1072.7 9896.7 11099.7 11130.3 11152.9 11177.0 554565.0 557499.0 559079.0 561631.0 567146.0 129332.1 131978.0 134118.0 137217.0 139770.3 1198.9 1236.5 1247.3 1250.5 1250.6 21448.6 22278.3 22834.0 22881.5 22955.8 56428.0 57457.4 57703.0 58282.7 58737.4 80426.6 80563.0 80892.8 81348.4 82238.4 8922.0 8953.2 9082.4 9116.3 9120.5 13885.9 14013.5 14046.0 14200.4 14288.7 9578.5 9665.9 11466.1 12149.5 12208.5 9025.7 9802.9 11287.3 11370.4 11453.1 11932.5 11956.3 12098.0 12164.1 12200.9 8684.0 8846.6 8936.0 8937.9 8980.9 11647.6 11942.5 11964.3 11979.8 12084.3 21:51:41 INFO - PID 2308 | 21:51:41 INFO - PID 2308 | [#3] mootools.html Cycles:180 Average:7079.08 Median:3847.46 stddev:4454.60 (115.8%) stddev-sans-first:4445.56 21:51:41 INFO - PID 2308 | Values: 1249.6 1301.1 1463.7 1488.8 1490.6 11189.9 11399.9 11895.9 11924.3 11946.7 11561.3 11729.7 11777.9 11779.5 11935.6 2500.5 2531.9 2540.0 2542.5 2549.6 2467.4 2512.4 2515.9 2515.9 2522.6 2472.0 2489.7 2523.5 2525.1 2531.9 2051.2 2219.8 2446.8 2471.7 2480.0 2398.4 2473.1 2491.3 2529.6 2533.7 11666.2 11740.9 11749.6 11751.5 11774.5 6619.8 6782.9 6842.2 6850.3 6859.6 4000.8 4326.9 4372.6 4377.4 4398.1 1239.3 1262.1 1301.1 1307.8 1311.5 15245.2 15722.4 16586.4 16748.4 16752.1 5364.8 5609.9 5822.6 5834.3 5853.2 10334.4 11793.0 11799.6 11879.3 11893.8 6538.1 6602.1 6618.7 6629.4 6632.5 6056.8 6123.9 6206.3 6262.1 6292.9 3694.2 4258.9 4417.1 4436.5 4479.1 1269.7 1293.2 1293.9 1308.9 1311.4 798.9 804.0 813.9 817.4 842.4 4990.0 6166.7 6189.9 6436.6 6518.6 547.8 572.9 574.4 577.1 582.0 4220.0 4328.1 4453.9 4488.7 4565.6 11087.3 12393.6 14553.9 15110.0 15135.6 12930.6 14995.0 15090.8 15142.9 15209.9 8583.4 8696.6 8698.4 8700.6 8711.2 6270.3 7005.4 7240.7 7285.2 7320.2 13434.3 13516.8 13657.8 13658.5 13694.9 13775.0 13856.7 13886.9 13990.8 14217.6 9178.0 9448.6 9456.2 9482.9 9484.0 10536.1 10682.2 10739.7 10777.8 10910.2 9234.7 9277.9 9291.3 9375.0 9457.9 8666.4 8915.4 9019.2 9061.7 9112.0 6971.5 7146.6 8189.3 8349.0 8373.9 6024.9 6036.4 6145.8 6205.7 6216.1 5495.8 5899.0 5947.4 6124.4 6390.6 21:51:41 INFO - PID 2308 | 21:51:41 INFO - PID 2308 | [#4] prototype.html Cycles:180 Average:5466.61 Median:5917.95 stddev:1668.13 (28.2%) stddev-sans-first:1627.94 21:51:41 INFO - PID 2308 | Values: 346.7 405.6 409.2 411.9 422.1 6121.9 6157.4 6348.5 6384.2 6394.9 5662.6 6159.7 6221.4 6251.7 6290.2 4803.7 4805.0 4823.4 4847.7 4852.9 4235.5 4657.2 4752.3 4827.9 4854.6 4599.7 4785.6 4793.0 4826.0 4830.7 4168.2 4393.9 4771.5 4781.3 4863.3 3999.6 4236.7 4304.8 4307.4 4320.6 5174.8 5302.4 6142.9 6183.1 6228.5 4966.6 5528.2 5737.9 5750.6 5789.7 5614.5 6708.1 6726.6 6794.5 6825.4 4366.3 4640.3 4882.0 4919.9 4925.3 6606.9 6767.4 7065.2 7111.4 7155.7 3851.6 5064.4 5071.2 5078.2 5098.6 4340.9 5183.9 5188.5 5193.4 5213.7 5033.9 5494.5 5671.6 5718.5 5795.4 5341.9 6137.6 6467.3 6719.5 6719.8 1597.9 1738.9 1762.2 1790.4 1791.5 1097.6 1102.2 1209.1 1227.8 1233.7 5097.7 5471.7 5954.4 6049.7 6342.6 5421.7 5672.7 6966.8 7058.6 7063.8 5469.4 6318.3 6319.4 6323.4 6345.3 3514.8 3595.8 3627.4 3635.9 3641.8 7162.1 7168.9 7173.1 7201.7 7240.3 6562.8 6864.2 7112.9 7199.5 7214.9 7252.4 7284.6 7349.7 7354.9 7356.0 6953.1 7049.5 7078.8 7114.0 7145.9 5730.5 6830.8 6850.0 6866.6 6891.9 5985.3 6048.0 7261.7 7298.8 7330.9 3698.1 3824.8 3990.0 4310.1 4529.0 5843.8 6151.0 6689.0 6986.2 7001.4 5457.6 6378.9 6419.5 6669.7 6701.8 5931.7 6588.4 6722.4 6722.4 6746.4 5205.8 6349.9 6575.3 6607.7 6647.2 5650.7 5904.2 6825.8 6827.9 6857.1 6485.0 6631.5 6642.2 6649.7 6662.9 21:51:41 INFO - PID 2308 | 21:51:41 INFO - PID 2308 | [#5] yui.html Cycles:180 Average:22164.12 Median:17760.97 stddev:31639.66 (178.1%) stddev-sans-first:31687.88 21:51:41 INFO - PID 2308 | Values: 832.9 842.9 847.7 854.4 876.4 13751.6 16642.0 16647.4 18253.4 18845.9 17771.3 17953.0 18080.2 18163.5 18352.5 1004.8 1023.8 1025.6 1028.9 1031.1 1011.3 1019.7 1021.7 1024.7 1030.4 1079.1 1090.3 1091.6 1092.3 1097.9 1073.1 1090.3 1090.3 1090.5 1092.9 777.8 779.5 801.8 805.8 807.4 16722.5 16764.7 16821.4 16954.0 16969.0 16978.8 17114.7 17243.8 17421.0 17458.0 13737.2 13754.7 14065.7 14103.3 14103.9 3390.2 3445.2 3464.3 3464.6 3469.2 104464.0 137507.0 138499.6 139343.0 141170.0 13173.0 13193.7 13276.6 13287.6 13422.9 23792.0 23816.4 25628.0 25885.4 26038.6 7514.8 7538.5 7575.3 7614.5 7620.8 3785.9 3862.5 3863.1 3866.8 3871.8 4223.9 4244.8 4262.8 4311.9 4319.6 860.5 871.8 876.3 877.4 882.0 651.3 663.5 664.0 677.7 691.3 10706.7 11212.2 11323.0 11447.0 11708.5 644.6 653.9 658.4 674.3 683.5 4746.0 5148.2 5269.9 5340.8 5472.2 97681.0 99760.0 108704.5 109125.9 111079.0 76600.6 80844.2 84360.6 85349.9 87191.0 69423.7 83397.2 84358.0 84458.0 84740.6 9251.5 10140.8 10455.9 12051.4 12215.8 38605.8 38927.6 39147.8 39242.0 39578.6 56617.7 61499.7 80761.2 81653.1 82135.2 15471.5 15847.2 16092.8 16102.6 16381.8 17004.2 17079.7 17817.2 17914.9 18075.5 16956.5 17175.4 17280.0 17304.5 17562.6 14843.9 17379.8 17662.5 17750.6 17798.7 15104.5 16062.4 16389.3 17175.4 17237.0 10120.0 10979.9 11422.4 11750.0 11945.6 12543.9 13044.5 13515.1 13723.3 14044.2 21:51:41 INFO - PID 2308 | -------- Summary: end -------- 21:51:41 INFO - PID 2308 | 21:51:42 INFO - TEST-INFO | 2308: exit 0 21:51:42 INFO - TEST-OK | dromaeo_css | took 1114389ms 21:51:42 INFO - TEST-START | kraken 21:51:42 INFO - operating with platform_type : mac_ 21:51:42 INFO - Initialising browser for kraken test... 21:51:42 INFO - TEST-INFO | started process 2314 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpH2gUBb/profile http://localhost:55856/getInfo.html) 21:51:44 INFO - PID 2314 | 2017-05-03 21:51:44.956 plugin-container[2315:28556] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 21:51:44 INFO - PID 2314 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:51:44 INFO - PID 2314 | 2017-05-03 21:51:44.960 plugin-container[2315:28556] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 21:51:44 INFO - PID 2314 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:51:44 INFO - PID 2314 | 2017-05-03 21:51:44.960 plugin-container[2315:28556] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:51:45 INFO - PID 2314 | __metrics Screen width/height:1600/1200 21:51:45 INFO - PID 2314 | colorDepth:24 21:51:45 INFO - PID 2314 | Browser inner width/height: 1024/691 21:51:45 INFO - PID 2314 | __metrics 21:51:45 INFO - PID 2314 | 2017-05-03 21:51:45.495 plugin-container[2316:28609] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 21:51:45 INFO - PID 2314 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:51:45 INFO - PID 2314 | 2017-05-03 21:51:45.496 plugin-container[2316:28609] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 21:51:45 INFO - PID 2314 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:51:45 INFO - PID 2314 | 2017-05-03 21:51:45.496 plugin-container[2316:28609] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:51:46 INFO - TEST-INFO | 2314: exit 0 21:51:46 INFO - Browser initialized. 21:51:46 INFO - Running cycle 1/1 for kraken test... 21:51:46 INFO - TEST-INFO | started process 2317 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpH2gUBb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:51:48 INFO - PID 2317 | 2017-05-03 21:51:48.603 plugin-container[2318:28716] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 21:51:48 INFO - PID 2317 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:51:48 INFO - PID 2317 | 2017-05-03 21:51:48.604 plugin-container[2318:28716] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 21:51:48 INFO - PID 2317 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:51:48 INFO - PID 2317 | 2017-05-03 21:51:48.604 plugin-container[2318:28716] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:51:49 INFO - PID 2317 | 2017-05-03 21:51:49.127 plugin-container[2319:28760] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 21:51:49 INFO - PID 2317 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:51:49 INFO - PID 2317 | 2017-05-03 21:51:49.127 plugin-container[2319:28760] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.CFPasteboardClient' 21:51:49 INFO - PID 2317 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:51:49 INFO - PID 2317 | 2017-05-03 21:51:49.127 plugin-container[2319:28760] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:51:58 INFO - PID 2317 | RSS: Main: 234172416 21:51:58 INFO - PID 2317 | 21:52:01 INFO - PID 2317 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55856/tests/kraken/driver.html?testName=audio-beat-detection) 21:52:02 INFO - PID 2317 | RSS: Main: 246579200 21:52:02 INFO - PID 2317 | 21:52:04 INFO - PID 2317 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55856/tests/kraken/driver.html?testName=audio-dft) 21:52:05 INFO - PID 2317 | RSS: Main: 255041536 21:52:05 INFO - PID 2317 | 21:52:08 INFO - PID 2317 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55856/tests/kraken/driver.html?testName=audio-fft) 21:52:09 INFO - PID 2317 | RSS: Main: 257597440 21:52:09 INFO - PID 2317 | 21:52:11 INFO - PID 2317 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55856/tests/kraken/driver.html?testName=audio-oscillator) 21:52:11 INFO - PID 2317 | RSS: Main: 258842624 21:52:11 INFO - PID 2317 | 21:52:13 INFO - PID 2317 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55856/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:52:14 INFO - PID 2317 | RSS: Main: 260579328 21:52:14 INFO - PID 2317 | 21:52:17 INFO - PID 2317 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55856/tests/kraken/driver.html?testName=imaging-darkroom) 21:52:17 INFO - PID 2317 | RSS: Main: 266399744 21:52:17 INFO - PID 2317 | 21:52:21 INFO - PID 2317 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55856/tests/kraken/driver.html?testName=imaging-desaturate) 21:52:21 INFO - PID 2317 | RSS: Main: 267907072 21:52:21 INFO - PID 2317 | 21:52:24 INFO - PID 2317 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55856/tests/kraken/driver.html?testName=json-parse-financial) 21:52:25 INFO - PID 2317 | RSS: Main: 267067392 21:52:25 INFO - PID 2317 | 21:52:26 INFO - PID 2317 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55856/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:52:27 INFO - PID 2317 | RSS: Main: 266235904 21:52:27 INFO - PID 2317 | 21:52:29 INFO - PID 2317 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55856/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:52:29 INFO - PID 2317 | RSS: Main: 266256384 21:52:29 INFO - PID 2317 | 21:52:32 INFO - PID 2317 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55856/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:52:32 INFO - PID 2317 | RSS: Main: 265818112 21:52:32 INFO - PID 2317 | 21:52:35 INFO - PID 2317 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:52:36 INFO - PID 2317 | RSS: Main: 265895936 21:52:36 INFO - PID 2317 | 21:52:39 INFO - PID 2317 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:52:40 INFO - PID 2317 | RSS: Main: 266235904 21:52:40 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | Cycle 1(1): loaded http://localhost:55856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55856/tests/kraken/driver.html?testName=ai-astar) 21:52:41 INFO - PID 2317 | RSS: Main: 268193792 21:52:41 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | __start_tp_report 21:52:41 INFO - PID 2317 | _x_x_mozilla_page_load 21:52:41 INFO - PID 2317 | _x_x_mozilla_page_load_details 21:52:41 INFO - PID 2317 | |i|pagename|runs| 21:52:41 INFO - PID 2317 | |0;ai-astar;114;167;166;113;114;113;113;114;116;119 21:52:41 INFO - PID 2317 | |1;audio-beat-detection;149;108;111;156;111;110;109;114;156;148 21:52:41 INFO - PID 2317 | |2;audio-dft;197;204;200;225;211;202;200;202;203;197 21:52:41 INFO - PID 2317 | |3;audio-fft;82;57;56;82;58;58;68;85;84;56 21:52:41 INFO - PID 2317 | |4;audio-oscillator;93;69;87;79;99;99;106;103;68;89 21:52:41 INFO - PID 2317 | |5;imaging-gaussian-blur;87;89;88;88;89;86;88;88;88;87 21:52:41 INFO - PID 2317 | |6;imaging-darkroom;104;153;141;97;99;96;96;95;96;95 21:52:41 INFO - PID 2317 | |7;imaging-desaturate;92;95;92;90;91;90;89;93;121;143 21:52:41 INFO - PID 2317 | |8;json-parse-financial;50;50;52;53;49;61;75;77;73;72 21:52:41 INFO - PID 2317 | |9;json-stringify-tinderbox;56;63;63;63;64;61;56;58;58;59 21:52:41 INFO - PID 2317 | |10;stanford-crypto-aes;87;86;105;108;84;90;88;87;85;85 21:52:41 INFO - PID 2317 | |11;stanford-crypto-ccm;130;137;138;138;139;160;134;167;190;170 21:52:41 INFO - PID 2317 | |12;stanford-crypto-pbkdf2;180;184;188;187;187;186;183;200;192;221 21:52:41 INFO - PID 2317 | |13;stanford-crypto-sha256-iterative;75;64;71;62;63;67;68;71;69;79 21:52:41 INFO - PID 2317 | __end_tp_report 21:52:41 INFO - PID 2317 | __start_cc_report 21:52:41 INFO - PID 2317 | _x_x_mozilla_cycle_collect,962 21:52:41 INFO - PID 2317 | __end_cc_report 21:52:41 INFO - PID 2317 | __startTimestamp1493873561948__endTimestamp 21:52:41 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | ------- Summary: start ------- 21:52:41 INFO - PID 2317 | Number of tests: 14 21:52:41 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | [#0] ai-astar Cycles:10 Average:124.90 Median:115.00 stddev:22.00 (19.1%) stddev-sans-first:22.98 21:52:41 INFO - PID 2317 | Values: 114.0 167.0 166.0 113.0 114.0 113.0 113.0 114.0 116.0 119.0 21:52:41 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:131.00 stddev:21.76 (16.6%) stddev-sans-first:21.60 21:52:41 INFO - PID 2317 | Values: 149.0 108.0 111.0 156.0 111.0 110.0 109.0 114.0 156.0 148.0 21:52:41 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | [#2] audio-dft Cycles:10 Average:204.10 Median:202.50 stddev:8.36 (4.1%) stddev-sans-first:8.46 21:52:41 INFO - PID 2317 | Values: 197.0 204.0 200.0 225.0 211.0 202.0 200.0 202.0 203.0 197.0 21:52:41 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | [#3] audio-fft Cycles:10 Average:68.60 Median:75.00 stddev:13.09 (17.5%) stddev-sans-first:12.96 21:52:41 INFO - PID 2317 | Values: 82.0 57.0 56.0 82.0 58.0 58.0 68.0 85.0 84.0 56.0 21:52:41 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:88.00 stddev:13.52 (15.4%) stddev-sans-first:14.27 21:52:41 INFO - PID 2317 | Values: 93.0 69.0 87.0 79.0 99.0 99.0 106.0 103.0 68.0 89.0 21:52:41 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:88.00 stddev:0.92 (1.0%) stddev-sans-first:0.93 21:52:41 INFO - PID 2317 | Values: 87.0 89.0 88.0 88.0 89.0 86.0 88.0 88.0 88.0 87.0 21:52:41 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | [#6] imaging-darkroom Cycles:10 Average:107.20 Median:96.00 stddev:21.33 (22.2%) stddev-sans-first:22.59 21:52:41 INFO - PID 2317 | Values: 104.0 153.0 141.0 97.0 99.0 96.0 96.0 95.0 96.0 95.0 21:52:41 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | [#7] imaging-desaturate Cycles:10 Average:99.60 Median:91.50 stddev:17.93 (19.6%) stddev-sans-first:18.80 21:52:41 INFO - PID 2317 | Values: 92.0 95.0 92.0 90.0 91.0 90.0 89.0 93.0 121.0 143.0 21:52:41 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:66.50 stddev:11.77 (17.7%) stddev-sans-first:11.77 21:52:41 INFO - PID 2317 | Values: 50.0 50.0 52.0 53.0 49.0 61.0 75.0 77.0 73.0 72.0 21:52:41 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:62.00 stddev:3.07 (5.0%) stddev-sans-first:2.88 21:52:41 INFO - PID 2317 | Values: 56.0 63.0 63.0 63.0 64.0 61.0 56.0 58.0 58.0 59.0 21:52:41 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:86.50 stddev:8.63 (10.0%) stddev-sans-first:9.06 21:52:41 INFO - PID 2317 | Values: 87.0 86.0 105.0 108.0 84.0 90.0 88.0 87.0 85.0 85.0 21:52:41 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | [#11] stanford-crypto-ccm Cycles:10 Average:150.30 Median:149.50 stddev:20.06 (13.4%) stddev-sans-first:19.89 21:52:41 INFO - PID 2317 | Values: 130.0 137.0 138.0 138.0 139.0 160.0 134.0 167.0 190.0 170.0 21:52:41 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.80 Median:187.50 stddev:11.93 (6.4%) stddev-sans-first:12.00 21:52:41 INFO - PID 2317 | Values: 180.0 184.0 188.0 187.0 187.0 186.0 183.0 200.0 192.0 221.0 21:52:41 INFO - PID 2317 | 21:52:41 INFO - PID 2317 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:70.00 stddev:5.36 (7.7%) stddev-sans-first:5.21 21:52:41 INFO - PID 2317 | Values: 75.0 64.0 71.0 62.0 63.0 67.0 68.0 71.0 69.0 79.0 21:52:41 INFO - PID 2317 | -------- Summary: end -------- 21:52:41 INFO - PID 2317 | 21:52:42 INFO - TEST-INFO | 2317: exit 0 21:52:43 INFO - TEST-OK | kraken | took 60695ms 21:52:43 INFO - SUITE-END | took 1175s 21:52:43 INFO - Completed test suite (00:19:35) 21:52:43 INFO - javascript benchmark 21:52:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7937.457243963666, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3083.3370825272564, 3541.8229088545568, 3575.1240945968243, 3614.6204648511907, 3618.638136186382, 5345.7594408251625, 6086.786962456309, 6098.280951554085, 6111.983045594949, 6200.658963756991, 6156.538259630534, 6176.073588961658, 6184.474319682821, 6247.7813276535335, 6256.562040657156, 5001.874953126165, 5260.789568417259, 5389.946100538984, 5415.268938693275, 5430.5927055471, 5518.6688798672, 5538.363088244843, 5539.639923404966, 5560.944390556083, 5601.915971260434, 5347.839564813062, 5457.399686034533, 5457.727113644302, 5492.176173573976, 5493.642913210629, 5473.7263136843, 5482.342118945712, 5491.066518691832, 5508.862278443031, 5511.118221084607, 5424.620276580641, 5434.402215756264, 5444.265024221759, 5445.292112025411, 5452.91820622691, 6132.141500189932, 6162.0140777475835, 6219.844503887393, 6227.0, 6263.342349053375, 6402.23173219212, 6530.216374035099, 6548.410643042102, 6603.669816509156, 6659.600423974577, 6733.595984240961, 6754.358335958076, 6757.797266082025, 6768.221654509745, 6775.322467753185, 6220.0, 6235.750569977241, 6284.931561634533, 6293.1504246927, 6297.590656607306, 6621.702023408958, 6752.257251702309, 6845.486588505882, 6872.381485666314, 6916.308369163144, 6371.649559274192, 6448.161738973903, 6474.4496717778575, 6484.481241500669, 6594.307597702172, 6686.665666716742, 6786.117804685458, 6793.796186114326, 6810.216825065082, 6833.829154271183, 6627.635480048547, 6655.234648015444, 6670.132882725312, 6677.432418244503, 6680.0981867448245, 5489.945100549024, 6442.2591401989375, 6511.479081673455, 6566.67166641666, 6694.430973367318, 5275.024120537712, 5294.364676238876, 5316.9202461963105, 5330.200469929541, 5351.3578370595, 3728.6271372862498, 4695.859124226278, 4716.3632909557455, 4736.502667219961, 4747.311639812208, 6155.969220153871, 6213.502919766408, 6277.435030847246, 6352.396522330371, 6355.650439225887, 6629.635370054693, 6710.396064354134, 6724.394804467622, 6759.121314229119, 6779.389854912983, 6327.3988971047675, 6329.177206963065, 6338.112664227012, 6349.777757778548, 6358.936410635834, 5907.261592300963, 5918.822435326947, 5936.079907614327, 5945.702714864239, 5957.642541447527, 5724.713764311851, 6691.665416729144, 6811.250762416031, 6955.339242771928, 7031.578105313493, 5821.650700957956, 6621.404073633396, 6768.424683901923, 6774.4580433564215, 6860.0738900247825, 6962.686679099554, 6979.8604027918145, 7001.50989430735, 7006.054182685476, 7008.824779380557, 5828.921649494857, 6309.684515774285, 6517.120188774645, 6658.7336506539195, 6698.430633396216, 6741.52809303344, 6766.086578311865, 6816.693248803915, 6816.829579260559, 6845.623490708059, 5125.589952803842, 6374.872502549831, 6438.323975982455, 6586.2755096940255, 6589.24223714279, 6375.649339286384, 6581.868362632625, 6590.70341834609, 6600.306967768315, 6605.438537724347, 6236.126942228001, 6397.808065758035, 6432.453241474527, 6470.352964703492, 6480.513961452815, 6425.903611445926, 6470.094186813944, 6485.124508191334, 6555.344465553407, 6583.572067815577, 6412.198475190601, 6429.485641148791, 6445.065465507569, 6451.129097571956, 6453.354664533509], "value": 6080.883939063777, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.184050428059, 824.3322908444161, 852.126570265478, 1211.103783200432, 1284.1524593768115, 35746.0, 38825.805870970675, 38960.41559376605, 38970.0, 38984.0, 38900.416493752615, 39260.214795704065, 39293.41059884104, 39298.803505982505, 39317.0, 7838.686452541891, 8282.544460054694, 8474.0, 8479.788005299886, 8501.022382426007, 7611.467197296191, 8578.270846978014, 8582.828343433128, 8584.785380365478, 8585.098564650716, 8529.061803201643, 8535.658573657078, 8537.231649151576, 8593.742187734346, 8609.354298427612, 8510.446820956618, 8560.657573697044, 8563.143685631449, 8579.184977427165, 8579.571021448934, 8323.12729635827, 8324.875126873041, 8377.874331885027, 8383.664653413856, 8409.789755256106, 31522.52716209259, 37816.81091594552, 37977.81011094927, 38014.61985380166, 38142.283597238194, 3595.3168897909577, 3632.8183590820354, 3636.690881275095, 3637.8181090945614, 3650.5619325680823, 30475.628596713203, 30567.69432305671, 30813.383732325226, 30828.38343233145, 30840.074797756104, 2703.7296270373004, 3165.7942233754734, 3166.8733250669948, 3176.8252746098956, 3204.6314673812576, 229283.0, 245614.0, 249569.0, 269830.999999998, 298773.5061324701, 49236.50763492319, 49351.25973110406, 49547.752261238464, 49570.0, 49855.0028999418, 51185.0, 51519.22721159185, 51683.22475162875, 51746.48253517417, 51788.223176652384, 13862.514811981533, 13978.930105349407, 14086.859131408759, 14090.929545352412, 14123.0, 11376.715582110348, 11504.367259800623, 11517.48171332292, 11536.019438347666, 11564.710882228012, 13605.659858503617, 13714.0400171987, 13715.45138194481, 13731.794023089662, 13872.861271387359, 4945.7141143303, 5821.563382746311, 5832.212651292106, 5876.177335173079, 5929.288485381696, 996.8953259907605, 1013.5489707080426, 1036.6889933020063, 1066.3814987307344, 1068.983965240522, 21884.45288867759, 23008.884955575115, 24221.63667544988, 24270.87864560666, 24472.510549789262, 1127.7067962329688, 1135.6990397544491, 1138.618562781461, 1163.1973937982764, 1165.182315587686, 10678.1991350649, 12270.141090123605, 12330.260184388966, 12340.136190466761, 12363.876361236453, 320091.0, 321953.3902330473, 322112.0, 322129.0, 323365.0, 54652.0, 54833.903321933336, 55129.0, 55146.72426637841, 55376.0, 1472.536151112396, 1497.5806774103487, 1536.3086611025083, 1543.9459618913284, 1547.1877264436262, 18027.549311267325, 23898.64152037686, 24008.0, 24027.27918162458, 24998.875005624854, 32590.51114233336, 37482.50069997169, 38110.8094459537, 38221.0, 38426.0, 283261.0, 283924.0, 284387.57806210837, 284840.0, 285408.0, 34438.48342274918, 34469.310613787085, 35873.28253434969, 35936.0, 35949.0, 43946.78026609847, 44795.32807007832, 46077.53922460866, 46400.53599463962, 46402.53597464117, 24844.503109937337, 30528.931487397833, 30893.845530772203, 31331.37337253288, 31440.685593143775, 27742.583861241696, 30929.381412372077, 31058.844705776326, 31247.218819529695, 31319.43402829895, 38010.95912326952, 38031.239375211786, 38071.61928380681, 38073.80963095167, 38173.80913095417, 24012.0, 24314.635280470455, 28754.904395331512, 30063.69936300609, 32443.513347299337, 23019.309420717404, 23739.1691290804, 24857.92558930404, 24926.750732492445, 24945.875270623532], "value": 17492.27987354114, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.4972483295213, 435.9529521914681, 437.3265171635681, 446.2012996735842, 462.9282461218512, 19452.805471945278, 21084.051217695203, 21743.782562174372, 21946.45133871654, 21971.450713732145, 21833.454163645918, 22687.432814179654, 22711.772882271172, 22963.19628812992, 23333.183338583152, 5193.065248255312, 5992.340842507331, 6245.188125543673, 6361.642743221686, 6384.680765961683, 6074.96962515189, 6276.780312689057, 6310.368963103699, 6317.210348706411, 6344.270408902966, 6228.283747369065, 6241.65670888101, 6274.309825919146, 6280.685965701719, 6284.71718772654, 5371.704556249405, 6101.9389806102035, 6275.68621568922, 6277.497800175975, 6299.055141728754, 4722.362481065046, 5388.353397592314, 5474.808381706661, 5556.361018482886, 5592.0773072443, 27179.320516987034, 27293.72706272932, 27884.442311153663, 28018.0, 28098.578521321993, 2233.7766223377694, 2285.5771682238674, 2291.5302363015544, 2296.3684986628646, 2299.1033496936043, 17842.10789460522, 17992.460226193234, 18144.4556663299, 18256.269749210147, 18434.0, 2158.4819643285655, 2188.6060509108356, 2233.8101261392803, 2235.284708893155, 2242.473018840571, 153520.23239883842, 153993.46006539903, 154228.0, 155026.0, 156822.0, 12155.270683759003, 12737.36313184337, 12763.872361276453, 12773.297468639128, 12820.80768788469, 16378.26297816601, 16562.668746625, 16602.83397166037, 16628.919120257146, 16633.750493742602, 8836.116388361112, 9026.86459703105, 9030.413023153475, 9123.361364704408, 9157.679481218258, 8622.0, 8630.82738345242, 8659.826803463895, 8788.8681669775, 8805.987311459265, 7932.0, 8042.718504852302, 8043.517388956681, 8070.717524886601, 8084.0, 2164.686120512517, 2177.074743234119, 2182.33438801164, 2182.705334779816, 2196.890155492251, 910.8770316007386, 920.6455514626783, 988.2094324540338, 1014.4572653630272, 1022.616518805448, 21144.78855211459, 21511.46221344479, 21648.78351216499, 21755.80343081146, 21932.561348772935, 1025.1183981775666, 1043.2123746571442, 1043.956043956044, 1059.1791361694748, 1072.651388298806, 9896.653617123366, 11099.667009989713, 11130.332180069221, 11152.944235278772, 11177.049950754114, 554565.0, 557499.0, 559079.0, 561631.0, 567146.0, 129332.0600190998, 131978.0, 134118.0, 137217.0, 139770.30114849564, 1198.9460474278678, 1236.4744983382027, 1247.3451437995125, 1250.5498020712537, 1250.612310183864, 21448.571028579652, 22278.331650050524, 22834.0, 22881.542369152856, 22955.77044229603, 56428.0, 57457.425425745205, 57703.0, 58282.7085864568, 58737.4126258749, 80426.59786701029, 80563.0, 80892.78660819975, 81348.37303253783, 82238.35523289621, 8922.0, 8953.238974687225, 9082.40964337316, 9116.270698343984, 9120.498372589305, 13885.930570347084, 14013.5095271665, 14046.0, 14200.431982720576, 14288.714225715636, 9578.473183974947, 9665.855012174683, 11466.082713382742, 12149.514019439477, 12208.511659533518, 9025.729228123168, 9802.85295720579, 11287.322760634388, 11370.43147842588, 11453.083753299883, 11932.463039163085, 11956.282623042645, 12098.03215742756, 12164.148509604596, 12200.877991219973, 8683.956580217058, 8846.601902914255, 8936.0, 8937.89959359563, 8980.910190898006, 11647.59233426826, 11942.507186601675, 11964.282143071443, 11979.76040479203, 12084.274943503418], "value": 10603.688852119154, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1249.5813902342716, 1301.0502333296688, 1463.6999415119908, 1488.8213414390275, 1490.6198919275587, 11189.944050279757, 11399.886001139987, 11895.940520297409, 11924.344161071138, 11946.701332466693, 11561.306321620708, 11729.70675733107, 11777.941110294458, 11779.469923853425, 11935.58225462109, 2500.4749002709455, 2531.936701582457, 2539.961900571493, 2542.478791847667, 2549.5665736824785, 2467.4078221226955, 2512.4095837478176, 2515.874206289678, 2515.949681006379, 2522.583773677341, 2472.0, 2489.7136829264687, 2523.49530093981, 2525.0783464035585, 2531.860747658878, 2051.200031987526, 2219.8456802462792, 2446.7675570820743, 2471.7157526884457, 2479.962800557984, 2398.3764221302586, 2473.0973194783955, 2491.327341617753, 2529.620556916459, 2533.733957934409, 11666.183367164302, 11740.882591174064, 11749.588764393291, 11751.529938802438, 11774.468489274846, 6619.834504137387, 6782.932170678279, 6842.247352791189, 6850.349216824394, 6859.622720750357, 4000.759954402716, 4326.891827704332, 4372.562743725602, 4377.430933978594, 4398.076403955173, 1239.2997956154743, 1262.1228246368778, 1301.1412467771227, 1307.7711400504872, 1311.5344052861287, 15245.237738113161, 15722.371105155666, 16586.419475318427, 16748.41380551687, 16752.078635675032, 5364.81973965727, 5609.943900561024, 5822.621529600562, 5834.3290521589715, 5853.180554722342, 10334.431606261727, 11793.0, 11799.646010619523, 11879.346635934933, 11893.762124757457, 6538.051982462516, 6602.075709400688, 6618.7021584028835, 6629.436497897636, 6632.502562307846, 6056.788012419544, 6123.938760612336, 6206.348333425016, 6262.058761783862, 6292.905606415908, 3694.150345420568, 4258.914821703549, 4417.072414792865, 4436.534163912807, 4479.059397526491, 1269.7016201192712, 1293.204679122333, 1293.9158954667917, 1308.8822006019504, 1311.4229738914846, 798.865610832619, 803.9799005024804, 813.8616435205911, 817.4196320612313, 842.3892677808662, 4990.0, 6166.7224974876235, 6189.907151392733, 6436.645984470805, 6518.57629254097, 547.7644612816448, 572.9312482502127, 574.4341823304043, 577.0680351232812, 581.9621724587888, 4219.97890010548, 4328.091100868853, 4453.910921781546, 4488.663350248745, 4565.566271204297, 11087.33475991443, 12393.62819115428, 14553.927230363992, 15110.035695359753, 15135.621609459851, 12930.577636459982, 14995.025323353948, 15090.849091508944, 15142.924285378724, 15209.923950380176, 8583.39916205872, 8696.608652610521, 8698.434601750992, 8700.60847261862, 8711.21599056088, 6270.278917924497, 7005.404540614105, 7240.746573869889, 7285.23505031964, 7320.15818180916, 13434.261115638343, 13516.79724804109, 13657.795133072814, 13658.521951731642, 13694.863051369359, 13775.035747497579, 13856.653583660085, 13886.861131388558, 13990.810781083723, 14217.64455888611, 9178.0, 9448.574814133242, 9456.243500520079, 9482.85775713351, 9484.0, 10536.10443112344, 10682.198835087243, 10739.731506712395, 10777.838332425177, 10910.181736369645, 9234.676786312446, 9277.907220927704, 9291.256699463891, 9375.0, 9457.858132127885, 8666.396716607447, 8915.375923685539, 9019.233365163773, 9061.728148155566, 9112.0, 6971.5468494547695, 7146.64266786669, 8189.303909167787, 8349.039860415887, 8373.874391884248, 6024.90962635552, 6036.396360363929, 6145.8156255312415, 6205.6586887721605, 6216.098665693358, 5495.807646732345, 5899.0, 5947.375525569926, 6124.418180272867, 6390.616563006234], "value": 5314.04046055944, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.70183642067803, 405.61061381074165, 409.23473105293107, 411.93720201879154, 422.0946070678395, 6121.877562448748, 6157.384261573846, 6348.460380867632, 6384.201974753156, 6394.904076438851, 5662.5753068519925, 6159.661218632985, 6221.40896614822, 6251.6874156292115, 6290.21372328459, 4803.742241146655, 4804.951950480486, 4823.4435749053055, 4847.733374664392, 4852.902941941159, 4235.53409124996, 4657.20827459331, 4752.334673145762, 4827.927581086269, 4854.56308932196, 4599.655025873073, 4785.569298763111, 4793.041391721652, 4825.951740482603, 4830.71015739055, 4168.228877657628, 4393.912121757547, 4771.522847715235, 4781.282807578874, 4863.319135321058, 3999.560048394674, 4236.661067114624, 4304.7632380219075, 4307.418498502693, 4320.611144996934, 5174.835661976025, 5302.390225124122, 6142.8771424571705, 6183.072539119124, 6228.532860035471, 4966.553010229097, 5528.226048353234, 5737.856553586152, 5750.597458177929, 5789.652620842763, 5614.522765564931, 6708.12794336738, 6726.562773419712, 6794.490413219029, 6825.35159159884, 4366.345048242789, 4640.280756482751, 4881.95118048822, 4919.852404427873, 4925.3350797642215, 6606.900896486556, 6767.35710107539, 7065.230969095891, 7111.395531379839, 7155.749548765768, 3851.614838516126, 5064.41759197697, 5071.163258062452, 5078.238264260391, 5098.643094983389, 4340.891477713082, 5183.896322073538, 5188.507091826346, 5193.37679478465, 5213.661112027706, 5033.899322013539, 5494.478024587658, 5671.602987790815, 5718.456746609066, 5795.362510123883, 5341.946580534222, 6137.5703700741415, 6467.253841462779, 6719.462443004548, 6719.764808231688, 1597.8734991830731, 1738.9217485213196, 1762.175731387265, 1790.3644206306833, 1791.4983804534752, 1097.5554900265406, 1102.20090434436, 1209.0629761934572, 1227.8035514317844, 1233.6730766346925, 5097.719625420637, 5471.7264136793, 5954.404559544011, 6049.727762250709, 6342.619442833445, 5421.728913554307, 5672.688002159838, 6966.79099627012, 7058.61177635235, 7063.823404414828, 5469.398366179717, 6318.336574659595, 6319.377458354823, 6323.407402964763, 6345.270293916166, 3514.8242587870504, 3595.8381872815785, 3627.4196128619296, 3635.927281454409, 3641.7997010164695, 7162.068931038932, 7168.856622867514, 7173.067501224912, 7201.675924583406, 7240.312170343809, 6562.77030303937, 6864.24493305736, 7112.857742845114, 7199.496035277481, 7214.891776623354, 7252.41980641558, 7284.635768211462, 7349.742759003409, 7354.926450735531, 7355.963220183865, 6953.061336719478, 7049.519600883872, 7078.823029424306, 7114.039604653305, 7145.928540714526, 5730.484256416942, 6830.7553911891455, 6850.0409942607075, 6866.588004719732, 6891.862162756817, 5985.311689155803, 6047.969760151171, 7261.709531618887, 7298.78137131932, 7330.926690733025, 3698.1139618794073, 3824.847006119724, 3989.9626097214355, 4310.116426132573, 4529.00361920377, 5843.769826005786, 6151.0, 6689.0, 6986.231514533296, 7001.404880585207, 5457.590680698884, 6378.938109707459, 6419.4864410846085, 6669.733210671713, 6701.798946031627, 5931.703414829328, 6588.40704336612, 6722.361375669304, 6722.394984451227, 6746.414592570643, 5205.776642489088, 6349.904751428639, 6575.2767195607485, 6607.702653380513, 6647.235567909753, 5650.689212093374, 5904.202932604044, 6825.761098361533, 6827.89758153638, 6857.074294970115, 6484.967575162283, 6631.502637302126, 6642.202935647753, 6649.700763465559, 6662.933370666231], "value": 4959.665378405847, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [832.8750687396894, 842.8609279468892, 847.7326397036431, 854.3891117850737, 876.4259410086394, 13751.587452376432, 16642.0, 16647.417340393087, 18253.36113236037, 18845.905770471163, 17771.289148434047, 17953.0, 18080.186391612377, 18163.545911352223, 18352.541186470313, 1004.8442491413842, 1023.7542989682497, 1025.6410256410234, 1028.9485525723721, 1031.1183937733242, 1011.2971484818055, 1019.7450637340664, 1021.6679579136774, 1024.7182024943127, 1030.3766221436, 1079.098952374768, 1090.345792524483, 1091.5961094395084, 1092.3336764573603, 1097.8517900083507, 1073.098597178374, 1090.2749671468503, 1090.3294473898575, 1090.5092708281227, 1092.9071028962549, 777.7550071727388, 779.4894344204498, 801.7915342011061, 805.8025783682976, 807.4065561812064, 16722.498325050266, 16764.748528772077, 16821.41125060617, 16954.0, 16968.98186108825, 16978.83021169785, 17114.743278850827, 17243.79293449459, 17421.041842698647, 17458.0, 13737.24445155516, 13754.724905501835, 14065.71868562623, 14103.294835258299, 14103.942204334613, 3390.237196630763, 3445.207602251471, 3464.2725027744204, 3464.566929133858, 3469.1847415857255, 104464.0, 137507.0, 138499.61252905973, 139343.0, 141170.0, 13173.0, 13193.670158245928, 13276.601701948957, 13287.601371958857, 13422.865771342162, 23792.0, 23816.40458988539, 25628.0, 25885.35286617812, 26038.609420858702, 7514.812129696801, 7538.509996850187, 7575.318221360104, 7614.466987310835, 7620.847583048308, 3785.9242815143543, 3862.478565393692, 3863.130795570974, 3866.8066596670055, 3871.806409679561, 4223.894402639959, 4244.787760612019, 4262.7655478948955, 4311.913761724811, 4319.568043195718, 860.5310105992249, 871.8212766383003, 876.268315956171, 877.4165180155126, 881.9735407937773, 651.2705769538147, 663.5288944849211, 663.9734410623618, 677.7085853083222, 691.3328637864485, 10706.678799636024, 11212.225360250617, 11323.0, 11447.0, 11708.473118709679, 644.5681393466389, 653.8855700252436, 658.3876994395163, 674.254948282151, 683.5010442377093, 4746.0, 5148.150555158357, 5269.947300527022, 5340.75966581497, 5472.151816468374, 97681.0, 99760.0, 108704.4564777171, 109125.90489141195, 111079.0, 76600.61699691466, 80844.19155808366, 84360.57819710985, 85349.86625334417, 87191.0, 69423.65288173629, 83397.16602834016, 84358.0, 84458.0, 84740.57629711812, 9251.537423128952, 10140.83380411262, 10455.895441045492, 12051.397430128634, 12215.755684886075, 38605.84182474418, 38927.6107238924, 39147.80426097851, 39242.0, 39578.60421395749, 56617.71691141683, 61499.69250153899, 80761.19238807536, 81653.05948994402, 82135.17864821514, 15471.458498952483, 15847.207639617742, 16092.839071609134, 16102.597435063748, 16381.754273685667, 17004.234809433357, 17079.658406831546, 17817.1982260796, 17914.91042544831, 18075.548111296797, 16956.49130526086, 17175.398861039805, 17280.0, 17304.48086557355, 17562.648747024734, 14843.92578037146, 17379.826201738328, 17662.470125896245, 17750.644987099928, 17798.733019004467, 15104.54686359411, 16062.43781467643, 16389.262483188046, 17175.398861039805, 17237.0, 10120.0, 10979.945100274448, 11422.371769552423, 11750.0, 11945.581904633644, 12543.87456125427, 13044.478220871439, 13515.137967861156, 13723.313834308445, 14044.157350558999], "value": 8412.231697367813, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 167.0, 166.0, 113.0, 114.0, 113.0, 113.0, 114.0, 116.0, 119.0], "value": 124.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 108.0, 111.0, 156.0, 111.0, 110.0, 109.0, 114.0, 156.0, 148.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 204.0, 200.0, 225.0, 211.0, 202.0, 200.0, 202.0, 203.0, 197.0], "value": 204.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 57.0, 56.0, 82.0, 58.0, 58.0, 68.0, 85.0, 84.0, 56.0], "value": 68.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 69.0, 87.0, 79.0, 99.0, 99.0, 106.0, 103.0, 68.0, 89.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 88.0, 88.0, 89.0, 86.0, 88.0, 88.0, 88.0, 87.0], "value": 87.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 153.0, 141.0, 97.0, 99.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 107.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 92.0, 90.0, 91.0, 90.0, 89.0, 93.0, 121.0, 143.0], "value": 99.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 52.0, 53.0, 49.0, 61.0, 75.0, 77.0, 73.0, 72.0], "value": 61.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 63.0, 63.0, 63.0, 64.0, 61.0, 56.0, 58.0, 58.0, 59.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 105.0, 108.0, 84.0, 90.0, 88.0, 87.0, 85.0, 85.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 137.0, 138.0, 138.0, 139.0, 160.0, 134.0, 167.0, 190.0, 170.0], "value": 150.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 184.0, 188.0, 187.0, 187.0, 186.0, 183.0, 200.0, 192.0, 221.0], "value": 190.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 64.0, 71.0, 62.0, 63.0, 67.0, 68.0, 71.0, 69.0, 79.0], "value": 68.9, "unit": "score"}]}]} 21:52:43 INFO - Return code: 0 21:52:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:52:43 INFO - # TBPL SUCCESS # 21:52:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:52:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:52:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:52:43 INFO - 2017-05-03 21:52:43.257 screenresolution[2324:29144] starting screenresolution argv=screenresolution get 21:52:43 INFO - 2017-05-03 21:52:43.259 screenresolution[2324:29144] Display 0: 1600x1200x32@60 21:52:43 INFO - 2017-05-03 21:52:43.266 screenresolution[2325:29147] starting screenresolution argv=screenresolution list 21:52:43 INFO - Available Modes on Display 0 21:52:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:52:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:52:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:52:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:52:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:52:43 INFO - Intel Iris: 21:52:43 INFO - Chipset Model: Intel Iris 21:52:43 INFO - Type: GPU 21:52:43 INFO - Bus: Built-In 21:52:43 INFO - VRAM (Dynamic, Max): 1536 MB 21:52:43 INFO - Vendor: Intel (0x8086) 21:52:43 INFO - Device ID: 0x0a2e 21:52:43 INFO - Revision ID: 0x0009 21:52:43 INFO - Displays: 21:52:43 INFO - Display: 21:52:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:52:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:52:43 INFO - Display Serial Number: 1600x1200 60 21:52:43 INFO - Main Display: Yes 21:52:43 INFO - Mirror: Off 21:52:43 INFO - Online: Yes 21:52:43 INFO - Rotation: Supported 21:52:43 INFO - Return code: 0 21:52:43 INFO - Running post-action listener: _resource_record_post_action 21:52:43 INFO - [mozharness: 2017-05-04 04:52:43.519440Z] Finished run-tests step (success) 21:52:43 INFO - Running post-run listener: _resource_record_post_run 21:52:43 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 1237504; Write bytes: 512815104; Read time: 7; Write time: 1672 21:52:43 INFO - TinderboxPrint: CPU usage
54.3% 21:52:43 INFO - TinderboxPrint: I/O read bytes / time
1,237,504 / 7 21:52:43 INFO - TinderboxPrint: I/O write bytes / time
512,815,104 / 1,672 21:52:43 INFO - TinderboxPrint: CPU idle
2,185.0 (45.7%) 21:52:43 INFO - TinderboxPrint: CPU system
962.5 (20.1%) 21:52:43 INFO - TinderboxPrint: CPU user
1,634.1 (34.2%) 21:52:43 INFO - TinderboxPrint: Swap in / out
209,162,240 / 0 21:52:43 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 198760960; Write bytes: 197220352; Read time: 15092; Write time: 423 21:52:43 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 1237504; Write bytes: 298752000; Read time: 7; Write time: 1198 21:52:44 INFO - Running post-run listener: _upload_blobber_files 21:52:44 INFO - Blob upload gear active. 21:52:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:52:44 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 21:52:44 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'] 21:52:44 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 21:52:44 INFO - (blobuploader) - INFO - Open directory for files ... 21:52:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:52:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:52:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:52:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:52:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:52:46 INFO - (blobuploader) - INFO - Done attempting. 21:52:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:52:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:52:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:52:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:52:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:52:47 INFO - (blobuploader) - INFO - Done attempting. 21:52:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:52:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:52:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:52:48 INFO - (blobuploader) - INFO - Done attempting. 21:52:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:52:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:52:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:52:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:52:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:52:50 INFO - (blobuploader) - INFO - Done attempting. 21:52:50 INFO - (blobuploader) - INFO - Iteration through files over. 21:52:50 INFO - Return code: 0 21:52:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:52:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:52:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9910cd57c8752124d5e46ae19e846f71fd836c2565fa07de779ea157da74783e3c511889aad43875e600498a251721bad29e3989b6cd58fdf9f74daca21a3a73", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b02155937ad5149a30472e847ea996998e5a2dd6c273dd72aba4b6dd8718b364e4cd9b0a1f41422eead12be465c2604d7b018bd0531aa6c2f0ec81004d1734e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05e418de47c9ddb0920f72d47d7f37ec4d1c143884f821057aa4ee8dd2513cf43c6c85172f2da2423ac2f1caaf85f4bf4bbd595ddfbea9a127b5a15d0e90a043", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8c0785387fb36edb66a6e2c047734a1463e9c0c80de2f57cf0e25b71e80a93ba9eaa21998496e51c5c068dfaec2d608a9fe4ac2ee2d7b4f3c818d18d7cedee8"} 21:52:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:52:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:52:50 INFO - Contents: 21:52:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9910cd57c8752124d5e46ae19e846f71fd836c2565fa07de779ea157da74783e3c511889aad43875e600498a251721bad29e3989b6cd58fdf9f74daca21a3a73", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b02155937ad5149a30472e847ea996998e5a2dd6c273dd72aba4b6dd8718b364e4cd9b0a1f41422eead12be465c2604d7b018bd0531aa6c2f0ec81004d1734e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05e418de47c9ddb0920f72d47d7f37ec4d1c143884f821057aa4ee8dd2513cf43c6c85172f2da2423ac2f1caaf85f4bf4bbd595ddfbea9a127b5a15d0e90a043", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8c0785387fb36edb66a6e2c047734a1463e9c0c80de2f57cf0e25b71e80a93ba9eaa21998496e51c5c068dfaec2d608a9fe4ac2ee2d7b4f3c818d18d7cedee8"} 21:52:50 INFO - Running post-run listener: copy_logs_to_upload_dir 21:52:50 INFO - Copying logs to upload dir... 21:52:50 INFO - mkdir: /builds/slave/test/build/upload/logs 21:52:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.990267 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2017-05-03 21:52:50.400829) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 21:52:50.404726) ========= 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.gsShQHZFsi/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.Y2A8TvLAO4/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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/9910cd57c8752124d5e46ae19e846f71fd836c2565fa07de779ea157da74783e3c511889aad43875e600498a251721bad29e3989b6cd58fdf9f74daca21a3a73", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b02155937ad5149a30472e847ea996998e5a2dd6c273dd72aba4b6dd8718b364e4cd9b0a1f41422eead12be465c2604d7b018bd0531aa6c2f0ec81004d1734e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05e418de47c9ddb0920f72d47d7f37ec4d1c143884f821057aa4ee8dd2513cf43c6c85172f2da2423ac2f1caaf85f4bf4bbd595ddfbea9a127b5a15d0e90a043", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8c0785387fb36edb66a6e2c047734a1463e9c0c80de2f57cf0e25b71e80a93ba9eaa21998496e51c5c068dfaec2d608a9fe4ac2ee2d7b4f3c818d18d7cedee8"} build_url:https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/BtvgTKwERZKsxB5T0HYY9w/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/9910cd57c8752124d5e46ae19e846f71fd836c2565fa07de779ea157da74783e3c511889aad43875e600498a251721bad29e3989b6cd58fdf9f74daca21a3a73", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b02155937ad5149a30472e847ea996998e5a2dd6c273dd72aba4b6dd8718b364e4cd9b0a1f41422eead12be465c2604d7b018bd0531aa6c2f0ec81004d1734e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05e418de47c9ddb0920f72d47d7f37ec4d1c143884f821057aa4ee8dd2513cf43c6c85172f2da2423ac2f1caaf85f4bf4bbd595ddfbea9a127b5a15d0e90a043", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8c0785387fb36edb66a6e2c047734a1463e9c0c80de2f57cf0e25b71e80a93ba9eaa21998496e51c5c068dfaec2d608a9fe4ac2ee2d7b4f3c818d18d7cedee8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 21:52:50.445024) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:52:50.445769) ========= 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.gsShQHZFsi/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.Y2A8TvLAO4/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005444 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:52:50.495562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 21:52:50.495914) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 21:52:50.496290) ========= ========= Total master_lag: 0.19 =========