builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0311 starttime: 1494155010.04 results: success (0) buildid: 20170507030205 builduid: 37231938039645f1a46f3f870f81f1f5 revision: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-07 04:03:30.043140) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-07 04:03:30.043574) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-07 04:03:30.043859) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-07 04:03:30.071643) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 04:03:30.072072) ========= 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.48IbiaIQE4/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.FgiHbHoo1N/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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-07 04:03:30-- 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% 27.7M=0s 2017-05-07 04:03:30 (27.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.640790 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 04:03:30.738005) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 04:03:30.738386) ========= 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.48IbiaIQE4/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.FgiHbHoo1N/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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.030233 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 04:03:30.792471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-07 04:03:30.792877) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 --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 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.48IbiaIQE4/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.FgiHbHoo1N/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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-07 04:03:30,890 truncating revision to first 12 chars 2017-05-07 04:03:30,890 Setting DEBUG logging. 2017-05-07 04:03:30,890 attempt 1/10 2017-05-07 04:03:30,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37a5b7f6f101?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-07 04:03:31,654 unpacking tar archive at: mozilla-central-37a5b7f6f101/testing/mozharness/ program finished with exit code 0 elapsedTime=1.043246 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-07 04:03:31.861016) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-07 04:03:31.861380) ========= script_repo_revision: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-07 04:03:31.861782) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-07 04:03:31.862060) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-07 04:03:31.882857) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-07 04:03:31.883453) ========= /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.48IbiaIQE4/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.FgiHbHoo1N/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:03:32 INFO - MultiFileLogger online at 20170507 04:03:32 in /builds/slave/test 04:03:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:03:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:03:32 INFO - {'append_to_log': False, 04:03:32 INFO - 'base_work_dir': '/builds/slave/test', 04:03:32 INFO - 'blob_upload_branch': 'Firefox', 04:03:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:03:32 INFO - 'branch': 'Firefox', 04:03:32 INFO - 'buildbot_json_path': 'buildprops.json', 04:03:32 INFO - 'config_files': ('talos/mac_config.py',), 04:03:32 INFO - 'default_actions': ('clobber', 04:03:32 INFO - 'read-buildbot-config', 04:03:32 INFO - 'download-and-extract', 04:03:32 INFO - 'populate-webroot', 04:03:32 INFO - 'create-virtualenv', 04:03:32 INFO - 'install', 04:03:32 INFO - 'run-tests'), 04:03:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:03:32 INFO - 'download_minidump_stackwalk': True, 04:03:32 INFO - 'download_symbols': 'ondemand', 04:03:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:03:32 INFO - 'tooltool.py': '/tools/tooltool.py', 04:03:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:03:32 INFO - '/tools/misc-python/virtualenv.py')}, 04:03:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:03:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:03:32 INFO - 'gecko_profile': False, 04:03:32 INFO - 'gecko_profile_interval': 0, 04:03:32 INFO - 'installer_path': 'installer.exe', 04:03:32 INFO - 'log_level': 'info', 04:03:32 INFO - 'log_name': 'talos', 04:03:32 INFO - 'log_to_console': True, 04:03:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:03:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:03:32 INFO - 'opt_config_files': (), 04:03:32 INFO - 'pip_index': False, 04:03:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:03:32 INFO - 'cmd': ('bash', 04:03:32 INFO - '-c', 04:03:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:03:32 INFO - 'enabled': True, 04:03:32 INFO - 'halt_on_failure': False, 04:03:32 INFO - 'name': 'check_screen_resolution'},), 04:03:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:03:32 INFO - 'cmd': ('bash', 04:03:32 INFO - '-c', 04:03:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:03:32 INFO - 'enabled': True, 04:03:32 INFO - 'halt_on_failure': False, 04:03:32 INFO - 'name': 'check_screen_resolution'},), 04:03:32 INFO - 'run_cmd_checks_enabled': True, 04:03:32 INFO - 'suite': 'dromaeojs-e10s', 04:03:32 INFO - 'system_bits': '32', 04:03:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:03:32 INFO - 'title': 't-yosemite-r7-0311', 04:03:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:03:32 INFO - 'use_talos_json': True, 04:03:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:03:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:03:32 INFO - 'work_dir': 'build'} 04:03:32 INFO - [mozharness: 2017-05-07 11:03:32.083491Z] Running clobber step. 04:03:32 INFO - Running pre-action listener: _resource_record_pre_action 04:03:32 INFO - Running main action method: clobber 04:03:32 INFO - rmtree: /builds/slave/test/build 04:03:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:03:34 INFO - Running post-action listener: _resource_record_post_action 04:03:34 INFO - [mozharness: 2017-05-07 11:03:34.398655Z] Finished clobber step (success) 04:03:34 INFO - [mozharness: 2017-05-07 11:03:34.398826Z] Running read-buildbot-config step. 04:03:34 INFO - Running pre-action listener: _resource_record_pre_action 04:03:34 INFO - Running main action method: read_buildbot_config 04:03:34 INFO - Using buildbot properties: 04:03:34 INFO - { 04:03:34 INFO - "project": "", 04:03:34 INFO - "product": "firefox", 04:03:34 INFO - "script_repo_revision": "production", 04:03:34 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:03:34 INFO - "repository": "", 04:03:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:03:34 INFO - "buildid": "20170507030205", 04:03:34 INFO - "stage_platform": "macosx64", 04:03:34 INFO - "basedir": "/builds/slave/test", 04:03:34 INFO - "nightly_build": "True", 04:03:34 INFO - "buildnumber": 52, 04:03:34 INFO - "slavename": "t-yosemite-r7-0311", 04:03:34 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:03:34 INFO - "platform": "yosemite_r7", 04:03:34 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:03:34 INFO - "branch": "mozilla-central", 04:03:34 INFO - "repo_path": "mozilla-central", 04:03:34 INFO - "revision": "37a5b7f6f101df2eb292b1b6baaf1540c9920e20", 04:03:34 INFO - "pgo_build": "False", 04:03:34 INFO - "builduid": "37231938039645f1a46f3f870f81f1f5", 04:03:34 INFO - "slavebuilddir": "test" 04:03:34 INFO - } 04:03:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:03:34 INFO - Running post-action listener: _resource_record_post_action 04:03:34 INFO - [mozharness: 2017-05-07 11:03:34.401970Z] Finished read-buildbot-config step (success) 04:03:34 INFO - [mozharness: 2017-05-07 11:03:34.402082Z] Running download-and-extract step. 04:03:34 INFO - Running pre-action listener: _resource_record_pre_action 04:03:34 INFO - Running main action method: download_and_extract 04:03:34 INFO - mkdir: /builds/slave/test/build/tests 04:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:03:34 INFO - trying https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:03:34 INFO - Downloading https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:03:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:03:35 INFO - Downloaded 1325 bytes. 04:03:35 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:03:35 INFO - Using the following test package requirements: 04:03:35 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:03:35 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:03:35 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:03:35 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:03:35 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:03:35 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:03:35 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:03:35 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:03:35 INFO - u'jsshell-mac.zip'], 04:03:35 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:03:35 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:03:35 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:03:35 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:03:35 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:03:35 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:03:35 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:03:35 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:03:35 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:03:35 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:03:35 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:03:35 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:03:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:03:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:03:35 INFO - Fetch https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:03:37 INFO - Content-Length response header: 52704282 04:03:37 INFO - Bytes received: 52704282 04:03:53 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:03:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:03:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:03:53 INFO - Fetch https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:03:55 INFO - Content-Length response header: 52704282 04:03:55 INFO - Bytes received: 52704282 04:04:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:04:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:04:10 INFO - Fetch https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:04:11 INFO - Content-Length response header: 14408697 04:04:11 INFO - Bytes received: 14408697 04:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:11 INFO - trying https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:04:11 INFO - Downloading https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:04:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:04:13 INFO - Downloaded 70961209 bytes. 04:04:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:04:13 INFO - mkdir: /builds/slave/test/properties 04:04:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:04:13 INFO - Writing to file /builds/slave/test/properties/build_url 04:04:13 INFO - Contents: 04:04:13 INFO - build_url:https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:04:14 INFO - Running post-action listener: _resource_record_post_action 04:04:14 INFO - Running post-action listener: set_extra_try_arguments 04:04:14 INFO - [mozharness: 2017-05-07 11:04:14.597771Z] Finished download-and-extract step (success) 04:04:14 INFO - [mozharness: 2017-05-07 11:04:14.597893Z] Running populate-webroot step. 04:04:14 INFO - Running pre-action listener: _resource_record_pre_action 04:04:14 INFO - Running main action method: populate_webroot 04:04:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:04:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:04:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:04:14 INFO - '--tppagecycles', 04:04:14 INFO - '7'], 04:04:14 INFO - 'tests': ['tsvgm']}}, 04:04:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:04:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:04:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:04:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:04:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:04:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:04:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:04:14 INFO - 'talos_options': ['--disable-e10s'], 04:04:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:04:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:04:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:04:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:04:14 INFO - 'talos_options': ['--disable-e10s'], 04:04:14 INFO - 'tests': ['damp', 'tps']}, 04:04:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:04:14 INFO - 'tests': ['damp', 'tps']}, 04:04:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:04:14 INFO - 'tests': ['dromaeo_dom']}, 04:04:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:04:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:04:14 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:04:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:04:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:04:14 INFO - 'tests': ['a11yr', 04:04:14 INFO - 'ts_paint', 04:04:14 INFO - 'tpaint', 04:04:14 INFO - 'sessionrestore', 04:04:14 INFO - 'sessionrestore_no_auto_restore', 04:04:14 INFO - 'tabpaint']}, 04:04:14 INFO - 'other-e10s': {'tests': ['a11yr', 04:04:14 INFO - 'ts_paint', 04:04:14 INFO - 'tpaint', 04:04:14 INFO - 'sessionrestore', 04:04:14 INFO - 'sessionrestore_no_auto_restore', 04:04:14 INFO - 'tabpaint']}, 04:04:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:04:14 INFO - 'ts_paint', 04:04:14 INFO - 'tpaint', 04:04:14 INFO - 'sessionrestore', 04:04:14 INFO - 'sessionrestore_no_auto_restore', 04:04:14 INFO - 'tabpaint']}, 04:04:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:04:14 INFO - 'ts_paint', 04:04:14 INFO - 'tpaint', 04:04:14 INFO - 'sessionrestore', 04:04:14 INFO - 'sessionrestore_no_auto_restore', 04:04:14 INFO - 'tabpaint']}, 04:04:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:04:14 INFO - 'tests': ['a11yr', 04:04:14 INFO - 'ts_paint', 04:04:14 INFO - 'tpaint', 04:04:14 INFO - 'sessionrestore', 04:04:14 INFO - 'sessionrestore_no_auto_restore', 04:04:14 INFO - 'tabpaint']}, 04:04:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:04:14 INFO - 'tests': ['a11yr', 04:04:14 INFO - 'ts_paint', 04:04:14 INFO - 'tpaint', 04:04:14 INFO - 'sessionrestore', 04:04:14 INFO - 'sessionrestore_no_auto_restore', 04:04:14 INFO - 'tabpaint']}, 04:04:14 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:04:14 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:04:14 INFO - 'bloom_basic_ref']}, 04:04:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:04:14 INFO - 'tests': ['tsvgx', 04:04:14 INFO - 'tsvgr_opacity', 04:04:14 INFO - 'tart', 04:04:14 INFO - 'tscrollx', 04:04:14 INFO - 'cart', 04:04:14 INFO - 'tsvg_static']}, 04:04:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:04:14 INFO - 'tsvgr_opacity', 04:04:14 INFO - 'tart', 04:04:14 INFO - 'tscrollx', 04:04:14 INFO - 'cart', 04:04:14 INFO - 'tsvg_static']}, 04:04:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:04:14 INFO - 'talos_options': ['--disable-e10s'], 04:04:14 INFO - 'tests': ['tp5o']}, 04:04:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:04:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:04:14 INFO - 'talos_options': ['--disable-e10s', 04:04:14 INFO - '--xperf_path', 04:04:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:04:14 INFO - 'tests': ['tp5n']}, 04:04:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:04:14 INFO - 'talos_options': ['--xperf_path', 04:04:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:04:14 INFO - 'tests': ['tp5n']}}, 04:04:14 INFO - 'talos.zip': {'path': '', 04:04:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:04:14 INFO - Running post-action listener: _resource_record_post_action 04:04:14 INFO - [mozharness: 2017-05-07 11:04:14.617124Z] Finished populate-webroot step (success) 04:04:14 INFO - [mozharness: 2017-05-07 11:04:14.617259Z] Running create-virtualenv step. 04:04:14 INFO - Running pre-action listener: _resource_record_pre_action 04:04:14 INFO - Running main action method: create_virtualenv 04:04:14 INFO - Creating virtualenv /builds/slave/test/build/venv 04:04:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:04:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:04:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:04:14 INFO - Using real prefix '/tools/python27' 04:04:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:04:15 INFO - Installing distribute.............................................................................................................................................................................................done. 04:04:18 INFO - Installing pip.................done. 04:04:18 INFO - Return code: 0 04:04:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:04:18 INFO - Reading from file tmpfile_stdout 04:04:18 INFO - Output received: 04:04:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:04:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100bd2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab03d59c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009b0d30>, '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 0x1008d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009a5be8>, '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.48IbiaIQE4/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.FgiHbHoo1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:04:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:04:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48IbiaIQE4/Render', 04:04:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:18 INFO - 'HOME': '/Users/cltbld', 04:04:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:18 INFO - 'LOGNAME': 'cltbld', 04:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:18 INFO - 'MOZ_NO_REMOTE': '1', 04:04:18 INFO - 'NO_EM_RESTART': '1', 04:04:18 INFO - 'PAGER': '/bin/cat', 04:04:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:18 INFO - 'PWD': '/builds/slave/test', 04:04:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:18 INFO - 'SHELL': '/bin/bash', 04:04:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FgiHbHoo1N/Listeners', 04:04:18 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 04:04:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:18 INFO - 'USER': 'cltbld', 04:04:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:18 INFO - 'XPC_FLAGS': '0x0', 04:04:18 INFO - 'XPC_SERVICE_NAME': '0', 04:04:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:04:18 INFO - Cleaning up... 04:04:18 INFO - Return code: 0 04:04:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100bd2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab03d59c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009b0d30>, '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 0x1008d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009a5be8>, '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.48IbiaIQE4/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.FgiHbHoo1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:04:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:04:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48IbiaIQE4/Render', 04:04:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:18 INFO - 'HOME': '/Users/cltbld', 04:04:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:18 INFO - 'LOGNAME': 'cltbld', 04:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:18 INFO - 'MOZ_NO_REMOTE': '1', 04:04:18 INFO - 'NO_EM_RESTART': '1', 04:04:18 INFO - 'PAGER': '/bin/cat', 04:04:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:18 INFO - 'PWD': '/builds/slave/test', 04:04:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:18 INFO - 'SHELL': '/bin/bash', 04:04:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FgiHbHoo1N/Listeners', 04:04:18 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 04:04:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:18 INFO - 'USER': 'cltbld', 04:04:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:18 INFO - 'XPC_FLAGS': '0x0', 04:04:18 INFO - 'XPC_SERVICE_NAME': '0', 04:04:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:19 INFO - Downloading/unpacking psutil>=3.1.1 04:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:04:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:04:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:04:21 INFO - Installing collected packages: psutil 04:04:21 INFO - Running setup.py install for psutil 04:04:21 INFO - building 'psutil._psutil_osx' extension 04:04:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:04:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:04:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:04:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:04:22 INFO - building 'psutil._psutil_posix' extension 04:04:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:04:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:04:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:04:22 INFO - ^ 04:04:22 INFO - 1 warning generated. 04:04:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:04:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:04:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:04:22 INFO - Successfully installed psutil 04:04:22 INFO - Cleaning up... 04:04:22 INFO - Return code: 0 04:04:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:22 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 0x100bd2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab03d59c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009b0d30>, '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 0x1008d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009a5be8>, '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.48IbiaIQE4/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.FgiHbHoo1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:04:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48IbiaIQE4/Render', 04:04:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:22 INFO - 'HOME': '/Users/cltbld', 04:04:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:22 INFO - 'LOGNAME': 'cltbld', 04:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:22 INFO - 'MOZ_NO_REMOTE': '1', 04:04:22 INFO - 'NO_EM_RESTART': '1', 04:04:22 INFO - 'PAGER': '/bin/cat', 04:04:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:22 INFO - 'PWD': '/builds/slave/test', 04:04:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:22 INFO - 'SHELL': '/bin/bash', 04:04:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FgiHbHoo1N/Listeners', 04:04:22 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 04:04:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:22 INFO - 'USER': 'cltbld', 04:04:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:22 INFO - 'XPC_FLAGS': '0x0', 04:04:22 INFO - 'XPC_SERVICE_NAME': '0', 04:04:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:04:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:04:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:04:24 INFO - Installing collected packages: mozsystemmonitor 04:04:24 INFO - Running setup.py install for mozsystemmonitor 04:04:24 INFO - Successfully installed mozsystemmonitor 04:04:24 INFO - Cleaning up... 04:04:24 INFO - Return code: 0 04:04:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:24 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 0x100bd2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab03d59c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009b0d30>, '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 0x1008d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009a5be8>, '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.48IbiaIQE4/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.FgiHbHoo1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:04:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48IbiaIQE4/Render', 04:04:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:24 INFO - 'HOME': '/Users/cltbld', 04:04:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:24 INFO - 'LOGNAME': 'cltbld', 04:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:24 INFO - 'MOZ_NO_REMOTE': '1', 04:04:24 INFO - 'NO_EM_RESTART': '1', 04:04:24 INFO - 'PAGER': '/bin/cat', 04:04:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:24 INFO - 'PWD': '/builds/slave/test', 04:04:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:24 INFO - 'SHELL': '/bin/bash', 04:04:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FgiHbHoo1N/Listeners', 04:04:24 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 04:04:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:24 INFO - 'USER': 'cltbld', 04:04:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:24 INFO - 'XPC_FLAGS': '0x0', 04:04:24 INFO - 'XPC_SERVICE_NAME': '0', 04:04:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:25 INFO - Downloading/unpacking jsonschema==2.5.1 04:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:04:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04:26 INFO - Downloading functools32-3.2.3-2.tar.gz 04:04:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:04:26 INFO - warning: no files found matching '*.txt' 04:04:26 INFO - no previously-included directories found matching 'build' 04:04:26 INFO - no previously-included directories found matching 'dist' 04:04:26 INFO - no previously-included directories found matching '.git*' 04:04:26 INFO - Installing collected packages: jsonschema, functools32 04:04:26 INFO - Running setup.py install for functools32 04:04:26 INFO - warning: no files found matching '*.txt' 04:04:26 INFO - no previously-included directories found matching 'build' 04:04:26 INFO - no previously-included directories found matching 'dist' 04:04:26 INFO - no previously-included directories found matching '.git*' 04:04:26 INFO - Successfully installed jsonschema functools32 04:04:26 INFO - Cleaning up... 04:04:26 INFO - Return code: 0 04:04:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:26 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 0x100bd2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab03d59c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009b0d30>, '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 0x1008d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009a5be8>, '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.48IbiaIQE4/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.FgiHbHoo1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:04:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:04:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48IbiaIQE4/Render', 04:04:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:26 INFO - 'HOME': '/Users/cltbld', 04:04:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:26 INFO - 'LOGNAME': 'cltbld', 04:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:26 INFO - 'MOZ_NO_REMOTE': '1', 04:04:26 INFO - 'NO_EM_RESTART': '1', 04:04:26 INFO - 'PAGER': '/bin/cat', 04:04:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:26 INFO - 'PWD': '/builds/slave/test', 04:04:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:26 INFO - 'SHELL': '/bin/bash', 04:04:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FgiHbHoo1N/Listeners', 04:04:26 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 04:04:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:26 INFO - 'USER': 'cltbld', 04:04:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:26 INFO - 'XPC_FLAGS': '0x0', 04:04:26 INFO - 'XPC_SERVICE_NAME': '0', 04:04:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:04:27 INFO - Cleaning up... 04:04:27 INFO - Return code: 0 04:04:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:27 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 0x100bd2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab03d59c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009b0d30>, '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 0x1008d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009a5be8>, '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.48IbiaIQE4/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.FgiHbHoo1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:04:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48IbiaIQE4/Render', 04:04:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:27 INFO - 'HOME': '/Users/cltbld', 04:04:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:27 INFO - 'LOGNAME': 'cltbld', 04:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:27 INFO - 'MOZ_NO_REMOTE': '1', 04:04:27 INFO - 'NO_EM_RESTART': '1', 04:04:27 INFO - 'PAGER': '/bin/cat', 04:04:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:27 INFO - 'PWD': '/builds/slave/test', 04:04:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:27 INFO - 'SHELL': '/bin/bash', 04:04:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FgiHbHoo1N/Listeners', 04:04:27 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 04:04:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:27 INFO - 'USER': 'cltbld', 04:04:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:27 INFO - 'XPC_FLAGS': '0x0', 04:04:27 INFO - 'XPC_SERVICE_NAME': '0', 04:04:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:27 INFO - Downloading/unpacking blobuploader==1.2.4 04:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:28 INFO - Downloading blobuploader-1.2.4.tar.gz 04:04:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:04:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:04:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04:29 INFO - Downloading docopt-0.6.1.tar.gz 04:04:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:04:29 INFO - Installing collected packages: blobuploader, requests, docopt 04:04:29 INFO - Running setup.py install for blobuploader 04:04:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:04:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:04:30 INFO - Running setup.py install for requests 04:04:30 INFO - Running setup.py install for docopt 04:04:30 INFO - Successfully installed blobuploader requests docopt 04:04:30 INFO - Cleaning up... 04:04:30 INFO - Return code: 0 04:04:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:30 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 0x100bd2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab03d59c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009b0d30>, '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 0x1008d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009a5be8>, '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.48IbiaIQE4/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.FgiHbHoo1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:04:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:04:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48IbiaIQE4/Render', 04:04:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:30 INFO - 'HOME': '/Users/cltbld', 04:04:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:30 INFO - 'LOGNAME': 'cltbld', 04:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:30 INFO - 'MOZ_NO_REMOTE': '1', 04:04:30 INFO - 'NO_EM_RESTART': '1', 04:04:30 INFO - 'PAGER': '/bin/cat', 04:04:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:30 INFO - 'PWD': '/builds/slave/test', 04:04:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:30 INFO - 'SHELL': '/bin/bash', 04:04:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FgiHbHoo1N/Listeners', 04:04:30 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 04:04:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:30 INFO - 'USER': 'cltbld', 04:04:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:30 INFO - 'XPC_FLAGS': '0x0', 04:04:30 INFO - 'XPC_SERVICE_NAME': '0', 04:04:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:04:30 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-yg2nG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:04:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-ULIncW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:04:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-EETt4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:04:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-6Ua9uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:04:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-O8MZ56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:04:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-ri8dJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:04:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-U68NEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:04:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-NETsL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:04:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-8YyvRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:04:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Ef2rKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:04:32 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-VucPbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:04:32 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-8LDqmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:04:32 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-YVI1qG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:04:32 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-j6V12w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:32 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-EQWHfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:04:32 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-hSFaAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:04:32 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-he58aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:04:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:04:32 INFO - Running setup.py install for manifestparser 04:04:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:04:32 INFO - Running setup.py install for mozcrash 04:04:33 INFO - Running setup.py install for mozdebug 04:04:33 INFO - Running setup.py install for mozdevice 04:04:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:04:33 INFO - Running setup.py install for mozfile 04:04:33 INFO - Running setup.py install for mozhttpd 04:04:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:04:33 INFO - Running setup.py install for mozinfo 04:04:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:04:33 INFO - Running setup.py install for mozInstall 04:04:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:04:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:04:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:04:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:04:33 INFO - Running setup.py install for mozleak 04:04:34 INFO - Running setup.py install for mozlog 04:04:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:04:34 INFO - Running setup.py install for moznetwork 04:04:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:04:34 INFO - Running setup.py install for mozprocess 04:04:34 INFO - Running setup.py install for mozprofile 04:04:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:04:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:04:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:04:34 INFO - Running setup.py install for mozrunner 04:04:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:04:34 INFO - Running setup.py install for mozscreenshot 04:04:34 INFO - Running setup.py install for moztest 04:04:35 INFO - Running setup.py install for mozversion 04:04:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:04:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:04:35 INFO - Cleaning up... 04:04:35 INFO - Return code: 0 04:04:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04: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')]} 04:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04: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')]} 04:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:35 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 0x100bd2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab03d59c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009b0d30>, '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 0x1008d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009a5be8>, '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.48IbiaIQE4/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.FgiHbHoo1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:04:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:04:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:04:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48IbiaIQE4/Render', 04:04:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:35 INFO - 'HOME': '/Users/cltbld', 04:04:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:35 INFO - 'LOGNAME': 'cltbld', 04:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:35 INFO - 'MOZ_NO_REMOTE': '1', 04:04:35 INFO - 'NO_EM_RESTART': '1', 04:04:35 INFO - 'PAGER': '/bin/cat', 04:04:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:35 INFO - 'PWD': '/builds/slave/test', 04:04:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:35 INFO - 'SHELL': '/bin/bash', 04:04:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FgiHbHoo1N/Listeners', 04:04:35 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 04:04:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:35 INFO - 'USER': 'cltbld', 04:04:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:35 INFO - 'XPC_FLAGS': '0x0', 04:04:35 INFO - 'XPC_SERVICE_NAME': '0', 04:04:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:04:35 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-pkbgMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:04:35 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-47rHSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:04:35 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-H66gIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:04:35 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-W7KBx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:04:35 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)) 04:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:04:35 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-cFnZca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:04:36 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-TuxHG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:04:36 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Pplfzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:04:36 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-XLTZcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:04:36 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-5yxZXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:04:36 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-q90gs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:04:36 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-5VT1_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:04:36 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-DyqMMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:04:36 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-WWWL8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:04:36 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Poxb3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:37 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-z5iiXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:04:37 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-PDUJ_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:04:37 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-CvB4qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:04:37 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)) 04:04:37 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)) 04:04:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04:38 INFO - Downloading blessings-1.6.tar.gz 04:04:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:04:38 INFO - Installing collected packages: blessings 04:04:38 INFO - Running setup.py install for blessings 04:04:38 INFO - Successfully installed blessings 04:04:38 INFO - Cleaning up... 04:04:39 INFO - Return code: 0 04:04:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:04:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:04:39 INFO - Reading from file tmpfile_stdout 04:04:39 INFO - Current package versions: 04:04:39 INFO - blessings == 1.6 04:04:39 INFO - blobuploader == 1.2.4 04:04:39 INFO - docopt == 0.6.1 04:04:39 INFO - functools32 == 3.2.3-2 04:04:39 INFO - jsonschema == 2.5.1 04:04:39 INFO - manifestparser == 1.1 04:04:39 INFO - mozInstall == 1.12 04:04:39 INFO - mozcrash == 1.0 04:04:39 INFO - mozdebug == 0.1 04:04:39 INFO - mozdevice == 0.50 04:04:39 INFO - mozfile == 1.2 04:04:39 INFO - mozhttpd == 0.7 04:04:39 INFO - mozinfo == 0.9 04:04:39 INFO - mozleak == 0.1 04:04:39 INFO - mozlog == 3.4 04:04:39 INFO - moznetwork == 0.27 04:04:39 INFO - mozprocess == 0.25 04:04:39 INFO - mozprofile == 0.28 04:04:39 INFO - mozrunner == 6.13 04:04:39 INFO - mozscreenshot == 0.1 04:04:39 INFO - mozsystemmonitor == 0.3 04:04:39 INFO - moztest == 0.8 04:04:39 INFO - mozversion == 1.4 04:04:39 INFO - psutil == 3.1.1 04:04:39 INFO - requests == 1.2.3 04:04:39 INFO - wsgiref == 0.1.2 04:04:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:39 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 0x100bd2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab03d59c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009b0d30>, '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 0x1008d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009a5be8>, '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.48IbiaIQE4/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.FgiHbHoo1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:04:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:04:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48IbiaIQE4/Render', 04:04:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:39 INFO - 'HOME': '/Users/cltbld', 04:04:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:39 INFO - 'LOGNAME': 'cltbld', 04:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:39 INFO - 'MOZ_NO_REMOTE': '1', 04:04:39 INFO - 'NO_EM_RESTART': '1', 04:04:39 INFO - 'PAGER': '/bin/cat', 04:04:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:39 INFO - 'PWD': '/builds/slave/test', 04:04:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:39 INFO - 'SHELL': '/bin/bash', 04:04:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FgiHbHoo1N/Listeners', 04:04:39 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 04:04:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:39 INFO - 'USER': 'cltbld', 04:04:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:39 INFO - 'XPC_FLAGS': '0x0', 04:04:39 INFO - 'XPC_SERVICE_NAME': '0', 04:04:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:04:39 INFO - Cleaning up... 04:04:39 INFO - Return code: 0 04:04:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:39 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 0x100bd2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab03d59c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009b0d30>, '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 0x1008d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009a5be8>, '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.48IbiaIQE4/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.FgiHbHoo1N/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:04:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:04:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48IbiaIQE4/Render', 04:04:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:39 INFO - 'HOME': '/Users/cltbld', 04:04:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:39 INFO - 'LOGNAME': 'cltbld', 04:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:39 INFO - 'MOZ_NO_REMOTE': '1', 04:04:39 INFO - 'NO_EM_RESTART': '1', 04:04:39 INFO - 'PAGER': '/bin/cat', 04:04:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:39 INFO - 'PWD': '/builds/slave/test', 04:04:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:39 INFO - 'SHELL': '/bin/bash', 04:04:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FgiHbHoo1N/Listeners', 04:04:39 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 04:04:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:39 INFO - 'USER': 'cltbld', 04:04:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:39 INFO - 'XPC_FLAGS': '0x0', 04:04:39 INFO - 'XPC_SERVICE_NAME': '0', 04:04:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:04:39 INFO - Cleaning up... 04:04:39 INFO - Return code: 0 04:04:39 INFO - Running post-action listener: _resource_record_post_action 04:04:39 INFO - Running post-action listener: _start_resource_monitoring 04:04:39 INFO - Starting resource monitoring. 04:04:39 INFO - [mozharness: 2017-05-07 11:04:39.869036Z] Finished create-virtualenv step (success) 04:04:39 INFO - [mozharness: 2017-05-07 11:04:39.870074Z] Running install step. 04:04:39 INFO - Running pre-action listener: _resource_record_pre_action 04:04:39 INFO - Running main action method: install 04:04:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:04:40 INFO - Reading from file tmpfile_stdout 04:04:40 INFO - Detecting whether we're running mozinstall >=1.0... 04:04:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:04:40 INFO - Reading from file tmpfile_stdout 04:04:40 INFO - Output received: 04:04:40 INFO - Usage: mozinstall [options] installer 04:04:40 INFO - Options: 04:04:40 INFO - -h, --help show this help message and exit 04:04:40 INFO - -d DEST, --destination=DEST 04:04:40 INFO - Directory to install application into. [default: 04:04:40 INFO - "/builds/slave/test"] 04:04:40 INFO - --app=APP Application being installed. [default: firefox] 04:04:40 INFO - mkdir: /builds/slave/test/build/application 04:04:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:05:00 INFO - Reading from file tmpfile_stdout 04:05:00 INFO - Output received: 04:05:00 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:05:00 INFO - Running post-action listener: _resource_record_post_action 04:05:00 INFO - [mozharness: 2017-05-07 11:05:00.230593Z] Finished install step (success) 04:05:00 INFO - [mozharness: 2017-05-07 11:05:00.230750Z] Running run-tests step. 04:05:00 INFO - Running pre-action listener: _resource_record_pre_action 04:05:00 INFO - Running main action method: run_tests 04:05:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:05:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:05:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:05:00 INFO - 2017-05-07 04:05:00.245 screenresolution[1635:7985] starting screenresolution argv=screenresolution get 04:05:00 INFO - 2017-05-07 04:05:00.248 screenresolution[1635:7985] Display 0: 1600x1200x32@60 04:05:00 INFO - 2017-05-07 04:05:00.254 screenresolution[1636:7988] starting screenresolution argv=screenresolution list 04:05:00 INFO - Available Modes on Display 0 04:05:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:05:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:05:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:05:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:05:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:05:00 INFO - Intel Iris: 04:05:00 INFO - Chipset Model: Intel Iris 04:05:00 INFO - Type: GPU 04:05:00 INFO - Bus: Built-In 04:05:00 INFO - VRAM (Dynamic, Max): 1536 MB 04:05:00 INFO - Vendor: Intel (0x8086) 04:05:00 INFO - Device ID: 0x0a2e 04:05:00 INFO - Revision ID: 0x0009 04:05:00 INFO - Displays: 04:05:00 INFO - Display: 04:05:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:05:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:05:00 INFO - Display Serial Number: 1600x1200 60 04:05:00 INFO - Main Display: Yes 04:05:00 INFO - Mirror: Off 04:05:00 INFO - Online: Yes 04:05:00 INFO - Rotation: Supported 04:05:00 INFO - Return code: 0 04:05:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:05:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:05:00 INFO - Python 2.7.3 04:05:00 INFO - Return code: 0 04:05:00 INFO - grabbing minidump binary from tooltool 04:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:00 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 0x1009b0d30>, '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 0x1008d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009a5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:05:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:05:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:05:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:05:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:05:00 INFO - Return code: 0 04:05:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:05:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:05:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:05:00 INFO - ENV: RUST_BACKTRACE is now 1 04:05:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:05:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:05:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0311', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:05:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0311 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:05:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48IbiaIQE4/Render', 04:05:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:00 INFO - 'HOME': '/Users/cltbld', 04:05:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:00 INFO - 'LOGNAME': 'cltbld', 04:05:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:05:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:05:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:00 INFO - 'MOZ_NO_REMOTE': '1', 04:05:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:05:00 INFO - 'NO_EM_RESTART': '1', 04:05:00 INFO - 'PAGER': '/bin/cat', 04:05:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:00 INFO - 'PWD': '/builds/slave/test', 04:05:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:05:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:00 INFO - 'RUST_BACKTRACE': '1', 04:05:00 INFO - 'SHELL': '/bin/bash', 04:05:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FgiHbHoo1N/Listeners', 04:05:00 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 04:05:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:00 INFO - 'USER': 'cltbld', 04:05:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:00 INFO - 'XPC_FLAGS': '0x0', 04:05:00 INFO - 'XPC_SERVICE_NAME': '0', 04:05:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0311', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:05:00 INFO - mozversion application_buildid: 20170507030205 04:05:00 INFO - mozversion application_changeset: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 04:05:00 INFO - mozversion application_display_name: Nightly 04:05:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:05:00 INFO - mozversion application_name: Firefox 04:05:00 INFO - mozversion application_remotingname: firefox 04:05:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:05:00 INFO - mozversion application_vendor: Mozilla 04:05:00 INFO - mozversion application_version: 55.0a1 04:05:00 INFO - mozversion platform_buildid: 20170507030205 04:05:00 INFO - mozversion platform_changeset: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 04:05:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:05:00 INFO - mozversion platform_version: 55.0a1 04:05:00 INFO - using testdate: 1494155100 04:05:00 INFO - actual date: 1494155100 04:05:00 INFO - starting webserver on 'localhost:49247' 04:05:00 INFO - SUITE-START | Running 2 tests 04:05:00 INFO - TEST-START | dromaeo_css 04:05:00 INFO - operating with platform_type : mac_ 04:05:00 INFO - Initialising browser for dromaeo_css test... 04:05:00 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpPnpeSc/profile http://localhost:49247/getInfo.html) 04:05:03 INFO - PID 1646 | 2017-05-07 04:05:03.388 plugin-container[1649:8182] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9c43, name = 'com.apple.tsm.portname' 04:05:03 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:05:03 INFO - PID 1646 | 2017-05-07 04:05:03.388 plugin-container[1649:8182] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0xa10f, name = 'com.apple.CFPasteboardClient' 04:05:03 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:05:03 INFO - PID 1646 | 2017-05-07 04:05:03.389 plugin-container[1649:8182] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:05:03 INFO - PID 1646 | __metrics Screen width/height:1600/1200 04:05:03 INFO - PID 1646 | colorDepth:24 04:05:03 INFO - PID 1646 | Browser inner width/height: 1024/691 04:05:03 INFO - PID 1646 | __metrics 04:05:04 INFO - TEST-INFO | 1646: exit 0 04:05:04 INFO - Browser initialized. 04:05:04 INFO - Running cycle 1/1 for dromaeo_css test... 04:05:04 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpPnpeSc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:05:07 INFO - PID 1651 | 2017-05-07 04:05:07.199 plugin-container[1652:8314] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x474f, name = 'com.apple.tsm.portname' 04:05:07 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:05:07 INFO - PID 1651 | 2017-05-07 04:05:07.200 plugin-container[1652:8314] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 04:05:07 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:05:07 INFO - PID 1651 | 2017-05-07 04:05:07.200 plugin-container[1652:8314] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:05:07 INFO - PID 1651 | 2017-05-07 04:05:07.669 plugin-container[1653:8359] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 04:05:07 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:05:07 INFO - PID 1651 | 2017-05-07 04:05:07.670 plugin-container[1653:8359] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903b, name = 'com.apple.CFPasteboardClient' 04:05:07 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:05:07 INFO - PID 1651 | 2017-05-07 04:05:07.670 plugin-container[1653:8359] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:05:17 INFO - PID 1651 | RSS: Main: 248229888 04:05:17 INFO - PID 1651 | 04:08:20 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 04:08:22 INFO - PID 1651 | RSS: Main: 252305408 04:08:22 INFO - PID 1651 | 04:11:24 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 04:11:25 INFO - PID 1651 | RSS: Main: 258314240 04:11:25 INFO - PID 1651 | 04:14:27 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 04:14:27 INFO - PID 1651 | RSS: Main: 268476416 04:14:27 INFO - PID 1651 | 04:17:29 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 04:17:30 INFO - PID 1651 | RSS: Main: 261033984 04:17:30 INFO - PID 1651 | 04:20:33 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 04:20:33 INFO - PID 1651 | RSS: Main: 265187328 04:20:33 INFO - PID 1651 | 04:23:35 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 04:23:35 INFO - PID 1651 | RSS: Main: 272035840 04:23:35 INFO - PID 1651 | 04:23:35 INFO - PID 1651 | __start_tp_report 04:23:35 INFO - PID 1651 | _x_x_mozilla_page_load 04:23:35 INFO - PID 1651 | _x_x_mozilla_page_load_details 04:23:35 INFO - PID 1651 | |i|pagename|runs| 04:23:35 INFO - PID 1651 | |0;dojo.html;3653.963460365397;3670.779753214807;3704.2591481703666;3711.7587356821823;3716.646918542738;6263.373662633734;6286.434220920122;6309.242890853098;6321.131348441811;6379.808605741823;6313.810585682437;6352.269489008765;6373.1714877065915;6379.07503412005;6379.808605741823;5382.569394448435;5384.811531596395;5478.233047373361;5580.720963951807;5671.319441667006;5577.776888924438;5637.943620563803;5650.463205995445;5655.688937108457;5657.405972372903;5545.861353466155;5567.387587365387;5599.4120617335;5625.38120806711;5645.294338207724;5503.3120859892515;5556.527695145917;5563.554915606742;5609.887802243932;5611.326640803089;5528.474794894479;5530.391656917735;5588.050031494615;5588.888222235573;5633.887322253573;4808.447028591721;6223.68881555925;6282.87434251317;6334.809955701337;6335.081413195061;6888;6889.724411023553;6901.344372284625;6914.239433662293;6925.342092501255;6959;6987.89518157228;6987.965060174666;7006.299370063004;7011.298870112999;6225.906611400833;6339.302676705559;6375.521835862236;6379.904301435482;6415.967920160369;7150.964245178845;7153.89269160963;7155.713771449084;7178.353948144692;7184.784456466315;5703.9429605704245;5950.85122871923;6010.158577799111;6714.362135597111;6734.259231484532;6941.618210998444;6960.443164546824;6981.89527157093;6985.231624521299;7004.964975175193;6591.538592298589;6689.1972963244725;6719.932800671931;6832.931670683329;6882.139732533434;5969.253843269591;6884.449244060464;6887.724491020404;6895.34494223048;6912.792616221522;5443.237946687467;5451.563874889999;5453.045716999509;5458.836234912959;5492.670439773627;3784.9432258516144;4790.401199850019;4819.566239038503;4856.490068542823;4880.902381952341;6103.761967187076;6374.808755737336;6419.2296924369375;6419.325970773095;6436.645984470805;6836.179658441019;6951.200611929693;6970.442364610819;6974.860502789916;6985.860282794316;6259.0924315973925;6412.839679008062;6415.967920160369;6420.454261387835;6420.5184611154355;5975.581709280395;6111.774065234738;6125.448709616156;6131.693415329305;6132.600268413531;7217.963910180415;7228.421726261781;7228.4578656599915;7233.204347521663;7245.963770181115;6743.224529179011;6941.167059952838;6941.409980151541;6946.235914049349;6998.2651821558;6923.411510021705;7107.644617769194;7157.785266442015;7187.209406965125;7216.097987751531;6853.17761868579;6875.106236189264;6880.9655951721925;6887;6894.034835123187;6695.5982641039745;6806.0131280963;6857.794266172023;6977;6990.790276291719;6570.145881035435;6602.801915942529;6675.866482670416;6738.022986667004;6773.729050837911;5200.557952573922;6670.633115178712;6678.298778628174;6729.7644582441335;6744.022116793136;6452.22573291208;6464.256610489854;6542.901856472062;6558.081868538504;6599.7360105595235;5891.823245302648;6503.674816259263;6591.8022459324375;6757.93242067573;6769.1876974763345;5487.725613719378;5806.519337568893;5844.853878653068;6142.894279029818;6543.836404089936 04:23:35 INFO - PID 1651 | |1;ext.html;733.2301083861945;827.5737994932609;1140;1272.408330126491;1285.9742805143892;31528.52707209388;36787.448188277165;37488.43767343492;37518.99999999996;37567.06082347943;37707.811460942656;37815.621843781555;38015;38020.619793802056;38030.619693803055;7408.851627997642;7791.999999999985;8230.382721295897;8275.586220688972;8337.374696897758;8416.957915210445;8434.283085937703;8504.234618884298;8515.403921725481;8526.658933642648;8419.789505262355;8505.277051450634;8537.18896704812;8542.87185692212;8553.957230213871;8436.409451338408;8475.660973561051;8496.320294376435;8511.404201705884;8535.189157030072;8245.299149572293;8261.958690206571;8295.958520207421;8315.334773218188;8330.958345208295;36604.450933236025;36721.63278367236;36925.63074369249;37086.44370334447;37095.4435683465;3631.9273614527824;3661.6704496595435;3668;3668.229671768932;3668.358037343481;30274.84862575695;30609.693903060906;30696.846515767502;30776.384472310652;30850;3007.578938948549;3096.9690303096904;3099.9070027898974;3107.0989413070183;3114.2837147455984;224755;278795;283136;284289;285343.5732821343;37430.625693743255;38066.23867522634;45921.85195370142;46489.30266046012;46603.76698116556;46978.5302146981;47404.814879628284;47499.05001900012;47654.28518572224;47727;14110;14119.71760564783;14248.715025699428;14257;14289.928550357181;11434.313941163557;11435.14236432271;11472.88527114718;11480.483378247998;11689.76620467586;13080.28058456794;13163.078584498993;13223.206607603575;13280.667983300495;13391.26348050847;5838;5844.561657875592;5856;5901.439363260483;5902.3507414184405;984.2667212926273;1007.6171054999201;1032.3702541449709;1033.571068006784;1051.984220236697;20788.376348709564;24251.272461826175;24496.510069798504;24518;24563.87718061398;953.9332246742662;1098.5880294889416;1114.5374669512062;1132.2979752553306;1150.8388825564427;11285.54857805695;12280.508779648893;12517.123801333819;12584.748305033849;12599.748005039848;308694;310226.8977310243;310629;312153;312382;52300.21549676758;52409.47590524122;52956.29305948547;53049;53118.468815312124;1509.7282489152058;1539.7844301797982;1566.717990761651;1577.8895477316478;1582.0586750883206;18189.636207276046;23008.4247893804;24081;24095.6989462318;24280.635790462802;30534.694653053186;30975.380492389577;36665.616734912146;37375.626243738305;37403.625963741106;261675;265613;266154.66922665265;266251;266755;32272;32782.50826237561;33263.66736332606;33859.15352116217;33945.98162055142;35319.940401787986;36776.63223367839;44211;44567;44781.88045298894;29422.264443389085;29437.558436623895;30332.84833575818;31205.219869503446;31277;28604.42791144207;30789.23026924345;31103.066907992797;31115.53326700056;31369.686303136677;28648.713512864604;35922.28155436929;36414.63585364113;37201.81399092987;37383.81308093442;30407.391852163277;30994.69005309918;31303;31323.68676313208;31651.683483165794;22824.543509130057;24178.768715475075;24547.018119275745;24615.261542153763;24626 04:23:35 INFO - PID 1651 | |2;jquery.html;437.87739432958784;446.37284615115755;451.79821674346243;460.8110674623404;465.5716740598647;21235.57528849422;21623.45941351465;22015.229466968638;22653.886730566323;22733.31800045997;18251.543711407223;22043.33869983899;22537.887310563467;23699.76300236997;23958.161464348752;4582.862514124565;6234.84412889678;6338.144350512668;6388.105665206875;6388.904166437507;5514.889702205954;6265.874682506347;6315.052742088677;6322.178116844803;6335.904961425559;6200;6248.218972628421;6252.781152659658;6264;6269.341719119495;6068.96965515174;6167.845803854917;6238.4697300729495;6242.625442473466;6262.499000079983;5577.776888924438;5594.832155035356;5598.552115830724;5639.069553523664;5641.294838145232;25553.977840886342;26532.46935061307;27283;27533.449331013268;27814.721852781415;2249;2292.5529521743265;2293.2317673579373;2295.0934380919443;2304.7349554801244;17383.826161738474;17775.911120444314;18248.81751182498;18348.63302733951;18395.908020459945;1941.7378653881685;2108.673155660875;2167.1981366894192;2168.11107445948;2179.858309209912;161006;162321.37678623298;165391;165887;166536;12582.937085314697;12776.233425994284;13067.803982940264;13091.279979601213;13200.801987970188;16826.326946921985;16836.579085522713;16864.57838554046;16865.747013794804;16998.745018824728;9024.458532488072;9073.682421115362;9152.725418237464;9266.073392660815;9294.209992150743;8599.484030958163;8618.956905215433;8622.353323500762;8774.649014039367;8782.341324400568;7245.094363204599;7693.769186924401;8177.795555111051;8202.26179643835;8207.876881846778;2288.39357570244;2293.140072472823;2294.736105347873;2304.873231972224;2493.1523282084177;987.2891518106951;1001.7095042437758;1003.4832061488339;1030.6444276724667;1036.1348274191134;15820.288087036111;18521.166547505396;20905.28687934622;22054.779452205592;22337;1021.4126877045728;1033.475847360497;1048.119579553179;1068.7274744939991;1073.726199819041;9758.804823903482;11337.43312834355;11362.147838912115;11386.032187264176;11407.030402415721;541629;544328;544615;559951;562847.1857640685;126906.04033556301;127921;127993.44013119685;129185;129420.35289823491;1180.728432460539;1194.5938380950518;1211.9636410907688;1212.4059210986552;1215.7203843115956;18104.764359498156;18677.346292879683;18784.966826824657;18855.528611784815;19036.71444928355;54874.902501950535;58385.91298609057;58521.9999999983;58560;60404.4898877514;63870.36129638644;64941.675291623236;65285;72893;74684.62657686895;8515.148485151436;8884.422512536665;8922.509261990654;9340.906590934004;9341.11259430353;10425.739356515844;12064.939675301568;13743.793843092162;14478.493252736103;14877.47928822486;11970.521179152736;12040.879591203975;12213.206141600767;12307.20003199789;12361.505539778667;11600.535978560763;11685.415729213675;11710.94144529272;11936.343501107522;12095.637130886087;10054.54754536033;11058.281211721212;11651.18441709106;12100.152989290666;12206.694832629255;8993.28053755711;9006.81986360256;9139.680111196341;9207.447553146832;9305.581248843953;11986.280823150639;12053.156279060382;12261.448234829275;12273.386330683608;12327.69180770488 04:23:35 INFO - PID 1651 | |3;mootools.html;1350.9527166549167;1409.8167238259039;1439.438618938614;1498.677784276381;1499.8500149985002;10511.474426278684;11438;11652.126090543201;11727.237729547584;12028.699282517942;11658.883411165885;11701.3564253966;11809.232399894023;11845.230060046091;11859.644210673694;2499.5750722377193;2538.4669219463844;2552.8723563821736;2553.2978430931457;2557.5268575313535;2479.82641215115;2498.150628786212;2509.9623505647337;2518.5970244760842;2522;2463.854307746897;2494.4138127540014;2508.4732206236713;2536.7843733282693;2538.9492210155786;2429.3197904586746;2457.6436416719653;2474.3319303787875;2479.652848601197;2481.702195736514;2402.2072716003677;2487.8134139939575;2500.437401584647;2508.172303139978;2525.154073385418;11768.235064720766;11868.940655296754;11874.584389546324;11886.573611166628;11898.881011189864;5724.742386592613;6546.607203567801;6778.423833974118;6787.151606049244;6791.966040169817;3403.4724617684296;4200.726952748061;4286.5284818669925;4317.719348242385;4359.956400436018;1245.0973044542634;1251.8873301402825;1280.6222164461412;1288.8582255951837;1292.0309767674244;16050.956687815255;16348.264328105144;16472.917635411864;16492.505224843273;16611;5437.673739575559;5510.834674959758;5586.35756887955;5675.2054712340305;5687.914681279784;11640.88359116398;11704.648860534198;11741.236819606698;11757.470913808898;11813.23213991105;6462.32145624712;6487.772927947499;6574.112494813235;6582.539222254492;6605.76879809214;5012.949870501321;6002.129691194839;6130.1724267224245;6137.723802428902;6149.292831324455;3855.325318069383;4192.782756115282;4455.844045458393;4469.128519938646;4476.6418686505;1165.8018136916576;1171.2796630072614;1177.5584155941522;1182.361524776611;1182.3733421286731;699.2238615137194;708.6527601475343;831.2684837343099;833;844.3076677124699;6165.229346331708;6252.624842509464;6338.524610654219;6414.069959855795;6474.15835941334;514.5189248053082;590.1325052173298;591.7987884119334;601.2964831147568;606.4632799971969;3987.322155233617;4089.427480152781;4267.637250833714;4330.458692663417;4393.824247030147;14710.33803478846;15002.474913377979;15090.24548772557;15094.622634434007;15108.924455377653;14380.56858294253;14951.551453456414;14954.626134346729;15019;15022.323995420233;7498.550086994906;8414.326853851677;8608.440451370641;8614.39699221061;8623.956880215559;5666.603337766317;5869;5934.9109763354445;6381.1704478417505;6758.797236082925;12652;12737.29944853005;12800.807987880375;12856.742865142833;13792.172469651852;11122.666320010412;11225.87741225871;13422.39599218018;13866.237356945061;13885.305734713022;9351.812963740824;9550.283728720235;9554.092361225672;9560.665376711782;9599.712008639752;10672.199585030998;10733.946330268298;10794.56821727122;10860.348379097279;10983.835242471529;7700.537967721954;9241.953790231006;9259.166674999282;9264.907350926405;9265.72202833916;8832.205101540892;8942.329325300758;8971;8983.550822458981;8986.236169925629;8136;8284.875726863982;8287.58562071906;8293.21214484623;8297.170282971896;5370.30835286899;6091.664958427329;6223.626582405071;6241;6315.778947736807;6199.380061993765;6207.193064901534;6334.556581039283;6339.334369891095;6393.665718173946 04:23:35 INFO - PID 1651 | |4;prototype.html;386.46474632633794;392.068836513281;392.75060336686204;398.48197343453523;398.81056498163366;5033.037115524944;5268.47315268473;6412.230532336121;6470.805875823727;6567.441767449773;5921.911171332434;6163.383661633834;6248.500119990401;6357.332480089582;6394.610856246185;3648.3797754381817;4463.352813841991;4495.460544734637;4643.651726120537;4659.836905708301;4233.343831706075;4638.860834174963;4649.488556258809;4652.906941861161;4655.88360290992;4597.988442542635;4609.953900460986;4617.07658468306;4617.5613316735025;4619.676622636417;3626.5648122225502;3750.474933509311;4515.7516336601475;4592.6555508337005;4608.953910460919;3572.5534308211472;3880.417937309398;3896.8051597420017;3901.2977664020464;3902;6283.937160628381;6314.494840412756;6323.778667746653;6323.968380158116;6340.461060809836;4541.3188021797;5271.367435907678;5438;5470.9452905470835;5530.198121272433;6787.741883895757;6848.9657551711925;6884.208316043669;6885.896711549331;6902;3702.241040586673;4280.315149576053;4430.867073987785;4434.2905135178535;4456.153330867125;6336.778212762531;7040.929590704079;7356.742514011984;7361.263873612649;7400.555966641965;4466.665000125004;4488.685791994529;4501.794120880811;4502.4371953505815;4510.639148868083;4019.33680942647;4564.997028906977;4566.150708962876;4568.954310456853;4587.472440669299;4792.496787837296;4992.026554821848;5321.441248668834;5482.945170548243;5491.615586908958;6861.4853885958755;6885.104936358342;6890.827729306808;6914.965425172943;6919.719851827428;1538.8768898488095;1553.8368471310575;1556.7820505129291;1558.1430213382594;1562.3750499800171;967.2890425537224;1003.1773945364731;1017.0541396501177;1018;1020.2501161646184;6514.026443869236;6522.152120224436;6523.673816309166;6559.573627714183;6585.275619681831;6116.66358350295;6552.705128269239;7009.964950175318;7186.281371862772;7233.240509746506;5585.357683866408;6391.872162556816;6514.674266286666;6519.903889862993;6532.314107018789;3644.2529281497227;3646.9154546907102;3699.891062094634;3708.592054873962;3741.28915506053;7176.354128128493;7362.77911662651;7389.408847292204;7400.481966262418;7411.407087432993;7145.606221915613;7240.950062240946;7252.673629686677;7290.927090729025;7301.780946571611;7265.600391978492;7281.381082607932;7310.892870530003;7335.193128755725;7369.22623124575;5878.529717622494;6240.375962403723;6673.099131617364;7069.469789765891;7090.6100164491445;6850.349216824394;6929.376356127973;6977.1278590176225;6983.7206511741;6985.567958568379;5696.772129114789;6410.967945160431;6589.736410543716;7393.630318484162;7413.332800048021;4458.977705111453;5070.949290507047;5110.4123025852505;5119.180931051014;5124.923126153036;6934.596531202824;7082.18554866197;7126.180489243803;7148.392386647193;7202.351788339075;5736.282964629421;6520.598595947811;6854.317040885297;6864.38220560152;6872.969054641644;5153.793848246029;6494.383033611799;6778.491613129134;6814.114165158498;6847.691853866489;5929;6352.333005034589;6678.966605166943;6691.631960242234;6722.764703235363;6596.769113081019;6888.655567221519;6892.379685828299;6934.301096231254;6978.302169782981;6703.631300278532;6746.942182634343;6755.290694477009;6762.64747050582;6778.559393639398 04:23:35 INFO - PID 1651 | |5;yui.html;774.693995871631;830.4311546590586;830.7673851321629;857.2670366836355;858.613623869259;14273.571792846205;14792.704145917101;16433.42483013095;16934.23795929183;16983.150842457875;12679.683007924807;13276.867231327684;17582.560435989108;17606.82393176068;17624.735628965576;944.187998321443;967.6371360739722;969.1955676788284;980.0052946259552;980.0248752491282;627.397698209717;642.1459458919649;951.3388195204336;975.687779910429;992.7369247149511;931.2643012020495;1016.0855230292722;1035.4926086217736;1039.8596189514433;1041.9322744021615;1016.1007508355121;1019.8164330420522;1034.632705389591;1035.414990530348;1035.9015893490107;758.3250906693048;766.3332900376653;766.3792328214108;767.2864236260276;769.5344316688379;13912.652183695387;14065.789013164811;14588;16181.595460113474;17246.913765431218;16459.58851028722;16739.916300418543;16920.323187072503;17095.316187352615;17128.486145415656;13768.724625507533;14066.2966851657;14230.501932432418;14240;14435.71128577433;3383.374075795986;3389.0510657016075;3410.7441941854213;3412.283420481702;3422.709069729076;124275.3786231063;124671;125112.99999999908;125296;127595;11469.426528673534;11516.193866429438;11656;11799.705007374712;11926.642200733992;16954.321827126776;19651.705224421647;19883.204671813255;20102;20109.899450502948;7053.858922821515;7061.223265440797;7079.29207079288;7100.822479437952;7140.250273721184;3244.3024749678934;3854.7494412863075;3870.4581358609817;3885.300645883768;3894.2211557688574;3824.196918647115;4120.299549076664;4250.617444430016;4261.531231564525;4270.765107919032;819.3035919468523;825.7894236969654;857.2713193785357;858.9012263589642;862.5773371048141;644.223710428932;659.5383231737707;669.5647828911247;671.9563228390139;689.1695506914157;10677.679669609925;11268;12023.519059237533;12023.819642705366;12166.57416990401;631.8041407163794;638.5051585021646;648.4747354642755;656.4736986506392;659.581165959619;4350.912981740347;4777.4505931818285;5526.58550608706;5568.693721845338;5649.322081350264;117194;118206;118845.81154188521;120088.79911200951;121221;98084.01915980891;103115.23520500692;103562.48218758858;103796.48101759443;104387.43418848723;77757.8336324967;92299.5385023084;93372.53313733388;94113;94773.52613236889;11129.332240065622;11369.886301136883;11424.200305978502;11441.828372574251;11644.53421863116;33861.66138338585;44046.33930490981;44825.327620085074;44971;45817.08365832731;41821.581784182985;56813.715931420076;56956;57342;58427.24718258459;13962.860371396157;14203.857961420254;14224.217668028357;14241.430342786172;16026;17994.91002544979;18747;18964.146613402707;19062;19093.904530477816;16848.494545163663;17210.91394543019;17351.219195135996;17526.948383097057;17566.945983241047;16950.643948483845;17348.04585747796;17496.91251543734;17540.210690518703;17557.034363110153;13003.479860805463;15744.212789360257;17075.829241707423;17091.829081709522;17142.40001599938;11571.71070723205;11714.472848721998;12060.457279422622;12281.93859030699;12423.440945157308;13026.674333141369;13151.802722958972;14033.578992630237;14105.717885642025;14129.788053179416 04:23:35 INFO - PID 1651 | __end_tp_report 04:23:35 INFO - PID 1651 | __start_cc_report 04:23:35 INFO - PID 1651 | _x_x_mozilla_cycle_collect,401 04:23:35 INFO - PID 1651 | __end_cc_report 04:23:35 INFO - PID 1651 | __startTimestamp1494156215853__endTimestamp 04:23:35 INFO - PID 1651 | 04:23:35 INFO - PID 1651 | ------- Summary: start ------- 04:23:35 INFO - PID 1651 | Number of tests: 6 04:23:35 INFO - PID 1651 | 04:23:35 INFO - PID 1651 | [#0] dojo.html Cycles:165 Average:6279.66 Median:6420.45 stddev:788.25 (12.3%) stddev-sans-first:763.28 04:23:35 INFO - PID 1651 | Values: 3654.0 3670.8 3704.3 3711.8 3716.6 6263.4 6286.4 6309.2 6321.1 6379.8 6313.8 6352.3 6373.2 6379.1 6379.8 5382.6 5384.8 5478.2 5580.7 5671.3 5577.8 5637.9 5650.5 5655.7 5657.4 5545.9 5567.4 5599.4 5625.4 5645.3 5503.3 5556.5 5563.6 5609.9 5611.3 5528.5 5530.4 5588.1 5588.9 5633.9 4808.4 6223.7 6282.9 6334.8 6335.1 6888.0 6889.7 6901.3 6914.2 6925.3 6959.0 6987.9 6988.0 7006.3 7011.3 6225.9 6339.3 6375.5 6379.9 6416.0 7151.0 7153.9 7155.7 7178.4 7184.8 5703.9 5950.9 6010.2 6714.4 6734.3 6941.6 6960.4 6981.9 6985.2 7005.0 6591.5 6689.2 6719.9 6832.9 6882.1 5969.3 6884.4 6887.7 6895.3 6912.8 5443.2 5451.6 5453.0 5458.8 5492.7 3784.9 4790.4 4819.6 4856.5 4880.9 6103.8 6374.8 6419.2 6419.3 6436.6 6836.2 6951.2 6970.4 6974.9 6985.9 6259.1 6412.8 6416.0 6420.5 6420.5 5975.6 6111.8 6125.4 6131.7 6132.6 7218.0 7228.4 7228.5 7233.2 7246.0 6743.2 6941.2 6941.4 6946.2 6998.3 6923.4 7107.6 7157.8 7187.2 7216.1 6853.2 6875.1 6881.0 6887.0 6894.0 6695.6 6806.0 6857.8 6977.0 6990.8 6570.1 6602.8 6675.9 6738.0 6773.7 5200.6 6670.6 6678.3 6729.8 6744.0 6452.2 6464.3 6542.9 6558.1 6599.7 5891.8 6503.7 6591.8 6757.9 6769.2 5487.7 5806.5 5844.9 6142.9 6543.8 04:23:35 INFO - PID 1651 | 04:23:35 INFO - PID 1651 | [#1] ext.html Cycles:180 Average:43032.23 Median:31313.34 stddev:74225.61 (237.0%) stddev-sans-first:74365.89 04:23:35 INFO - PID 1651 | Values: 733.2 827.6 1140.0 1272.4 1286.0 31528.5 36787.4 37488.4 37519.0 37567.1 37707.8 37815.6 38015.0 38020.6 38030.6 7408.9 7792.0 8230.4 8275.6 8337.4 8417.0 8434.3 8504.2 8515.4 8526.7 8419.8 8505.3 8537.2 8542.9 8554.0 8436.4 8475.7 8496.3 8511.4 8535.2 8245.3 8262.0 8296.0 8315.3 8331.0 36604.5 36721.6 36925.6 37086.4 37095.4 3631.9 3661.7 3668.0 3668.2 3668.4 30274.8 30609.7 30696.8 30776.4 30850.0 3007.6 3097.0 3099.9 3107.1 3114.3 224755.0 278795.0 283136.0 284289.0 285343.6 37430.6 38066.2 45921.9 46489.3 46603.8 46978.5 47404.8 47499.1 47654.3 47727.0 14110.0 14119.7 14248.7 14257.0 14289.9 11434.3 11435.1 11472.9 11480.5 11689.8 13080.3 13163.1 13223.2 13280.7 13391.3 5838.0 5844.6 5856.0 5901.4 5902.4 984.3 1007.6 1032.4 1033.6 1052.0 20788.4 24251.3 24496.5 24518.0 24563.9 953.9 1098.6 1114.5 1132.3 1150.8 11285.5 12280.5 12517.1 12584.7 12599.7 308694.0 310226.9 310629.0 312153.0 312382.0 52300.2 52409.5 52956.3 53049.0 53118.5 1509.7 1539.8 1566.7 1577.9 1582.1 18189.6 23008.4 24081.0 24095.7 24280.6 30534.7 30975.4 36665.6 37375.6 37403.6 261675.0 265613.0 266154.7 266251.0 266755.0 32272.0 32782.5 33263.7 33859.2 33946.0 35319.9 36776.6 44211.0 44567.0 44781.9 29422.3 29437.6 30332.8 31205.2 31277.0 28604.4 30789.2 31103.1 31115.5 31369.7 28648.7 35922.3 36414.6 37201.8 37383.8 30407.4 30994.7 31303.0 31323.7 31651.7 22824.5 24178.8 24547.0 24615.3 24626.0 04:23:35 INFO - PID 1651 | 04:23:35 INFO - PID 1651 | [#2] jquery.html Cycles:180 Average:35652.95 Median:22693.60 stddev:93617.10 (412.5%) stddev-sans-first:93842.38 04:23:35 INFO - PID 1651 | Values: 437.9 446.4 451.8 460.8 465.6 21235.6 21623.5 22015.2 22653.9 22733.3 18251.5 22043.3 22537.9 23699.8 23958.2 4582.9 6234.8 6338.1 6388.1 6388.9 5514.9 6265.9 6315.1 6322.2 6335.9 6200.0 6248.2 6252.8 6264.0 6269.3 6069.0 6167.8 6238.5 6242.6 6262.5 5577.8 5594.8 5598.6 5639.1 5641.3 25554.0 26532.5 27283.0 27533.4 27814.7 2249.0 2292.6 2293.2 2295.1 2304.7 17383.8 17775.9 18248.8 18348.6 18395.9 1941.7 2108.7 2167.2 2168.1 2179.9 161006.0 162321.4 165391.0 165887.0 166536.0 12582.9 12776.2 13067.8 13091.3 13200.8 16826.3 16836.6 16864.6 16865.7 16998.7 9024.5 9073.7 9152.7 9266.1 9294.2 8599.5 8619.0 8622.4 8774.6 8782.3 7245.1 7693.8 8177.8 8202.3 8207.9 2288.4 2293.1 2294.7 2304.9 2493.2 987.3 1001.7 1003.5 1030.6 1036.1 15820.3 18521.2 20905.3 22054.8 22337.0 1021.4 1033.5 1048.1 1068.7 1073.7 9758.8 11337.4 11362.1 11386.0 11407.0 541629.0 544328.0 544615.0 559951.0 562847.2 126906.0 127921.0 127993.4 129185.0 129420.4 1180.7 1194.6 1212.0 1212.4 1215.7 18104.8 18677.3 18785.0 18855.5 19036.7 54874.9 58385.9 58522.0 58560.0 60404.5 63870.4 64941.7 65285.0 72893.0 74684.6 8515.1 8884.4 8922.5 9340.9 9341.1 10425.7 12064.9 13743.8 14478.5 14877.5 11970.5 12040.9 12213.2 12307.2 12361.5 11600.5 11685.4 11710.9 11936.3 12095.6 10054.5 11058.3 11651.2 12100.2 12206.7 8993.3 9006.8 9139.7 9207.4 9305.6 11986.3 12053.2 12261.4 12273.4 12327.7 04:23:35 INFO - PID 1651 | 04:23:35 INFO - PID 1651 | [#3] mootools.html Cycles:180 Average:7036.29 Median:3629.40 stddev:4469.16 (123.1%) stddev-sans-first:4461.28 04:23:35 INFO - PID 1651 | Values: 1351.0 1409.8 1439.4 1498.7 1499.9 10511.5 11438.0 11652.1 11727.2 12028.7 11658.9 11701.4 11809.2 11845.2 11859.6 2499.6 2538.5 2552.9 2553.3 2557.5 2479.8 2498.2 2510.0 2518.6 2522.0 2463.9 2494.4 2508.5 2536.8 2538.9 2429.3 2457.6 2474.3 2479.7 2481.7 2402.2 2487.8 2500.4 2508.2 2525.2 11768.2 11868.9 11874.6 11886.6 11898.9 5724.7 6546.6 6778.4 6787.2 6792.0 3403.5 4200.7 4286.5 4317.7 4360.0 1245.1 1251.9 1280.6 1288.9 1292.0 16051.0 16348.3 16472.9 16492.5 16611.0 5437.7 5510.8 5586.4 5675.2 5687.9 11640.9 11704.6 11741.2 11757.5 11813.2 6462.3 6487.8 6574.1 6582.5 6605.8 5012.9 6002.1 6130.2 6137.7 6149.3 3855.3 4192.8 4455.8 4469.1 4476.6 1165.8 1171.3 1177.6 1182.4 1182.4 699.2 708.7 831.3 833.0 844.3 6165.2 6252.6 6338.5 6414.1 6474.2 514.5 590.1 591.8 601.3 606.5 3987.3 4089.4 4267.6 4330.5 4393.8 14710.3 15002.5 15090.2 15094.6 15108.9 14380.6 14951.6 14954.6 15019.0 15022.3 7498.6 8414.3 8608.4 8614.4 8624.0 5666.6 5869.0 5934.9 6381.2 6758.8 12652.0 12737.3 12800.8 12856.7 13792.2 11122.7 11225.9 13422.4 13866.2 13885.3 9351.8 9550.3 9554.1 9560.7 9599.7 10672.2 10733.9 10794.6 10860.3 10983.8 7700.5 9242.0 9259.2 9264.9 9265.7 8832.2 8942.3 8971.0 8983.6 8986.2 8136.0 8284.9 8287.6 8293.2 8297.2 5370.3 6091.7 6223.6 6241.0 6315.8 6199.4 6207.2 6334.6 6339.3 6393.7 04:23:35 INFO - PID 1651 | 04:23:35 INFO - PID 1651 | [#4] prototype.html Cycles:180 Average:5506.46 Median:6330.37 stddev:1786.13 (28.2%) stddev-sans-first:1749.31 04:23:35 INFO - PID 1651 | Values: 386.5 392.1 392.8 398.5 398.8 5033.0 5268.5 6412.2 6470.8 6567.4 5921.9 6163.4 6248.5 6357.3 6394.6 3648.4 4463.4 4495.5 4643.7 4659.8 4233.3 4638.9 4649.5 4652.9 4655.9 4598.0 4610.0 4617.1 4617.6 4619.7 3626.6 3750.5 4515.8 4592.7 4609.0 3572.6 3880.4 3896.8 3901.3 3902.0 6283.9 6314.5 6323.8 6324.0 6340.5 4541.3 5271.4 5438.0 5470.9 5530.2 6787.7 6849.0 6884.2 6885.9 6902.0 3702.2 4280.3 4430.9 4434.3 4456.2 6336.8 7040.9 7356.7 7361.3 7400.6 4466.7 4488.7 4501.8 4502.4 4510.6 4019.3 4565.0 4566.2 4569.0 4587.5 4792.5 4992.0 5321.4 5482.9 5491.6 6861.5 6885.1 6890.8 6915.0 6919.7 1538.9 1553.8 1556.8 1558.1 1562.4 967.3 1003.2 1017.1 1018.0 1020.3 6514.0 6522.2 6523.7 6559.6 6585.3 6116.7 6552.7 7010.0 7186.3 7233.2 5585.4 6391.9 6514.7 6519.9 6532.3 3644.3 3646.9 3699.9 3708.6 3741.3 7176.4 7362.8 7389.4 7400.5 7411.4 7145.6 7241.0 7252.7 7290.9 7301.8 7265.6 7281.4 7310.9 7335.2 7369.2 5878.5 6240.4 6673.1 7069.5 7090.6 6850.3 6929.4 6977.1 6983.7 6985.6 5696.8 6411.0 6589.7 7393.6 7413.3 4459.0 5070.9 5110.4 5119.2 5124.9 6934.6 7082.2 7126.2 7148.4 7202.4 5736.3 6520.6 6854.3 6864.4 6873.0 5153.8 6494.4 6778.5 6814.1 6847.7 5929.0 6352.3 6679.0 6691.6 6722.8 6596.8 6888.7 6892.4 6934.3 6978.3 6703.6 6746.9 6755.3 6762.6 6778.6 04:23:35 INFO - PID 1651 | 04:23:35 INFO - PID 1651 | [#5] yui.html Cycles:180 Average:22424.69 Median:17574.75 stddev:33123.32 (188.5%) stddev-sans-first:33176.35 04:23:35 INFO - PID 1651 | Values: 774.7 830.4 830.8 857.3 858.6 14273.6 14792.7 16433.4 16934.2 16983.2 12679.7 13276.9 17582.6 17606.8 17624.7 944.2 967.6 969.2 980.0 980.0 627.4 642.1 951.3 975.7 992.7 931.3 1016.1 1035.5 1039.9 1041.9 1016.1 1019.8 1034.6 1035.4 1035.9 758.3 766.3 766.4 767.3 769.5 13912.7 14065.8 14588.0 16181.6 17246.9 16459.6 16739.9 16920.3 17095.3 17128.5 13768.7 14066.3 14230.5 14240.0 14435.7 3383.4 3389.1 3410.7 3412.3 3422.7 124275.4 124671.0 125113.0 125296.0 127595.0 11469.4 11516.2 11656.0 11799.7 11926.6 16954.3 19651.7 19883.2 20102.0 20109.9 7053.9 7061.2 7079.3 7100.8 7140.3 3244.3 3854.7 3870.5 3885.3 3894.2 3824.2 4120.3 4250.6 4261.5 4270.8 819.3 825.8 857.3 858.9 862.6 644.2 659.5 669.6 672.0 689.2 10677.7 11268.0 12023.5 12023.8 12166.6 631.8 638.5 648.5 656.5 659.6 4350.9 4777.5 5526.6 5568.7 5649.3 117194.0 118206.0 118845.8 120088.8 121221.0 98084.0 103115.2 103562.5 103796.5 104387.4 77757.8 92299.5 93372.5 94113.0 94773.5 11129.3 11369.9 11424.2 11441.8 11644.5 33861.7 44046.3 44825.3 44971.0 45817.1 41821.6 56813.7 56956.0 57342.0 58427.2 13962.9 14203.9 14224.2 14241.4 16026.0 17994.9 18747.0 18964.1 19062.0 19093.9 16848.5 17210.9 17351.2 17526.9 17566.9 16950.6 17348.0 17496.9 17540.2 17557.0 13003.5 15744.2 17075.8 17091.8 17142.4 11571.7 11714.5 12060.5 12281.9 12423.4 13026.7 13151.8 14033.6 14105.7 14129.8 04:23:35 INFO - PID 1651 | -------- Summary: end -------- 04:23:35 INFO - PID 1651 | 04:23:36 INFO - TEST-INFO | 1651: exit 0 04:23:36 INFO - TEST-OK | dromaeo_css | took 1115633ms 04:23:36 INFO - TEST-START | kraken 04:23:36 INFO - operating with platform_type : mac_ 04:23:36 INFO - Initialising browser for kraken test... 04:23:36 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmphueERK/profile http://localhost:49247/getInfo.html) 04:23:39 INFO - PID 1661 | 2017-05-07 04:23:39.198 plugin-container[1662:10530] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x913f, name = 'com.apple.tsm.portname' 04:23:39 INFO - PID 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:23:39 INFO - PID 1661 | 2017-05-07 04:23:39.199 plugin-container[1662:10530] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4323, name = 'com.apple.CFPasteboardClient' 04:23:39 INFO - PID 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:23:39 INFO - PID 1661 | 2017-05-07 04:23:39.199 plugin-container[1662:10530] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:23:39 INFO - PID 1661 | __metrics Screen width/height:1600/1200 04:23:39 INFO - PID 1661 | colorDepth:24 04:23:39 INFO - PID 1661 | Browser inner width/height: 1024/691 04:23:39 INFO - PID 1661 | __metrics 04:23:39 INFO - PID 1661 | 2017-05-07 04:23:39.845 plugin-container[1663:10582] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x964b, name = 'com.apple.tsm.portname' 04:23:39 INFO - PID 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:23:39 INFO - PID 1661 | 2017-05-07 04:23:39.845 plugin-container[1663:10582] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980f, name = 'com.apple.CFPasteboardClient' 04:23:39 INFO - PID 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:23:39 INFO - PID 1661 | 2017-05-07 04:23:39.845 plugin-container[1663:10582] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:23:40 INFO - TEST-INFO | 1661: exit 0 04:23:40 INFO - Browser initialized. 04:23:40 INFO - Running cycle 1/1 for kraken test... 04:23:40 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmphueERK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:42 INFO - PID 1664 | 2017-05-07 04:23:42.841 plugin-container[1665:10686] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 04:23:42 INFO - PID 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:23:42 INFO - PID 1664 | 2017-05-07 04:23:42.841 plugin-container[1665:10686] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 04:23:42 INFO - PID 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:23:42 INFO - PID 1664 | 2017-05-07 04:23:42.841 plugin-container[1665:10686] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:23:43 INFO - PID 1664 | 2017-05-07 04:23:43.379 plugin-container[1666:10728] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 04:23:43 INFO - PID 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:23:43 INFO - PID 1664 | 2017-05-07 04:23:43.379 plugin-container[1666:10728] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 04:23:43 INFO - PID 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:23:43 INFO - PID 1664 | 2017-05-07 04:23:43.379 plugin-container[1666:10728] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:23:52 INFO - PID 1664 | RSS: Main: 233746432 04:23:52 INFO - PID 1664 | 04:23:55 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 04:23:56 INFO - PID 1664 | RSS: Main: 246636544 04:23:56 INFO - PID 1664 | 04:23:58 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 04:23:59 INFO - PID 1664 | RSS: Main: 254701568 04:23:59 INFO - PID 1664 | 04:24:02 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 04:24:03 INFO - PID 1664 | RSS: Main: 257060864 04:24:03 INFO - PID 1664 | 04:24:05 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 04:24:05 INFO - PID 1664 | RSS: Main: 259366912 04:24:05 INFO - PID 1664 | 04:24:07 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:24:08 INFO - PID 1664 | RSS: Main: 259686400 04:24:08 INFO - PID 1664 | 04:24:11 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 04:24:11 INFO - PID 1664 | RSS: Main: 265809920 04:24:11 INFO - PID 1664 | 04:24:14 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 04:24:15 INFO - PID 1664 | RSS: Main: 267649024 04:24:15 INFO - PID 1664 | 04:24:18 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 04:24:19 INFO - PID 1664 | RSS: Main: 267137024 04:24:19 INFO - PID 1664 | 04:24:20 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:24:21 INFO - PID 1664 | RSS: Main: 266948608 04:24:21 INFO - PID 1664 | 04:24:23 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:24:23 INFO - PID 1664 | RSS: Main: 266698752 04:24:23 INFO - PID 1664 | 04:24:25 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:24:26 INFO - PID 1664 | RSS: Main: 266280960 04:24:26 INFO - PID 1664 | 04:24:29 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:24:29 INFO - PID 1664 | RSS: Main: 266784768 04:24:29 INFO - PID 1664 | 04:24:33 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:24:33 INFO - PID 1664 | RSS: Main: 263987200 04:24:33 INFO - PID 1664 | 04:24:35 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 04:24:36 INFO - PID 1664 | RSS: Main: 265908224 04:24:36 INFO - PID 1664 | 04:24:36 INFO - PID 1664 | __start_tp_report 04:24:36 INFO - PID 1664 | _x_x_mozilla_page_load 04:24:36 INFO - PID 1664 | _x_x_mozilla_page_load_details 04:24:36 INFO - PID 1664 | |i|pagename|runs| 04:24:36 INFO - PID 1664 | |0;ai-astar;101;113;117;115;115;115;114;114;116;113 04:24:36 INFO - PID 1664 | |1;audio-beat-detection;130;134;96;139;113;98;117;104;125;135 04:24:36 INFO - PID 1664 | |2;audio-dft;195;198;245;254;206;203;199;195;197;195 04:24:36 INFO - PID 1664 | |3;audio-fft;77;60;58;79;58;59;70;56;73;84 04:24:36 INFO - PID 1664 | |4;audio-oscillator;81;69;84;69;67;68;86;68;68;90 04:24:36 INFO - PID 1664 | |5;imaging-gaussian-blur;90;87;89;88;90;94;88;88;89;96 04:24:36 INFO - PID 1664 | |6;imaging-darkroom;96;97;97;96;95;101;98;96;96;97 04:24:36 INFO - PID 1664 | |7;imaging-desaturate;91;114;91;90;87;89;87;129;142;93 04:24:36 INFO - PID 1664 | |8;json-parse-financial;52;49;51;70;74;74;75;74;51;52 04:24:36 INFO - PID 1664 | |9;json-stringify-tinderbox;57;60;66;63;57;69;60;55;57;58 04:24:36 INFO - PID 1664 | |10;stanford-crypto-aes;83;98;96;84;80;83;85;84;85;83 04:24:36 INFO - PID 1664 | |11;stanford-crypto-ccm;134;146;137;139;135;135;139;146;186;138 04:24:36 INFO - PID 1664 | |12;stanford-crypto-pbkdf2;238;240;227;162;236;235;206;186;228;186 04:24:36 INFO - PID 1664 | |13;stanford-crypto-sha256-iterative;68;70;69;87;98;89;88;96;74;68 04:24:36 INFO - PID 1664 | __end_tp_report 04:24:36 INFO - PID 1664 | __start_cc_report 04:24:36 INFO - PID 1664 | _x_x_mozilla_cycle_collect,968 04:24:36 INFO - PID 1664 | __end_cc_report 04:24:36 INFO - PID 1664 | __startTimestamp1494156276048__endTimestamp 04:24:36 INFO - PID 1664 | 04:24:36 INFO - PID 1664 | ------- Summary: start ------- 04:24:36 INFO - PID 1664 | Number of tests: 14 04:24:36 INFO - PID 1664 | 04:24:36 INFO - PID 1664 | [#0] ai-astar Cycles:10 Average:113.30 Median:115.00 stddev:4.50 (3.9%) stddev-sans-first:1.32 04:24:36 INFO - PID 1664 | Values: 101.0 113.0 117.0 115.0 115.0 115.0 114.0 114.0 116.0 113.0 04:24:36 INFO - PID 1664 | 04:24:36 INFO - PID 1664 | [#1] audio-beat-detection Cycles:10 Average:119.10 Median:134.50 stddev:15.89 (11.8%) stddev-sans-first:16.36 04:24:36 INFO - PID 1664 | Values: 130.0 134.0 96.0 139.0 113.0 98.0 117.0 104.0 125.0 135.0 04:24:36 INFO - PID 1664 | 04:24:36 INFO - PID 1664 | [#2] audio-dft Cycles:10 Average:208.70 Median:201.00 stddev:21.90 (10.9%) stddev-sans-first:22.66 04:24:36 INFO - PID 1664 | Values: 195.0 198.0 245.0 254.0 206.0 203.0 199.0 195.0 197.0 195.0 04:24:36 INFO - PID 1664 | 04:24:36 INFO - PID 1664 | [#3] audio-fft Cycles:10 Average:67.40 Median:71.50 stddev:10.39 (14.5%) stddev-sans-first:10.43 04:24:36 INFO - PID 1664 | Values: 77.0 60.0 58.0 79.0 58.0 59.0 70.0 56.0 73.0 84.0 04:24:36 INFO - PID 1664 | 04:24:36 INFO - PID 1664 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:75.00 stddev:9.10 (12.1%) stddev-sans-first:9.39 04:24:36 INFO - PID 1664 | Values: 81.0 69.0 84.0 69.0 67.0 68.0 86.0 68.0 68.0 90.0 04:24:36 INFO - PID 1664 | 04:24:36 INFO - PID 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:89.90 Median:89.50 stddev:2.88 (3.2%) stddev-sans-first:3.06 04:24:36 INFO - PID 1664 | Values: 90.0 87.0 89.0 88.0 90.0 94.0 88.0 88.0 89.0 96.0 04:24:36 INFO - PID 1664 | 04:24:36 INFO - PID 1664 | [#6] imaging-darkroom Cycles:10 Average:96.90 Median:96.50 stddev:1.66 (1.7%) stddev-sans-first:1.73 04:24:36 INFO - PID 1664 | Values: 96.0 97.0 97.0 96.0 95.0 101.0 98.0 96.0 96.0 97.0 04:24:36 INFO - PID 1664 | 04:24:36 INFO - PID 1664 | [#7] imaging-desaturate Cycles:10 Average:101.30 Median:89.50 stddev:19.87 (22.2%) stddev-sans-first:20.73 04:24:36 INFO - PID 1664 | Values: 91.0 114.0 91.0 90.0 87.0 89.0 87.0 129.0 142.0 93.0 04:24:36 INFO - PID 1664 | 04:24:36 INFO - PID 1664 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:72.00 stddev:11.91 (16.5%) stddev-sans-first:12.04 04:24:36 INFO - PID 1664 | Values: 52.0 49.0 51.0 70.0 74.0 74.0 75.0 74.0 51.0 52.0 04:24:36 INFO - PID 1664 | 04:24:36 INFO - PID 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:4.49 (7.5%) stddev-sans-first:4.61 04:24:36 INFO - PID 1664 | Values: 57.0 60.0 66.0 63.0 57.0 69.0 60.0 55.0 57.0 58.0 04:24:36 INFO - PID 1664 | 04:24:36 INFO - PID 1664 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:84.50 stddev:5.93 (7.0%) stddev-sans-first:6.19 04:24:36 INFO - PID 1664 | Values: 83.0 98.0 96.0 84.0 80.0 83.0 85.0 84.0 85.0 83.0 04:24:36 INFO - PID 1664 | 04:24:36 INFO - PID 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:139.00 stddev:15.52 (11.2%) stddev-sans-first:16.07 04:24:36 INFO - PID 1664 | Values: 134.0 146.0 137.0 139.0 135.0 135.0 139.0 146.0 186.0 138.0 04:24:36 INFO - PID 1664 | 04:24:36 INFO - PID 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:214.40 Median:231.50 stddev:27.64 (11.9%) stddev-sans-first:27.97 04:24:36 INFO - PID 1664 | Values: 238.0 240.0 227.0 162.0 236.0 235.0 206.0 186.0 228.0 186.0 04:24:36 INFO - PID 1664 | 04:24:36 INFO - PID 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.70 Median:87.50 stddev:12.08 (13.8%) stddev-sans-first:11.91 04:24:36 INFO - PID 1664 | Values: 68.0 70.0 69.0 87.0 98.0 89.0 88.0 96.0 74.0 68.0 04:24:36 INFO - PID 1664 | -------- Summary: end -------- 04:24:36 INFO - PID 1664 | 04:24:37 INFO - TEST-INFO | 1664: exit 0 04:24:37 INFO - TEST-OK | kraken | took 60628ms 04:24:37 INFO - SUITE-END | took 1176s 04:24:37 INFO - Completed test suite (00:19:36) 04:24:37 INFO - javascript benchmark 04:24:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7886.6317221723175, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3653.963460365397, 3670.779753214807, 3704.2591481703666, 3711.7587356821823, 3716.646918542738, 6263.373662633734, 6286.434220920122, 6309.242890853098, 6321.131348441811, 6379.808605741823, 6313.810585682437, 6352.269489008765, 6373.1714877065915, 6379.07503412005, 6379.808605741823, 5382.569394448435, 5384.811531596395, 5478.233047373361, 5580.720963951807, 5671.319441667006, 5577.776888924438, 5637.943620563803, 5650.463205995445, 5655.688937108457, 5657.405972372903, 5545.861353466155, 5567.387587365387, 5599.4120617335, 5625.38120806711, 5645.294338207724, 5503.3120859892515, 5556.527695145917, 5563.554915606742, 5609.887802243932, 5611.326640803089, 5528.474794894479, 5530.391656917735, 5588.050031494615, 5588.888222235573, 5633.887322253573, 4808.447028591721, 6223.68881555925, 6282.87434251317, 6334.809955701337, 6335.081413195061, 6888.0, 6889.724411023553, 6901.344372284625, 6914.239433662293, 6925.342092501255, 6959.0, 6987.89518157228, 6987.965060174666, 7006.299370063004, 7011.298870112999, 6225.906611400833, 6339.302676705559, 6375.521835862236, 6379.904301435482, 6415.967920160369, 7150.964245178845, 7153.89269160963, 7155.713771449084, 7178.353948144692, 7184.784456466315, 5703.9429605704245, 5950.85122871923, 6010.158577799111, 6714.362135597111, 6734.259231484532, 6941.618210998444, 6960.443164546824, 6981.89527157093, 6985.231624521299, 7004.964975175193, 6591.538592298589, 6689.1972963244725, 6719.932800671931, 6832.931670683329, 6882.139732533434, 5969.253843269591, 6884.449244060464, 6887.724491020404, 6895.34494223048, 6912.792616221522, 5443.237946687467, 5451.563874889999, 5453.045716999509, 5458.836234912959, 5492.670439773627, 3784.9432258516144, 4790.401199850019, 4819.566239038503, 4856.490068542823, 4880.902381952341, 6103.761967187076, 6374.808755737336, 6419.2296924369375, 6419.325970773095, 6436.645984470805, 6836.179658441019, 6951.200611929693, 6970.442364610819, 6974.860502789916, 6985.860282794316, 6259.0924315973925, 6412.839679008062, 6415.967920160369, 6420.454261387835, 6420.5184611154355, 5975.581709280395, 6111.774065234738, 6125.448709616156, 6131.693415329305, 6132.600268413531, 7217.963910180415, 7228.421726261781, 7228.4578656599915, 7233.204347521663, 7245.963770181115, 6743.224529179011, 6941.167059952838, 6941.409980151541, 6946.235914049349, 6998.2651821558, 6923.411510021705, 7107.644617769194, 7157.785266442015, 7187.209406965125, 7216.097987751531, 6853.17761868579, 6875.106236189264, 6880.9655951721925, 6887.0, 6894.034835123187, 6695.5982641039745, 6806.0131280963, 6857.794266172023, 6977.0, 6990.790276291719, 6570.145881035435, 6602.801915942529, 6675.866482670416, 6738.022986667004, 6773.729050837911, 5200.557952573922, 6670.633115178712, 6678.298778628174, 6729.7644582441335, 6744.022116793136, 6452.22573291208, 6464.256610489854, 6542.901856472062, 6558.081868538504, 6599.7360105595235, 5891.823245302648, 6503.674816259263, 6591.8022459324375, 6757.93242067573, 6769.1876974763345, 5487.725613719378, 5806.519337568893, 5844.853878653068, 6142.894279029818, 6543.836404089936], "value": 6226.845377354912, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.2301083861945, 827.5737994932609, 1140.0, 1272.408330126491, 1285.9742805143892, 31528.52707209388, 36787.448188277165, 37488.43767343492, 37518.99999999996, 37567.06082347943, 37707.811460942656, 37815.621843781555, 38015.0, 38020.619793802056, 38030.619693803055, 7408.851627997642, 7791.999999999985, 8230.382721295897, 8275.586220688972, 8337.374696897758, 8416.957915210445, 8434.283085937703, 8504.234618884298, 8515.403921725481, 8526.658933642648, 8419.789505262355, 8505.277051450634, 8537.18896704812, 8542.87185692212, 8553.957230213871, 8436.409451338408, 8475.660973561051, 8496.320294376435, 8511.404201705884, 8535.189157030072, 8245.299149572293, 8261.958690206571, 8295.958520207421, 8315.334773218188, 8330.958345208295, 36604.450933236025, 36721.63278367236, 36925.63074369249, 37086.44370334447, 37095.4435683465, 3631.9273614527824, 3661.6704496595435, 3668.0, 3668.229671768932, 3668.358037343481, 30274.84862575695, 30609.693903060906, 30696.846515767502, 30776.384472310652, 30850.0, 3007.578938948549, 3096.9690303096904, 3099.9070027898974, 3107.0989413070183, 3114.2837147455984, 224755.0, 278795.0, 283136.0, 284289.0, 285343.5732821343, 37430.625693743255, 38066.23867522634, 45921.85195370142, 46489.30266046012, 46603.76698116556, 46978.5302146981, 47404.814879628284, 47499.05001900012, 47654.28518572224, 47727.0, 14110.0, 14119.71760564783, 14248.715025699428, 14257.0, 14289.928550357181, 11434.313941163557, 11435.14236432271, 11472.88527114718, 11480.483378247998, 11689.76620467586, 13080.28058456794, 13163.078584498993, 13223.206607603575, 13280.667983300495, 13391.26348050847, 5838.0, 5844.561657875592, 5856.0, 5901.439363260483, 5902.3507414184405, 984.2667212926273, 1007.6171054999201, 1032.3702541449709, 1033.571068006784, 1051.984220236697, 20788.376348709564, 24251.272461826175, 24496.510069798504, 24518.0, 24563.87718061398, 953.9332246742662, 1098.5880294889416, 1114.5374669512062, 1132.2979752553306, 1150.8388825564427, 11285.54857805695, 12280.508779648893, 12517.123801333819, 12584.748305033849, 12599.748005039848, 308694.0, 310226.8977310243, 310629.0, 312153.0, 312382.0, 52300.21549676758, 52409.47590524122, 52956.29305948547, 53049.0, 53118.468815312124, 1509.7282489152058, 1539.7844301797982, 1566.717990761651, 1577.8895477316478, 1582.0586750883206, 18189.636207276046, 23008.4247893804, 24081.0, 24095.6989462318, 24280.635790462802, 30534.694653053186, 30975.380492389577, 36665.616734912146, 37375.626243738305, 37403.625963741106, 261675.0, 265613.0, 266154.66922665265, 266251.0, 266755.0, 32272.0, 32782.50826237561, 33263.66736332606, 33859.15352116217, 33945.98162055142, 35319.940401787986, 36776.63223367839, 44211.0, 44567.0, 44781.88045298894, 29422.264443389085, 29437.558436623895, 30332.84833575818, 31205.219869503446, 31277.0, 28604.42791144207, 30789.23026924345, 31103.066907992797, 31115.53326700056, 31369.686303136677, 28648.713512864604, 35922.28155436929, 36414.63585364113, 37201.81399092987, 37383.81308093442, 30407.391852163277, 30994.69005309918, 31303.0, 31323.68676313208, 31651.683483165794, 22824.543509130057, 24178.768715475075, 24547.018119275745, 24615.261542153763, 24626.0], "value": 17204.259063100828, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.87739432958784, 446.37284615115755, 451.79821674346243, 460.8110674623404, 465.5716740598647, 21235.57528849422, 21623.45941351465, 22015.229466968638, 22653.886730566323, 22733.31800045997, 18251.543711407223, 22043.33869983899, 22537.887310563467, 23699.76300236997, 23958.161464348752, 4582.862514124565, 6234.84412889678, 6338.144350512668, 6388.105665206875, 6388.904166437507, 5514.889702205954, 6265.874682506347, 6315.052742088677, 6322.178116844803, 6335.904961425559, 6200.0, 6248.218972628421, 6252.781152659658, 6264.0, 6269.341719119495, 6068.96965515174, 6167.845803854917, 6238.4697300729495, 6242.625442473466, 6262.499000079983, 5577.776888924438, 5594.832155035356, 5598.552115830724, 5639.069553523664, 5641.294838145232, 25553.977840886342, 26532.46935061307, 27283.0, 27533.449331013268, 27814.721852781415, 2249.0, 2292.5529521743265, 2293.2317673579373, 2295.0934380919443, 2304.7349554801244, 17383.826161738474, 17775.911120444314, 18248.81751182498, 18348.63302733951, 18395.908020459945, 1941.7378653881685, 2108.673155660875, 2167.1981366894192, 2168.11107445948, 2179.858309209912, 161006.0, 162321.37678623298, 165391.0, 165887.0, 166536.0, 12582.937085314697, 12776.233425994284, 13067.803982940264, 13091.279979601213, 13200.801987970188, 16826.326946921985, 16836.579085522713, 16864.57838554046, 16865.747013794804, 16998.745018824728, 9024.458532488072, 9073.682421115362, 9152.725418237464, 9266.073392660815, 9294.209992150743, 8599.484030958163, 8618.956905215433, 8622.353323500762, 8774.649014039367, 8782.341324400568, 7245.094363204599, 7693.769186924401, 8177.795555111051, 8202.26179643835, 8207.876881846778, 2288.39357570244, 2293.140072472823, 2294.736105347873, 2304.873231972224, 2493.1523282084177, 987.2891518106951, 1001.7095042437758, 1003.4832061488339, 1030.6444276724667, 1036.1348274191134, 15820.288087036111, 18521.166547505396, 20905.28687934622, 22054.779452205592, 22337.0, 1021.4126877045728, 1033.475847360497, 1048.119579553179, 1068.7274744939991, 1073.726199819041, 9758.804823903482, 11337.43312834355, 11362.147838912115, 11386.032187264176, 11407.030402415721, 541629.0, 544328.0, 544615.0, 559951.0, 562847.1857640685, 126906.04033556301, 127921.0, 127993.44013119685, 129185.0, 129420.35289823491, 1180.728432460539, 1194.5938380950518, 1211.9636410907688, 1212.4059210986552, 1215.7203843115956, 18104.764359498156, 18677.346292879683, 18784.966826824657, 18855.528611784815, 19036.71444928355, 54874.902501950535, 58385.91298609057, 58521.9999999983, 58560.0, 60404.4898877514, 63870.36129638644, 64941.675291623236, 65285.0, 72893.0, 74684.62657686895, 8515.148485151436, 8884.422512536665, 8922.509261990654, 9340.906590934004, 9341.11259430353, 10425.739356515844, 12064.939675301568, 13743.793843092162, 14478.493252736103, 14877.47928822486, 11970.521179152736, 12040.879591203975, 12213.206141600767, 12307.20003199789, 12361.505539778667, 11600.535978560763, 11685.415729213675, 11710.94144529272, 11936.343501107522, 12095.637130886087, 10054.54754536033, 11058.281211721212, 11651.18441709106, 12100.152989290666, 12206.694832629255, 8993.28053755711, 9006.81986360256, 9139.680111196341, 9207.447553146832, 9305.581248843953, 11986.280823150639, 12053.156279060382, 12261.448234829275, 12273.386330683608, 12327.69180770488], "value": 10554.10058926154, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.9527166549167, 1409.8167238259039, 1439.438618938614, 1498.677784276381, 1499.8500149985002, 10511.474426278684, 11438.0, 11652.126090543201, 11727.237729547584, 12028.699282517942, 11658.883411165885, 11701.3564253966, 11809.232399894023, 11845.230060046091, 11859.644210673694, 2499.5750722377193, 2538.4669219463844, 2552.8723563821736, 2553.2978430931457, 2557.5268575313535, 2479.82641215115, 2498.150628786212, 2509.9623505647337, 2518.5970244760842, 2522.0, 2463.854307746897, 2494.4138127540014, 2508.4732206236713, 2536.7843733282693, 2538.9492210155786, 2429.3197904586746, 2457.6436416719653, 2474.3319303787875, 2479.652848601197, 2481.702195736514, 2402.2072716003677, 2487.8134139939575, 2500.437401584647, 2508.172303139978, 2525.154073385418, 11768.235064720766, 11868.940655296754, 11874.584389546324, 11886.573611166628, 11898.881011189864, 5724.742386592613, 6546.607203567801, 6778.423833974118, 6787.151606049244, 6791.966040169817, 3403.4724617684296, 4200.726952748061, 4286.5284818669925, 4317.719348242385, 4359.956400436018, 1245.0973044542634, 1251.8873301402825, 1280.6222164461412, 1288.8582255951837, 1292.0309767674244, 16050.956687815255, 16348.264328105144, 16472.917635411864, 16492.505224843273, 16611.0, 5437.673739575559, 5510.834674959758, 5586.35756887955, 5675.2054712340305, 5687.914681279784, 11640.88359116398, 11704.648860534198, 11741.236819606698, 11757.470913808898, 11813.23213991105, 6462.32145624712, 6487.772927947499, 6574.112494813235, 6582.539222254492, 6605.76879809214, 5012.949870501321, 6002.129691194839, 6130.1724267224245, 6137.723802428902, 6149.292831324455, 3855.325318069383, 4192.782756115282, 4455.844045458393, 4469.128519938646, 4476.6418686505, 1165.8018136916576, 1171.2796630072614, 1177.5584155941522, 1182.361524776611, 1182.3733421286731, 699.2238615137194, 708.6527601475343, 831.2684837343099, 833.0, 844.3076677124699, 6165.229346331708, 6252.624842509464, 6338.524610654219, 6414.069959855795, 6474.15835941334, 514.5189248053082, 590.1325052173298, 591.7987884119334, 601.2964831147568, 606.4632799971969, 3987.322155233617, 4089.427480152781, 4267.637250833714, 4330.458692663417, 4393.824247030147, 14710.33803478846, 15002.474913377979, 15090.24548772557, 15094.622634434007, 15108.924455377653, 14380.56858294253, 14951.551453456414, 14954.626134346729, 15019.0, 15022.323995420233, 7498.550086994906, 8414.326853851677, 8608.440451370641, 8614.39699221061, 8623.956880215559, 5666.603337766317, 5869.0, 5934.9109763354445, 6381.1704478417505, 6758.797236082925, 12652.0, 12737.29944853005, 12800.807987880375, 12856.742865142833, 13792.172469651852, 11122.666320010412, 11225.87741225871, 13422.39599218018, 13866.237356945061, 13885.305734713022, 9351.812963740824, 9550.283728720235, 9554.092361225672, 9560.665376711782, 9599.712008639752, 10672.199585030998, 10733.946330268298, 10794.56821727122, 10860.348379097279, 10983.835242471529, 7700.537967721954, 9241.953790231006, 9259.166674999282, 9264.907350926405, 9265.72202833916, 8832.205101540892, 8942.329325300758, 8971.0, 8983.550822458981, 8986.236169925629, 8136.0, 8284.875726863982, 8287.58562071906, 8293.21214484623, 8297.170282971896, 5370.30835286899, 6091.664958427329, 6223.626582405071, 6241.0, 6315.778947736807, 6199.380061993765, 6207.193064901534, 6334.556581039283, 6339.334369891095, 6393.665718173946], "value": 5267.67947146431, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.46474632633794, 392.068836513281, 392.75060336686204, 398.48197343453523, 398.81056498163366, 5033.037115524944, 5268.47315268473, 6412.230532336121, 6470.805875823727, 6567.441767449773, 5921.911171332434, 6163.383661633834, 6248.500119990401, 6357.332480089582, 6394.610856246185, 3648.3797754381817, 4463.352813841991, 4495.460544734637, 4643.651726120537, 4659.836905708301, 4233.343831706075, 4638.860834174963, 4649.488556258809, 4652.906941861161, 4655.88360290992, 4597.988442542635, 4609.953900460986, 4617.07658468306, 4617.5613316735025, 4619.676622636417, 3626.5648122225502, 3750.474933509311, 4515.7516336601475, 4592.6555508337005, 4608.953910460919, 3572.5534308211472, 3880.417937309398, 3896.8051597420017, 3901.2977664020464, 3902.0, 6283.937160628381, 6314.494840412756, 6323.778667746653, 6323.968380158116, 6340.461060809836, 4541.3188021797, 5271.367435907678, 5438.0, 5470.9452905470835, 5530.198121272433, 6787.741883895757, 6848.9657551711925, 6884.208316043669, 6885.896711549331, 6902.0, 3702.241040586673, 4280.315149576053, 4430.867073987785, 4434.2905135178535, 4456.153330867125, 6336.778212762531, 7040.929590704079, 7356.742514011984, 7361.263873612649, 7400.555966641965, 4466.665000125004, 4488.685791994529, 4501.794120880811, 4502.4371953505815, 4510.639148868083, 4019.33680942647, 4564.997028906977, 4566.150708962876, 4568.954310456853, 4587.472440669299, 4792.496787837296, 4992.026554821848, 5321.441248668834, 5482.945170548243, 5491.615586908958, 6861.4853885958755, 6885.104936358342, 6890.827729306808, 6914.965425172943, 6919.719851827428, 1538.8768898488095, 1553.8368471310575, 1556.7820505129291, 1558.1430213382594, 1562.3750499800171, 967.2890425537224, 1003.1773945364731, 1017.0541396501177, 1018.0, 1020.2501161646184, 6514.026443869236, 6522.152120224436, 6523.673816309166, 6559.573627714183, 6585.275619681831, 6116.66358350295, 6552.705128269239, 7009.964950175318, 7186.281371862772, 7233.240509746506, 5585.357683866408, 6391.872162556816, 6514.674266286666, 6519.903889862993, 6532.314107018789, 3644.2529281497227, 3646.9154546907102, 3699.891062094634, 3708.592054873962, 3741.28915506053, 7176.354128128493, 7362.77911662651, 7389.408847292204, 7400.481966262418, 7411.407087432993, 7145.606221915613, 7240.950062240946, 7252.673629686677, 7290.927090729025, 7301.780946571611, 7265.600391978492, 7281.381082607932, 7310.892870530003, 7335.193128755725, 7369.22623124575, 5878.529717622494, 6240.375962403723, 6673.099131617364, 7069.469789765891, 7090.6100164491445, 6850.349216824394, 6929.376356127973, 6977.1278590176225, 6983.7206511741, 6985.567958568379, 5696.772129114789, 6410.967945160431, 6589.736410543716, 7393.630318484162, 7413.332800048021, 4458.977705111453, 5070.949290507047, 5110.4123025852505, 5119.180931051014, 5124.923126153036, 6934.596531202824, 7082.18554866197, 7126.180489243803, 7148.392386647193, 7202.351788339075, 5736.282964629421, 6520.598595947811, 6854.317040885297, 6864.38220560152, 6872.969054641644, 5153.793848246029, 6494.383033611799, 6778.491613129134, 6814.114165158498, 6847.691853866489, 5929.0, 6352.333005034589, 6678.966605166943, 6691.631960242234, 6722.764703235363, 6596.769113081019, 6888.655567221519, 6892.379685828299, 6934.301096231254, 6978.302169782981, 6703.631300278532, 6746.942182634343, 6755.290694477009, 6762.64747050582, 6778.559393639398], "value": 4938.888805222351, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.693995871631, 830.4311546590586, 830.7673851321629, 857.2670366836355, 858.613623869259, 14273.571792846205, 14792.704145917101, 16433.42483013095, 16934.23795929183, 16983.150842457875, 12679.683007924807, 13276.867231327684, 17582.560435989108, 17606.82393176068, 17624.735628965576, 944.187998321443, 967.6371360739722, 969.1955676788284, 980.0052946259552, 980.0248752491282, 627.397698209717, 642.1459458919649, 951.3388195204336, 975.687779910429, 992.7369247149511, 931.2643012020495, 1016.0855230292722, 1035.4926086217736, 1039.8596189514433, 1041.9322744021615, 1016.1007508355121, 1019.8164330420522, 1034.632705389591, 1035.414990530348, 1035.9015893490107, 758.3250906693048, 766.3332900376653, 766.3792328214108, 767.2864236260276, 769.5344316688379, 13912.652183695387, 14065.789013164811, 14588.0, 16181.595460113474, 17246.913765431218, 16459.58851028722, 16739.916300418543, 16920.323187072503, 17095.316187352615, 17128.486145415656, 13768.724625507533, 14066.2966851657, 14230.501932432418, 14240.0, 14435.71128577433, 3383.374075795986, 3389.0510657016075, 3410.7441941854213, 3412.283420481702, 3422.709069729076, 124275.3786231063, 124671.0, 125112.99999999908, 125296.0, 127595.0, 11469.426528673534, 11516.193866429438, 11656.0, 11799.705007374712, 11926.642200733992, 16954.321827126776, 19651.705224421647, 19883.204671813255, 20102.0, 20109.899450502948, 7053.858922821515, 7061.223265440797, 7079.29207079288, 7100.822479437952, 7140.250273721184, 3244.3024749678934, 3854.7494412863075, 3870.4581358609817, 3885.300645883768, 3894.2211557688574, 3824.196918647115, 4120.299549076664, 4250.617444430016, 4261.531231564525, 4270.765107919032, 819.3035919468523, 825.7894236969654, 857.2713193785357, 858.9012263589642, 862.5773371048141, 644.223710428932, 659.5383231737707, 669.5647828911247, 671.9563228390139, 689.1695506914157, 10677.679669609925, 11268.0, 12023.519059237533, 12023.819642705366, 12166.57416990401, 631.8041407163794, 638.5051585021646, 648.4747354642755, 656.4736986506392, 659.581165959619, 4350.912981740347, 4777.4505931818285, 5526.58550608706, 5568.693721845338, 5649.322081350264, 117194.0, 118206.0, 118845.81154188521, 120088.79911200951, 121221.0, 98084.01915980891, 103115.23520500692, 103562.48218758858, 103796.48101759443, 104387.43418848723, 77757.8336324967, 92299.5385023084, 93372.53313733388, 94113.0, 94773.52613236889, 11129.332240065622, 11369.886301136883, 11424.200305978502, 11441.828372574251, 11644.53421863116, 33861.66138338585, 44046.33930490981, 44825.327620085074, 44971.0, 45817.08365832731, 41821.581784182985, 56813.715931420076, 56956.0, 57342.0, 58427.24718258459, 13962.860371396157, 14203.857961420254, 14224.217668028357, 14241.430342786172, 16026.0, 17994.91002544979, 18747.0, 18964.146613402707, 19062.0, 19093.904530477816, 16848.494545163663, 17210.91394543019, 17351.219195135996, 17526.948383097057, 17566.945983241047, 16950.643948483845, 17348.04585747796, 17496.91251543734, 17540.210690518703, 17557.034363110153, 13003.479860805463, 15744.212789360257, 17075.829241707423, 17091.829081709522, 17142.40001599938, 11571.71070723205, 11714.472848721998, 12060.457279422622, 12281.93859030699, 12423.440945157308, 13026.674333141369, 13151.802722958972, 14033.578992630237, 14105.717885642025, 14129.788053179416], "value": 8179.867973582873, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 117.0, 115.0, 115.0, 115.0, 114.0, 114.0, 116.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 134.0, 96.0, 139.0, 113.0, 98.0, 117.0, 104.0, 125.0, 135.0], "value": 119.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 198.0, 245.0, 254.0, 206.0, 203.0, 199.0, 195.0, 197.0, 195.0], "value": 208.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 60.0, 58.0, 79.0, 58.0, 59.0, 70.0, 56.0, 73.0, 84.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 69.0, 84.0, 69.0, 67.0, 68.0, 86.0, 68.0, 68.0, 90.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 88.0, 90.0, 94.0, 88.0, 88.0, 89.0, 96.0], "value": 89.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 96.0, 95.0, 101.0, 98.0, 96.0, 96.0, 97.0], "value": 96.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 114.0, 91.0, 90.0, 87.0, 89.0, 87.0, 129.0, 142.0, 93.0], "value": 101.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 51.0, 70.0, 74.0, 74.0, 75.0, 74.0, 51.0, 52.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 66.0, 63.0, 57.0, 69.0, 60.0, 55.0, 57.0, 58.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 98.0, 96.0, 84.0, 80.0, 83.0, 85.0, 84.0, 85.0, 83.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 146.0, 137.0, 139.0, 135.0, 135.0, 139.0, 146.0, 186.0, 138.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [238.0, 240.0, 227.0, 162.0, 236.0, 235.0, 206.0, 186.0, 228.0, 186.0], "value": 214.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 69.0, 87.0, 98.0, 89.0, 88.0, 96.0, 74.0, 68.0], "value": 80.7, "unit": "score"}]}]} 04:24:37 INFO - Return code: 0 04:24:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:24:37 INFO - # TBPL SUCCESS # 04:24:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:24:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:24:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:24:37 INFO - 2017-05-07 04:24:37.394 screenresolution[1671:11125] starting screenresolution argv=screenresolution get 04:24:37 INFO - 2017-05-07 04:24:37.397 screenresolution[1671:11125] Display 0: 1600x1200x32@60 04:24:37 INFO - 2017-05-07 04:24:37.403 screenresolution[1672:11128] starting screenresolution argv=screenresolution list 04:24:37 INFO - Available Modes on Display 0 04:24:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:24:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:24:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:24:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:24:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:24:37 INFO - Intel Iris: 04:24:37 INFO - Chipset Model: Intel Iris 04:24:37 INFO - Type: GPU 04:24:37 INFO - Bus: Built-In 04:24:37 INFO - VRAM (Dynamic, Max): 1536 MB 04:24:37 INFO - Vendor: Intel (0x8086) 04:24:37 INFO - Device ID: 0x0a2e 04:24:37 INFO - Revision ID: 0x0009 04:24:37 INFO - Displays: 04:24:37 INFO - Display: 04:24:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:24:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:24:37 INFO - Display Serial Number: 1600x1200 60 04:24:37 INFO - Main Display: Yes 04:24:37 INFO - Mirror: Off 04:24:37 INFO - Online: Yes 04:24:37 INFO - Rotation: Supported 04:24:37 INFO - Return code: 0 04:24:37 INFO - Running post-action listener: _resource_record_post_action 04:24:37 INFO - [mozharness: 2017-05-07 11:24:37.643636Z] Finished run-tests step (success) 04:24:37 INFO - Running post-run listener: _resource_record_post_run 04:24:37 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 34124288; Write bytes: 515833856; Read time: 208; Write time: 1607 04:24:37 INFO - TinderboxPrint: CPU usage
54.1% 04:24:37 INFO - TinderboxPrint: I/O read bytes / time
34,124,288 / 208 04:24:37 INFO - TinderboxPrint: I/O write bytes / time
515,833,856 / 1,607 04:24:37 INFO - TinderboxPrint: CPU idle
2,200.0 (45.9%) 04:24:37 INFO - TinderboxPrint: CPU system
959.0 (20.0%) 04:24:37 INFO - TinderboxPrint: CPU user
1,630.7 (34.0%) 04:24:37 INFO - TinderboxPrint: Swap in / out
238,911,488 / 0 04:24:37 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205781504; Write bytes: 207763456; Read time: 16266; Write time: 422 04:24:37 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 32031232; Write bytes: 300996608; Read time: 187; Write time: 1157 04:24:38 INFO - Running post-run listener: _upload_blobber_files 04:24:38 INFO - Blob upload gear active. 04:24:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:24:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:24:38 INFO - (blobuploader) - INFO - Open directory for files ... 04:24:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:24:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:24:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:24:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:24:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:24:40 INFO - (blobuploader) - INFO - Done attempting. 04:24:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:24:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:24:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:24:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:24:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:24:42 INFO - (blobuploader) - INFO - Done attempting. 04:24:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:24:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:24:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:24:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:24:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:24:44 INFO - (blobuploader) - INFO - Done attempting. 04:24:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:24:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:24:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:24:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:24:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:24:47 INFO - (blobuploader) - INFO - Done attempting. 04:24:47 INFO - (blobuploader) - INFO - Iteration through files over. 04:24:47 INFO - Return code: 0 04:24:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:24:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:24:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb28dc26c71a77766ae404833b880c6352b02313461b633581693691dd55756cf27a125f0552d03f771e451794fb67ecb7347fef5ae3e1bd46b44ebe7309b2b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74ceedd765da96ac322cd9a3da205b366f3b829f16307f5b50826e7416a35b4930d1a6483027cc6a2887ef5ab06ebaa5aaa67a57150202b2c2b720d9802e5844", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abe357e0c71cb1e4b275338e8ad3debda9128537b01ee2543499aafdcfe3b0428dc0db2973334e03975115c6ff3fd14db25bac512d5be3b187a75b2f24866e63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54c53bb5cf3e0f93c6d61b3205932be0d7324be3bddbb79a098bc7943740c0662df0bd49f82b06cb47f8f2f9d0ab54fed10146fd0519873c688ce5868fc70168"} 04:24:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:24:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:24:47 INFO - Contents: 04:24:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb28dc26c71a77766ae404833b880c6352b02313461b633581693691dd55756cf27a125f0552d03f771e451794fb67ecb7347fef5ae3e1bd46b44ebe7309b2b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74ceedd765da96ac322cd9a3da205b366f3b829f16307f5b50826e7416a35b4930d1a6483027cc6a2887ef5ab06ebaa5aaa67a57150202b2c2b720d9802e5844", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abe357e0c71cb1e4b275338e8ad3debda9128537b01ee2543499aafdcfe3b0428dc0db2973334e03975115c6ff3fd14db25bac512d5be3b187a75b2f24866e63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54c53bb5cf3e0f93c6d61b3205932be0d7324be3bddbb79a098bc7943740c0662df0bd49f82b06cb47f8f2f9d0ab54fed10146fd0519873c688ce5868fc70168"} 04:24:47 INFO - Running post-run listener: copy_logs_to_upload_dir 04:24:47 INFO - Copying logs to upload dir... 04:24:47 INFO - mkdir: /builds/slave/test/build/upload/logs 04:24:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.549718 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-07 04:24:47.474443) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-07 04:24:47.478043) ========= 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.48IbiaIQE4/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.FgiHbHoo1N/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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/cb28dc26c71a77766ae404833b880c6352b02313461b633581693691dd55756cf27a125f0552d03f771e451794fb67ecb7347fef5ae3e1bd46b44ebe7309b2b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74ceedd765da96ac322cd9a3da205b366f3b829f16307f5b50826e7416a35b4930d1a6483027cc6a2887ef5ab06ebaa5aaa67a57150202b2c2b720d9802e5844", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abe357e0c71cb1e4b275338e8ad3debda9128537b01ee2543499aafdcfe3b0428dc0db2973334e03975115c6ff3fd14db25bac512d5be3b187a75b2f24866e63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54c53bb5cf3e0f93c6d61b3205932be0d7324be3bddbb79a098bc7943740c0662df0bd49f82b06cb47f8f2f9d0ab54fed10146fd0519873c688ce5868fc70168"} build_url:https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011191 build_url: 'https://queue.taskcluster.net/v1/task/ZKzN6Zw1RQ6my-LNxxpsWQ/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/cb28dc26c71a77766ae404833b880c6352b02313461b633581693691dd55756cf27a125f0552d03f771e451794fb67ecb7347fef5ae3e1bd46b44ebe7309b2b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74ceedd765da96ac322cd9a3da205b366f3b829f16307f5b50826e7416a35b4930d1a6483027cc6a2887ef5ab06ebaa5aaa67a57150202b2c2b720d9802e5844", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abe357e0c71cb1e4b275338e8ad3debda9128537b01ee2543499aafdcfe3b0428dc0db2973334e03975115c6ff3fd14db25bac512d5be3b187a75b2f24866e63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54c53bb5cf3e0f93c6d61b3205932be0d7324be3bddbb79a098bc7943740c0662df0bd49f82b06cb47f8f2f9d0ab54fed10146fd0519873c688ce5868fc70168"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-07 04:24:47.517298) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 04:24:47.517617) ========= 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.48IbiaIQE4/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.FgiHbHoo1N/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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.005200 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 04:24:47.568605) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-07 04:24:47.568922) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-07 04:24:47.569228) ========= ========= Total master_lag: 0.19 =========