builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0122 starttime: 1478190816.29 results: success (0) buildid: 20161103030205 builduid: 1d1483cf12d64dbbac00c1ce9f64e2ad revision: ade8d4a63e57560410de106450f37b50ed71cca5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 09:33:36.285608) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 09:33:36.286106) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 09:33:36.286418) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 09:33:36.309973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 09:33:36.310355) ========= 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.Se26TZsVHi/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.pLB3dkTHG0/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 --2016-11-03 09:33:36-- 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% 7.14M=0.002s 2016-11-03 09:33:36 (7.14 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121867 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 09:33:36.457472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 09:33:36.457845) ========= 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.Se26TZsVHi/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.pLB3dkTHG0/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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.019269 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 09:33:36.507818) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-03 09:33:36.508230) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ade8d4a63e57560410de106450f37b50ed71cca5 --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 ade8d4a63e57560410de106450f37b50ed71cca5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Se26TZsVHi/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.pLB3dkTHG0/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 2016-11-03 09:33:36,585 truncating revision to first 12 chars 2016-11-03 09:33:36,586 Setting DEBUG logging. 2016-11-03 09:33:36,586 attempt 1/10 2016-11-03 09:33:36,586 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ade8d4a63e57?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-03 09:33:37,704 unpacking tar archive at: mozilla-central-ade8d4a63e57/testing/mozharness/ program finished with exit code 0 elapsedTime=1.357044 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-03 09:33:37.890451) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 09:33:37.891039) ========= script_repo_revision: ade8d4a63e57560410de106450f37b50ed71cca5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 09:33:37.891688) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 09:33:37.892164) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 09:33:37.912073) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 16 secs) (at 2016-11-03 09:33:37.912427) ========= /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.Se26TZsVHi/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.pLB3dkTHG0/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 09:33:38 INFO - MultiFileLogger online at 20161103 09:33:38 in /builds/slave/test 09:33:38 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 09:33:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:33:38 INFO - {'append_to_log': False, 09:33:38 INFO - 'base_work_dir': '/builds/slave/test', 09:33:38 INFO - 'blob_upload_branch': 'Firefox', 09:33:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:33:38 INFO - 'branch': 'Firefox', 09:33:38 INFO - 'buildbot_json_path': 'buildprops.json', 09:33:38 INFO - 'config_files': ('talos/mac_config.py',), 09:33:38 INFO - 'default_actions': ('clobber', 09:33:38 INFO - 'read-buildbot-config', 09:33:38 INFO - 'download-and-extract', 09:33:38 INFO - 'populate-webroot', 09:33:38 INFO - 'create-virtualenv', 09:33:38 INFO - 'install', 09:33:38 INFO - 'run-tests'), 09:33:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:33:38 INFO - 'download_minidump_stackwalk': True, 09:33:38 INFO - 'download_symbols': 'ondemand', 09:33:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:33:38 INFO - 'tooltool.py': '/tools/tooltool.py', 09:33:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:33:38 INFO - '/tools/misc-python/virtualenv.py')}, 09:33:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:33:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:33:38 INFO - 'installer_path': 'installer.exe', 09:33:38 INFO - 'log_level': 'info', 09:33:38 INFO - 'log_name': 'talos', 09:33:38 INFO - 'log_to_console': True, 09:33:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:33:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:33:38 INFO - 'opt_config_files': (), 09:33:38 INFO - 'pip_index': False, 09:33:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:33:38 INFO - 'cmd': ('bash', 09:33:38 INFO - '-c', 09:33:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:33:38 INFO - 'enabled': True, 09:33:38 INFO - 'halt_on_failure': False, 09:33:38 INFO - 'name': 'check_screen_resolution'},), 09:33:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:33:38 INFO - 'cmd': ('bash', 09:33:38 INFO - '-c', 09:33:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:33:38 INFO - 'enabled': True, 09:33:38 INFO - 'halt_on_failure': False, 09:33:38 INFO - 'name': 'check_screen_resolution'},), 09:33:38 INFO - 'run_cmd_checks_enabled': True, 09:33:38 INFO - 'sps_profile': False, 09:33:38 INFO - 'sps_profile_interval': 0, 09:33:38 INFO - 'suite': 'dromaeojs-e10s', 09:33:38 INFO - 'system_bits': '32', 09:33:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:33:38 INFO - 'title': 't-yosemite-r7-0122', 09:33:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:33:38 INFO - 'use_talos_json': True, 09:33:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:33:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:33:38 INFO - 'work_dir': 'build'} 09:33:38 INFO - [mozharness: 2016-11-03 16:33:38.119718Z] Running clobber step. 09:33:38 INFO - Running pre-action listener: _resource_record_pre_action 09:33:38 INFO - Running main action method: clobber 09:33:38 INFO - rmtree: /builds/slave/test/build 09:33:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:33:39 INFO - Running post-action listener: _resource_record_post_action 09:33:39 INFO - [mozharness: 2016-11-03 16:33:39.122367Z] Finished clobber step (success) 09:33:39 INFO - [mozharness: 2016-11-03 16:33:39.122489Z] Running read-buildbot-config step. 09:33:39 INFO - Running pre-action listener: _resource_record_pre_action 09:33:39 INFO - Running main action method: read_buildbot_config 09:33:39 INFO - Using buildbot properties: 09:33:39 INFO - { 09:33:39 INFO - "project": "", 09:33:39 INFO - "product": "firefox", 09:33:39 INFO - "script_repo_revision": "production", 09:33:39 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:33:39 INFO - "repository": "", 09:33:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:33:39 INFO - "buildid": "20161103030205", 09:33:39 INFO - "stage_platform": "macosx64", 09:33:39 INFO - "basedir": "/builds/slave/test", 09:33:39 INFO - "nightly_build": "True", 09:33:39 INFO - "buildnumber": 2, 09:33:39 INFO - "slavename": "t-yosemite-r7-0122", 09:33:39 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:33:39 INFO - "platform": "yosemite_r7", 09:33:39 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:33:39 INFO - "branch": "mozilla-central", 09:33:39 INFO - "repo_path": "mozilla-central", 09:33:39 INFO - "revision": "ade8d4a63e57560410de106450f37b50ed71cca5", 09:33:39 INFO - "pgo_build": "False", 09:33:39 INFO - "builduid": "1d1483cf12d64dbbac00c1ce9f64e2ad", 09:33:39 INFO - "slavebuilddir": "test" 09:33:39 INFO - } 09:33:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 09:33:39 INFO - Running post-action listener: _resource_record_post_action 09:33:39 INFO - [mozharness: 2016-11-03 16:33:39.125961Z] Finished read-buildbot-config step (success) 09:33:39 INFO - [mozharness: 2016-11-03 16:33:39.126073Z] Running download-and-extract step. 09:33:39 INFO - Running pre-action listener: _resource_record_pre_action 09:33:39 INFO - Running main action method: download_and_extract 09:33:39 INFO - mkdir: /builds/slave/test/build/tests 09:33: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')]} 09:33:39 INFO - trying https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 09:33:39 INFO - Downloading https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:33:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 09:33:40 INFO - Downloaded 1199 bytes. 09:33:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:33:40 INFO - Using the following test package requirements: 09:33:40 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:33:40 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:33:40 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 09:33:40 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:33:40 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 09:33:40 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:33:40 INFO - u'jsshell-mac.zip'], 09:33:40 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:33:40 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 09:33:40 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:33:40 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:33:40 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 09:33:40 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:33:40 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 09:33:40 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:33:40 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 09:33:40 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:33:40 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 09:33:40 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:33:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:33:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:33:40 INFO - Fetch https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:33:40 INFO - Http code: 200 09:33:40 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 09:33:40 INFO - x-amz-cf-id: eSLonIa-9r1lejg0Pw1xwgn64MzGvVWu8VdiwAa3zpwoyfiKVNZ-_w== 09:33:40 INFO - x-amz-version-id: eKq6BuUe4f_gOcSYdb9daBuctkYheATO 09:33:41 INFO - Expected file size: 16389309 09:33:41 INFO - Obtained file size: 16389309 09:33:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:33:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:33:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:33:47 INFO - Fetch https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:33:48 INFO - Http code: 200 09:33:48 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 09:33:48 INFO - x-amz-cf-id: zN0LtEtyurH7jLuKt7hYOK8B0rwp63ZEsSJxzgEtev_jVkDaO9FI0g== 09:33:48 INFO - x-amz-version-id: eKq6BuUe4f_gOcSYdb9daBuctkYheATO 09:33:48 INFO - Expected file size: 16389309 09:33:48 INFO - Obtained file size: 16389309 09:33:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 09:33:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:33:55 INFO - Fetch https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 09:33:55 INFO - Http code: 200 09:33:55 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 09:33:55 INFO - x-amz-cf-id: E6CypEwgPMSPHRhrQV2UwpWEUt_vJewuUFVmuJCCKhPnChjtDiv-HQ== 09:33:55 INFO - x-amz-version-id: WlTrlaMySozm31t3ZvC4rjaqy1F8ZvtY 09:33:56 INFO - Expected file size: 14409038 09:33:56 INFO - Obtained file size: 14409038 09:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:56 INFO - trying https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:33:56 INFO - Downloading https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 09:33:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 09:34:28 WARNING - Socket error when accessing https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg: The read operation timed out 09:34:28 INFO - retry: attempt #1 caught exception: The read operation timed out 09:34:28 INFO - retry: Failed, sleeping 30 seconds before retrying 09:34:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #2 09:35:01 INFO - Downloaded 112093920 bytes. 09:35:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:35:01 INFO - mkdir: /builds/slave/test/properties 09:35:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:35:01 INFO - Writing to file /builds/slave/test/properties/build_url 09:35:01 INFO - Contents: 09:35:01 INFO - build_url:https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:35:02 INFO - Running post-action listener: _resource_record_post_action 09:35:02 INFO - Running post-action listener: set_extra_try_arguments 09:35:02 INFO - [mozharness: 2016-11-03 16:35:02.598586Z] Finished download-and-extract step (success) 09:35:02 INFO - [mozharness: 2016-11-03 16:35:02.598711Z] Running populate-webroot step. 09:35:02 INFO - Running pre-action listener: _resource_record_pre_action 09:35:02 INFO - Running main action method: populate_webroot 09:35:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:35:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:35:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:35:02 INFO - '--tppagecycles', 09:35:02 INFO - '7'], 09:35:02 INFO - 'tests': ['tsvgm']}}, 09:35:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:35:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:35:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:35:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:35:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:35:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:35:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:02 INFO - 'talos_options': ['--disable-e10s'], 09:35:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:02 INFO - 'talos_options': ['--disable-e10s'], 09:35:02 INFO - 'tests': ['damp', 'tps']}, 09:35:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:02 INFO - 'tests': ['damp', 'tps']}, 09:35:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:35:02 INFO - 'tests': ['dromaeo_dom']}, 09:35:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:35:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:35:02 INFO - 'tests': ['basic_compositor_video']}, 09:35:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:35:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:35:02 INFO - 'tests': ['a11yr', 09:35:02 INFO - 'ts_paint', 09:35:02 INFO - 'tpaint', 09:35:02 INFO - 'sessionrestore', 09:35:02 INFO - 'sessionrestore_no_auto_restore', 09:35:02 INFO - 'tabpaint']}, 09:35:02 INFO - 'other-e10s': {'tests': ['a11yr', 09:35:02 INFO - 'ts_paint', 09:35:02 INFO - 'tpaint', 09:35:02 INFO - 'sessionrestore', 09:35:02 INFO - 'sessionrestore_no_auto_restore', 09:35:02 INFO - 'tabpaint']}, 09:35:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:35:02 INFO - 'ts_paint', 09:35:02 INFO - 'tpaint', 09:35:02 INFO - 'sessionrestore', 09:35:02 INFO - 'sessionrestore_no_auto_restore', 09:35:02 INFO - 'tabpaint']}, 09:35:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:35:02 INFO - 'ts_paint', 09:35:02 INFO - 'tpaint', 09:35:02 INFO - 'sessionrestore', 09:35:02 INFO - 'sessionrestore_no_auto_restore', 09:35:02 INFO - 'tabpaint']}, 09:35:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:35:02 INFO - 'tests': ['a11yr', 09:35:02 INFO - 'ts_paint', 09:35:02 INFO - 'tpaint', 09:35:02 INFO - 'sessionrestore', 09:35:02 INFO - 'sessionrestore_no_auto_restore', 09:35:02 INFO - 'tabpaint']}, 09:35:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:35:02 INFO - 'tests': ['a11yr', 09:35:02 INFO - 'ts_paint', 09:35:02 INFO - 'tpaint', 09:35:02 INFO - 'sessionrestore', 09:35:02 INFO - 'sessionrestore_no_auto_restore', 09:35:02 INFO - 'tabpaint']}, 09:35:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:35:02 INFO - 'tests': ['tsvgx', 09:35:02 INFO - 'tsvgr_opacity', 09:35:02 INFO - 'tart', 09:35:02 INFO - 'tscrollx', 09:35:02 INFO - 'cart']}, 09:35:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:35:02 INFO - 'tsvgr_opacity', 09:35:02 INFO - 'tart', 09:35:02 INFO - 'tscrollx', 09:35:02 INFO - 'cart']}, 09:35:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:02 INFO - 'talos_options': ['--disable-e10s'], 09:35:02 INFO - 'tests': ['tp5o']}, 09:35:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:02 INFO - 'tests': ['tp5o']}, 09:35:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:02 INFO - 'talos_options': ['--disable-e10s', 09:35:02 INFO - '--xperf_path', 09:35:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:02 INFO - 'tests': ['tp5n']}, 09:35:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:02 INFO - 'talos_options': ['--xperf_path', 09:35:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:02 INFO - 'tests': ['tp5n']}}, 09:35:02 INFO - 'talos.zip': {'path': '', 09:35:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:35:02 INFO - Running post-action listener: _resource_record_post_action 09:35:02 INFO - [mozharness: 2016-11-03 16:35:02.617476Z] Finished populate-webroot step (success) 09:35:02 INFO - [mozharness: 2016-11-03 16:35:02.617611Z] Running create-virtualenv step. 09:35:02 INFO - Running pre-action listener: _resource_record_pre_action 09:35:02 INFO - Running main action method: create_virtualenv 09:35:02 INFO - Creating virtualenv /builds/slave/test/build/venv 09:35:02 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 09:35:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:35:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:35:02 INFO - Using real prefix '/tools/python27' 09:35:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:35:03 INFO - Installing distribute.............................................................................................................................................................................................done. 09:35:06 INFO - Installing pip.................done. 09:35:06 INFO - Return code: 0 09:35:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:35:06 INFO - Reading from file tmpfile_stdout 09:35:06 INFO - Output received: 09:35:06 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) 09:35:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:35:06 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')]} 09:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:06 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')]} 09:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:06 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 0x10c555490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff49ad65600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c369d30>, '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 0x10c18fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c361b20>, '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.Se26TZsVHi/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.pLB3dkTHG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 09:35:06 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 09:35:06 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 09:35:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Se26TZsVHi/Render', 09:35:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:06 INFO - 'HOME': '/Users/cltbld', 09:35:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:06 INFO - 'LOGNAME': 'cltbld', 09:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:06 INFO - 'MOZ_NO_REMOTE': '1', 09:35:06 INFO - 'NO_EM_RESTART': '1', 09:35:06 INFO - 'PAGER': '/bin/cat', 09:35:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:06 INFO - 'PWD': '/builds/slave/test', 09:35:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:06 INFO - 'SHELL': '/bin/bash', 09:35:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLB3dkTHG0/Listeners', 09:35:06 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 09:35:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:06 INFO - 'USER': 'cltbld', 09:35:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:06 INFO - 'XPC_FLAGS': '0x0', 09:35:06 INFO - 'XPC_SERVICE_NAME': '0', 09:35:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:06 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 09:35:06 INFO - Cleaning up... 09:35:06 INFO - Return code: 0 09:35:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:35:06 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')]} 09:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:06 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')]} 09:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:06 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 0x10c555490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff49ad65600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c369d30>, '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 0x10c18fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c361b20>, '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.Se26TZsVHi/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.pLB3dkTHG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 09:35:06 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 09:35:06 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 09:35:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Se26TZsVHi/Render', 09:35:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:06 INFO - 'HOME': '/Users/cltbld', 09:35:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:06 INFO - 'LOGNAME': 'cltbld', 09:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:06 INFO - 'MOZ_NO_REMOTE': '1', 09:35:06 INFO - 'NO_EM_RESTART': '1', 09:35:06 INFO - 'PAGER': '/bin/cat', 09:35:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:06 INFO - 'PWD': '/builds/slave/test', 09:35:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:06 INFO - 'SHELL': '/bin/bash', 09:35:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLB3dkTHG0/Listeners', 09:35:06 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 09:35:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:06 INFO - 'USER': 'cltbld', 09:35:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:06 INFO - 'XPC_FLAGS': '0x0', 09:35:06 INFO - 'XPC_SERVICE_NAME': '0', 09:35:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:07 INFO - Downloading/unpacking psutil>=3.1.1 09:35:07 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 09:35:07 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 09:35:07 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 09:35:07 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 09:35:07 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 09:35:07 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 09:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:35:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:10 INFO - Installing collected packages: psutil 09:35:10 INFO - Running setup.py install for psutil 09:35:10 INFO - building 'psutil._psutil_osx' extension 09:35:10 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 09:35:11 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 09:35:11 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 09:35:11 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 09:35:11 INFO - building 'psutil._psutil_posix' extension 09:35:11 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 09:35:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:35:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:35:11 INFO - ^ 09:35:11 INFO - 1 warning generated. 09:35:11 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 09:35:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:11 INFO - Successfully installed psutil 09:35:11 INFO - Cleaning up... 09:35:11 INFO - Return code: 0 09:35:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:35: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')]} 09:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35: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')]} 09:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:11 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 0x10c555490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff49ad65600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c369d30>, '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 0x10c18fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c361b20>, '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.Se26TZsVHi/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.pLB3dkTHG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 09:35:11 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 09:35:11 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 09:35:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Se26TZsVHi/Render', 09:35:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:11 INFO - 'HOME': '/Users/cltbld', 09:35:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:11 INFO - 'LOGNAME': 'cltbld', 09:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:11 INFO - 'MOZ_NO_REMOTE': '1', 09:35:11 INFO - 'NO_EM_RESTART': '1', 09:35:11 INFO - 'PAGER': '/bin/cat', 09:35:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:11 INFO - 'PWD': '/builds/slave/test', 09:35:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:11 INFO - 'SHELL': '/bin/bash', 09:35:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLB3dkTHG0/Listeners', 09:35:11 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 09:35:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:11 INFO - 'USER': 'cltbld', 09:35:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:11 INFO - 'XPC_FLAGS': '0x0', 09:35:11 INFO - 'XPC_SERVICE_NAME': '0', 09:35:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:35:12 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 09:35:12 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 09:35:12 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 09:35:12 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 09:35:12 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 09:35:12 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 09:35:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:35:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:35:14 INFO - Installing collected packages: mozsystemmonitor 09:35:14 INFO - Running setup.py install for mozsystemmonitor 09:35:14 INFO - Successfully installed mozsystemmonitor 09:35:14 INFO - Cleaning up... 09:35:14 INFO - Return code: 0 09:35:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:35:14 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')]} 09:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:14 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')]} 09:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:14 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 0x10c555490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff49ad65600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c369d30>, '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 0x10c18fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c361b20>, '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.Se26TZsVHi/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.pLB3dkTHG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 09:35:14 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 09:35:14 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 09:35:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Se26TZsVHi/Render', 09:35:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:14 INFO - 'HOME': '/Users/cltbld', 09:35:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:14 INFO - 'LOGNAME': 'cltbld', 09:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:14 INFO - 'MOZ_NO_REMOTE': '1', 09:35:14 INFO - 'NO_EM_RESTART': '1', 09:35:14 INFO - 'PAGER': '/bin/cat', 09:35:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:14 INFO - 'PWD': '/builds/slave/test', 09:35:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:14 INFO - 'SHELL': '/bin/bash', 09:35:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLB3dkTHG0/Listeners', 09:35:14 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 09:35:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:14 INFO - 'USER': 'cltbld', 09:35:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:14 INFO - 'XPC_FLAGS': '0x0', 09:35:14 INFO - 'XPC_SERVICE_NAME': '0', 09:35:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:15 INFO - Downloading/unpacking jsonschema==2.5.1 09:35:15 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 09:35:15 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 09:35:15 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 09:35:15 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 09:35:15 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 09:35:15 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 09:35:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:35:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:35:17 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 09:35:17 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 09:35:17 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 09:35:17 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 09:35:17 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 09:35:17 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 09:35:17 INFO - Downloading functools32-3.2.3-2.tar.gz 09:35:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:35:18 INFO - warning: no files found matching '*.txt' 09:35:18 INFO - no previously-included directories found matching 'build' 09:35:18 INFO - no previously-included directories found matching 'dist' 09:35:18 INFO - no previously-included directories found matching '.git*' 09:35:18 INFO - Installing collected packages: jsonschema, functools32 09:35:18 INFO - Running setup.py install for functools32 09:35:18 INFO - warning: no files found matching '*.txt' 09:35:18 INFO - no previously-included directories found matching 'build' 09:35:18 INFO - no previously-included directories found matching 'dist' 09:35:18 INFO - no previously-included directories found matching '.git*' 09:35:18 INFO - Successfully installed jsonschema functools32 09:35:18 INFO - Cleaning up... 09:35:18 INFO - Return code: 0 09:35:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:35: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')]} 09:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35: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')]} 09:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35: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', '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 0x10c555490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff49ad65600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c369d30>, '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 0x10c18fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c361b20>, '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.Se26TZsVHi/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.pLB3dkTHG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 09:35: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:35: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 functools32==3.2.3-2 09:35:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Se26TZsVHi/Render', 09:35:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:18 INFO - 'HOME': '/Users/cltbld', 09:35:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:18 INFO - 'LOGNAME': 'cltbld', 09:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:18 INFO - 'MOZ_NO_REMOTE': '1', 09:35:18 INFO - 'NO_EM_RESTART': '1', 09:35:18 INFO - 'PAGER': '/bin/cat', 09:35:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:18 INFO - 'PWD': '/builds/slave/test', 09:35:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:18 INFO - 'SHELL': '/bin/bash', 09:35:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLB3dkTHG0/Listeners', 09:35:18 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 09:35:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:18 INFO - 'USER': 'cltbld', 09:35:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:18 INFO - 'XPC_FLAGS': '0x0', 09:35:18 INFO - 'XPC_SERVICE_NAME': '0', 09:35:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:35:18 INFO - Cleaning up... 09:35:18 INFO - Return code: 0 09:35:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:35: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')]} 09:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35: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')]} 09:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35: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', '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 0x10c555490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff49ad65600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c369d30>, '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 0x10c18fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c361b20>, '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.Se26TZsVHi/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.pLB3dkTHG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 09:35: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:35: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 blobuploader==1.2.4 09:35:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Se26TZsVHi/Render', 09:35:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:18 INFO - 'HOME': '/Users/cltbld', 09:35:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:18 INFO - 'LOGNAME': 'cltbld', 09:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:18 INFO - 'MOZ_NO_REMOTE': '1', 09:35:18 INFO - 'NO_EM_RESTART': '1', 09:35:18 INFO - 'PAGER': '/bin/cat', 09:35:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:18 INFO - 'PWD': '/builds/slave/test', 09:35:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:18 INFO - 'SHELL': '/bin/bash', 09:35:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLB3dkTHG0/Listeners', 09:35:18 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 09:35:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:18 INFO - 'USER': 'cltbld', 09:35:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:18 INFO - 'XPC_FLAGS': '0x0', 09:35:18 INFO - 'XPC_SERVICE_NAME': '0', 09:35:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:18 INFO - Downloading/unpacking blobuploader==1.2.4 09:35:18 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 09:35:18 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 09:35:18 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 09:35:18 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 09:35:18 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 09:35:18 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 09:35:21 INFO - Downloading blobuploader-1.2.4.tar.gz 09:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:35:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:35:21 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 09:35:21 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 09:35:21 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 09:35:21 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 09:35:21 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 09:35:21 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 09:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:35:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:35:22 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 09:35:22 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 09:35:22 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 09:35:22 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 09:35:22 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 09:35:22 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 09:35:22 INFO - Downloading docopt-0.6.1.tar.gz 09:35:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:35:22 INFO - Installing collected packages: blobuploader, requests, docopt 09:35:22 INFO - Running setup.py install for blobuploader 09:35:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:35:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:35:22 INFO - Running setup.py install for requests 09:35:23 INFO - Running setup.py install for docopt 09:35:23 INFO - Successfully installed blobuploader requests docopt 09:35:23 INFO - Cleaning up... 09:35:23 INFO - Return code: 0 09:35:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:35:23 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')]} 09:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:23 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')]} 09:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:23 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 0x10c555490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff49ad65600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c369d30>, '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 0x10c18fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c361b20>, '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.Se26TZsVHi/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.pLB3dkTHG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 09:35:23 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 09:35:23 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 09:35:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Se26TZsVHi/Render', 09:35:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:23 INFO - 'HOME': '/Users/cltbld', 09:35:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:23 INFO - 'LOGNAME': 'cltbld', 09:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:23 INFO - 'MOZ_NO_REMOTE': '1', 09:35:23 INFO - 'NO_EM_RESTART': '1', 09:35:23 INFO - 'PAGER': '/bin/cat', 09:35:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:23 INFO - 'PWD': '/builds/slave/test', 09:35:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:23 INFO - 'SHELL': '/bin/bash', 09:35:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLB3dkTHG0/Listeners', 09:35:23 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 09:35:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:23 INFO - 'USER': 'cltbld', 09:35:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:23 INFO - 'XPC_FLAGS': '0x0', 09:35:23 INFO - 'XPC_SERVICE_NAME': '0', 09:35:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:35:23 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-Wnt_rD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:35:23 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-xGfHP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:35:24 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-fVuRX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:35:24 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-B_WRtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:35:24 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-iQzH3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:35:24 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-X5Ydd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:35:24 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-zVBb75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:35:24 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-QjnyMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:35:24 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-KaVTCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:35:24 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-GxuhQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:35:24 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-JOdCkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:35:24 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-hbpLqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:35:25 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-oss_vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:35:25 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-MBDqPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:25 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-ii0vdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:35:25 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-JUFaYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:35:25 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-Kb2GNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:35:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:35:25 INFO - Running setup.py install for manifestparser 09:35:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:35:25 INFO - Running setup.py install for mozcrash 09:35:25 INFO - Running setup.py install for mozdebug 09:35:26 INFO - Running setup.py install for mozdevice 09:35:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:35:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:35:26 INFO - Running setup.py install for mozfile 09:35:26 INFO - Running setup.py install for mozhttpd 09:35:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:35:26 INFO - Running setup.py install for mozinfo 09:35:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:35:26 INFO - Running setup.py install for mozInstall 09:35:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:35:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:35:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:35:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:35:26 INFO - Running setup.py install for mozleak 09:35:26 INFO - Running setup.py install for mozlog 09:35:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:35:27 INFO - Running setup.py install for moznetwork 09:35:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:35:27 INFO - Running setup.py install for mozprocess 09:35:27 INFO - Running setup.py install for mozprofile 09:35:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:35:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:35:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:35:27 INFO - Running setup.py install for mozrunner 09:35:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:35:27 INFO - Running setup.py install for mozscreenshot 09:35:27 INFO - Running setup.py install for moztest 09:35:28 INFO - Running setup.py install for mozversion 09:35:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:35:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:35:28 INFO - Cleaning up... 09:35:28 INFO - Return code: 0 09:35:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:35:28 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')]} 09:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:28 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')]} 09:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:28 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 0x10c555490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff49ad65600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c369d30>, '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 0x10c18fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c361b20>, '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.Se26TZsVHi/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.pLB3dkTHG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 09:35:28 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 09:35:28 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 09:35:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Se26TZsVHi/Render', 09:35:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:28 INFO - 'HOME': '/Users/cltbld', 09:35:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:28 INFO - 'LOGNAME': 'cltbld', 09:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:28 INFO - 'MOZ_NO_REMOTE': '1', 09:35:28 INFO - 'NO_EM_RESTART': '1', 09:35:28 INFO - 'PAGER': '/bin/cat', 09:35:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:28 INFO - 'PWD': '/builds/slave/test', 09:35:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:28 INFO - 'SHELL': '/bin/bash', 09:35:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLB3dkTHG0/Listeners', 09:35:28 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 09:35:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:28 INFO - 'USER': 'cltbld', 09:35:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:28 INFO - 'XPC_FLAGS': '0x0', 09:35:28 INFO - 'XPC_SERVICE_NAME': '0', 09:35:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:35:28 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-Kxbx_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:35:28 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)) 09:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:35:28 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-ZjoZQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 09:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:35:28 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-Js3X5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:35:28 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)) 09:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:35:28 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-9iahoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 09:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:35:28 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-3T1o5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:35:29 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)) 09:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:35:29 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-C948EC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:35:29 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)) 09:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:35:29 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-Cc_3eK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:35:29 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)) 09:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:35:29 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-0oPCH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:35:29 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)) 09:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:35:29 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-4Mhjvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:35:29 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)) 09:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:35:29 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-C6Or9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:35:29 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)) 09:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:35:29 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-A6PU3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:35:29 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)) 09:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:35:29 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-t9jOnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 09:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:35:29 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-193iNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:35:29 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)) 09:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:35:29 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-ns08io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 09:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-2O1WDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:30 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)) 09:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:35:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-Z0ApCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 09:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:35:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-5RHs9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:35:30 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)) 09:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:35:30 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)) 09:35:30 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:35:30 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:35:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:35:30 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 09:35:30 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 09:35:30 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 09:35:30 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 09:35:30 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 09:35:30 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 09:35:32 INFO - Downloading blessings-1.6.tar.gz 09:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:35:32 INFO - Installing collected packages: blessings 09:35:32 INFO - Running setup.py install for blessings 09:35:33 INFO - Successfully installed blessings 09:35:33 INFO - Cleaning up... 09:35:33 INFO - Return code: 0 09:35:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:35:33 INFO - Reading from file tmpfile_stdout 09:35:33 INFO - Current package versions: 09:35:33 INFO - blessings == 1.6 09:35:33 INFO - blobuploader == 1.2.4 09:35:33 INFO - docopt == 0.6.1 09:35:33 INFO - functools32 == 3.2.3-2 09:35:33 INFO - jsonschema == 2.5.1 09:35:33 INFO - manifestparser == 1.1 09:35:33 INFO - mozInstall == 1.12 09:35:33 INFO - mozcrash == 0.17 09:35:33 INFO - mozdebug == 0.1 09:35:33 INFO - mozdevice == 0.48 09:35:33 INFO - mozfile == 1.2 09:35:33 INFO - mozhttpd == 0.7 09:35:33 INFO - mozinfo == 0.9 09:35:33 INFO - mozleak == 0.1 09:35:33 INFO - mozlog == 3.4 09:35:33 INFO - moznetwork == 0.27 09:35:33 INFO - mozprocess == 0.23 09:35:33 INFO - mozprofile == 0.28 09:35:33 INFO - mozrunner == 6.12 09:35:33 INFO - mozscreenshot == 0.1 09:35:33 INFO - mozsystemmonitor == 0.3 09:35:33 INFO - moztest == 0.7 09:35:33 INFO - mozversion == 1.4 09:35:33 INFO - psutil == 3.1.1 09:35:33 INFO - requests == 1.2.3 09:35:33 INFO - wsgiref == 0.1.2 09:35:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:33 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 0x10c555490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff49ad65600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c369d30>, '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 0x10c18fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c361b20>, '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.Se26TZsVHi/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.pLB3dkTHG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 09:35:33 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 09:35:33 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 09:35:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Se26TZsVHi/Render', 09:35:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:33 INFO - 'HOME': '/Users/cltbld', 09:35:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:33 INFO - 'LOGNAME': 'cltbld', 09:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:33 INFO - 'MOZ_NO_REMOTE': '1', 09:35:33 INFO - 'NO_EM_RESTART': '1', 09:35:33 INFO - 'PAGER': '/bin/cat', 09:35:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:33 INFO - 'PWD': '/builds/slave/test', 09:35:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:33 INFO - 'SHELL': '/bin/bash', 09:35:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLB3dkTHG0/Listeners', 09:35:33 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 09:35:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:33 INFO - 'USER': 'cltbld', 09:35:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:33 INFO - 'XPC_FLAGS': '0x0', 09:35:33 INFO - 'XPC_SERVICE_NAME': '0', 09:35:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:33 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)) 09:35:33 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)) 09:35:33 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)) 09:35:33 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)) 09:35:33 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)) 09:35:33 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)) 09:35:33 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)) 09:35:33 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)) 09:35:33 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)) 09:35:33 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)) 09:35:33 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)) 09:35:33 INFO - Cleaning up... 09:35:33 INFO - Return code: 0 09:35:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c555490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4cb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff49ad65600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c369d30>, '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 0x10c18fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c361b20>, '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.Se26TZsVHi/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.pLB3dkTHG0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 09:35:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:35:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Se26TZsVHi/Render', 09:35:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:33 INFO - 'HOME': '/Users/cltbld', 09:35:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:33 INFO - 'LOGNAME': 'cltbld', 09:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:33 INFO - 'MOZ_NO_REMOTE': '1', 09:35:33 INFO - 'NO_EM_RESTART': '1', 09:35:33 INFO - 'PAGER': '/bin/cat', 09:35:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:33 INFO - 'PWD': '/builds/slave/test', 09:35:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:33 INFO - 'SHELL': '/bin/bash', 09:35:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLB3dkTHG0/Listeners', 09:35:33 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 09:35:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:33 INFO - 'USER': 'cltbld', 09:35:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:33 INFO - 'XPC_FLAGS': '0x0', 09:35:33 INFO - 'XPC_SERVICE_NAME': '0', 09:35:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:35:34 INFO - Cleaning up... 09:35:34 INFO - Return code: 0 09:35:34 INFO - Running post-action listener: _resource_record_post_action 09:35:34 INFO - Running post-action listener: _start_resource_monitoring 09:35:34 INFO - Starting resource monitoring. 09:35:34 INFO - [mozharness: 2016-11-03 16:35:34.095572Z] Finished create-virtualenv step (success) 09:35:34 INFO - [mozharness: 2016-11-03 16:35:34.096652Z] Running install step. 09:35:34 INFO - Running pre-action listener: _resource_record_pre_action 09:35:34 INFO - Running main action method: install 09:35:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:35:34 INFO - Reading from file tmpfile_stdout 09:35:34 INFO - Detecting whether we're running mozinstall >=1.0... 09:35:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:35:34 INFO - Reading from file tmpfile_stdout 09:35:34 INFO - Output received: 09:35:34 INFO - Usage: mozinstall [options] installer 09:35:34 INFO - Options: 09:35:34 INFO - -h, --help show this help message and exit 09:35:34 INFO - -d DEST, --destination=DEST 09:35:34 INFO - Directory to install application into. [default: 09:35:34 INFO - "/builds/slave/test"] 09:35:34 INFO - --app=APP Application being installed. [default: firefox] 09:35:34 INFO - mkdir: /builds/slave/test/build/application 09:35:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:36:08 INFO - Reading from file tmpfile_stdout 09:36:08 INFO - Output received: 09:36:08 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 09:36:08 INFO - Running post-action listener: _resource_record_post_action 09:36:08 INFO - [mozharness: 2016-11-03 16:36:08.551665Z] Finished install step (success) 09:36:08 INFO - [mozharness: 2016-11-03 16:36:08.551861Z] Running run-tests step. 09:36:08 INFO - Running pre-action listener: _resource_record_pre_action 09:36:08 INFO - Running main action method: run_tests 09:36:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:36:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:36:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:36:08 INFO - 2016-11-03 09:36:08.564 screenresolution[1983:13589] starting screenresolution argv=screenresolution get 09:36:08 INFO - 2016-11-03 09:36:08.566 screenresolution[1983:13589] Display 0: 1600x1200x32@60 09:36:08 INFO - 2016-11-03 09:36:08.571 screenresolution[1984:13591] starting screenresolution argv=screenresolution list 09:36:08 INFO - Available Modes on Display 0 09:36:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:36:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:36:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:36:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:36:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:36:08 INFO - Intel Iris: 09:36:08 INFO - Chipset Model: Intel Iris 09:36:08 INFO - Type: GPU 09:36:08 INFO - Bus: Built-In 09:36:08 INFO - VRAM (Dynamic, Max): 1536 MB 09:36:08 INFO - Vendor: Intel (0x8086) 09:36:08 INFO - Device ID: 0x0a2e 09:36:08 INFO - Revision ID: 0x0009 09:36:08 INFO - Displays: 09:36:08 INFO - Display: 09:36:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:36:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:36:08 INFO - Display Serial Number: 1600x1200 60 09:36:08 INFO - Main Display: Yes 09:36:08 INFO - Mirror: Off 09:36:08 INFO - Online: Yes 09:36:08 INFO - Rotation: Supported 09:36:08 INFO - Return code: 0 09:36:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:36:08 INFO - Python 2.7.3 09:36:08 INFO - Return code: 0 09:36:08 INFO - grabbing minidump binary from tooltool 09:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:08 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 0x10c369d30>, '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 0x10c18fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c361b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:36:08 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 09:36:08 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 09:36:08 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 09:36:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:36:08 INFO - Return code: 0 09:36:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:36:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:36:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:36:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:36:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:36:08 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/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0122', '--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 09:36:08 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/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0122 --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 09:36:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Se26TZsVHi/Render', 09:36:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:08 INFO - 'HOME': '/Users/cltbld', 09:36:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:08 INFO - 'LOGNAME': 'cltbld', 09:36:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:36:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:08 INFO - 'MOZ_NO_REMOTE': '1', 09:36:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:36:08 INFO - 'NO_EM_RESTART': '1', 09:36:08 INFO - 'PAGER': '/bin/cat', 09:36:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:08 INFO - 'PWD': '/builds/slave/test', 09:36:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:36:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:08 INFO - 'SHELL': '/bin/bash', 09:36:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pLB3dkTHG0/Listeners', 09:36:08 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 09:36:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:08 INFO - 'USER': 'cltbld', 09:36:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:08 INFO - 'XPC_FLAGS': '0x0', 09:36:08 INFO - 'XPC_SERVICE_NAME': '0', 09:36:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:08 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/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0122', '--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 09:36:09 INFO - mozversion application_buildid: 20161103030205 09:36:09 INFO - mozversion application_changeset: ade8d4a63e57560410de106450f37b50ed71cca5 09:36:09 INFO - mozversion application_display_name: Nightly 09:36:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:36:09 INFO - mozversion application_name: Firefox 09:36:09 INFO - mozversion application_remotingname: firefox 09:36:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:36:09 INFO - mozversion application_vendor: Mozilla 09:36:09 INFO - mozversion application_version: 52.0a1 09:36:09 INFO - mozversion platform_buildid: 20161103030205 09:36:09 INFO - mozversion platform_changeset: ade8d4a63e57560410de106450f37b50ed71cca5 09:36:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:36:09 INFO - mozversion platform_version: 52.0a1 09:36:09 INFO - using testdate: 1478190969 09:36:09 INFO - actual date: 1478190969 09:36:09 INFO - starting webserver on 'localhost:49664' 09:36:09 INFO - SUITE-START | Running 2 tests 09:36:09 INFO - TEST-START | dromaeo_css 09:36:09 INFO - operating with platform_type : mac_ 09:36:09 INFO - Initialising browser for dromaeo_css test... 09:36:09 INFO - TEST-INFO | started process 1994 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpsxMcQd/profile http://localhost:49664/getInfo.html) 09:36:12 INFO - PROCESS | 1994 | 2016-11-03 09:36:12.107 plugin-container[1997:13762] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9153, name = 'com.apple.tsm.portname' 09:36:12 INFO - PROCESS | 1994 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:36:12 INFO - PROCESS | 1994 | 2016-11-03 09:36:12.108 plugin-container[1997:13762] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 09:36:12 INFO - PROCESS | 1994 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:36:12 INFO - PROCESS | 1994 | 2016-11-03 09:36:12.108 plugin-container[1997:13762] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:36:12 INFO - PROCESS | 1994 | __metrics Screen width/height:1600/1200 09:36:12 INFO - PROCESS | 1994 | colorDepth:24 09:36:12 INFO - PROCESS | 1994 | Browser inner width/height: 1024/689 09:36:12 INFO - PROCESS | 1994 | __metrics 09:36:12 ERROR - PROCESS | 1994 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 09:36:12 INFO - TEST-INFO | 1994: exit 0 09:36:12 INFO - Browser initialized. 09:36:12 INFO - Running cycle 1/1 for dromaeo_css test... 09:36:12 INFO - TEST-INFO | started process 1998 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpsxMcQd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:15 INFO - PROCESS | 1998 | 2016-11-03 09:36:15.635 plugin-container[1999:13879] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 09:36:15 INFO - PROCESS | 1998 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:36:15 INFO - PROCESS | 1998 | 2016-11-03 09:36:15.635 plugin-container[1999:13879] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 09:36:15 INFO - PROCESS | 1998 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:36:15 INFO - PROCESS | 1998 | 2016-11-03 09:36:15.635 plugin-container[1999:13879] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:36:25 INFO - PROCESS | 1998 | RSS: Main: 239177728 09:36:25 INFO - PROCESS | 1998 | 09:37:14 INFO - PROCESS | 1998 | 1478191034953 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:39:28 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:49664/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49664/tests/dromaeo/cssquery-ext.html) 09:39:30 INFO - PROCESS | 1998 | RSS: Main: 252129280 09:39:30 INFO - PROCESS | 1998 | 09:42:32 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:49664/tests/dromaeo/cssquery-ext.html (next: http://localhost:49664/tests/dromaeo/cssquery-jquery.html) 09:42:33 INFO - PROCESS | 1998 | RSS: Main: 263204864 09:42:33 INFO - PROCESS | 1998 | 09:45:34 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:49664/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49664/tests/dromaeo/cssquery-mootools.html) 09:45:35 INFO - PROCESS | 1998 | RSS: Main: 267624448 09:45:35 INFO - PROCESS | 1998 | 09:48:37 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:49664/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49664/tests/dromaeo/cssquery-prototype.html) 09:48:38 INFO - PROCESS | 1998 | RSS: Main: 266113024 09:48:38 INFO - PROCESS | 1998 | 09:51:40 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:49664/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49664/tests/dromaeo/cssquery-yui.html) 09:51:41 INFO - PROCESS | 1998 | RSS: Main: 271355904 09:51:41 INFO - PROCESS | 1998 | 09:54:44 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:49664/tests/dromaeo/cssquery-yui.html (next: http://localhost:49664/tests/dromaeo/cssquery-dojo.html) 09:54:44 INFO - PROCESS | 1998 | RSS: Main: 273821696 09:54:44 INFO - PROCESS | 1998 | 09:54:44 INFO - PROCESS | 1998 | __start_tp_report 09:54:44 INFO - PROCESS | 1998 | _x_x_mozilla_page_load 09:54:44 INFO - PROCESS | 1998 | _x_x_mozilla_page_load_details 09:54:44 INFO - PROCESS | 1998 | |i|pagename|runs| 09:54:44 INFO - PROCESS | 1998 | |0;dojo.html;3314.950275745864;3317.10438181691;3320.4189266878293;3325.8503367348467;3382.0361197058814;5451.945480545193;5526.723663816808;5534.169874518824;5575.2473416088815;5596.188552659862;5460.590455715827;5527.170924361348;5552.750126244318;5562.610617256793;5638.971805140979;5099.821506247282;5101.9744901275535;5121.206213036985;5186.403563590179;5190.558802501791;5024.346834911456;5199.714015729152;5202.4277329493725;5228.0850851101095;5263.736813159327;5001.499850015006;5065.341505604285;5168.302279192299;5175.870603234912;5185.481451854822;5000.549950504472;5035.77339019745;5066.36670416198;5066.468020857794;5139.203423469368;4387.407699960497;5025.0954828130925;5071.695698258116;5095.8980820383385;5146.922796158024;4578.771061446948;4987.202047672391;5585.497305242548;5603.439656034405;5621.100623900156;5954.880902381971;5989.2812862456785;6084.056971169432;6087.969560152171;6091.482224010964;6084.117802918597;6099.908501372439;6102.908456373158;6110.908336374958;6166.660833654148;5543.833684989457;5573.498385145356;5639.759252964301;5656.4060773619;5659.51894089003;6170.167027451326;6213.2233470816145;6233.501319894398;6304.3695630437505;6311;5923.881522369528;5964.701764911737;5972.718318127054;5981.431763982415;6013.819585412444;5972.790952316648;6122.938770612326;6132.6627035513475;6138.478229350466;6159;5911.3201981772645;5935.73289201987;5989.071693887455;6009.128676341906;6085.96957015221;5997.160397544348;6003.099535069775;6048.274207095089;6062.42406971337;6074.119252708332;4818.469968303484;4845.297431872359;4880;4881.414230292387;4909.042736666387;4266.914661706748;4268.210381079511;4276.636485898671;4301.483821941387;4328.61042506176;5337.759800808895;5687.573431992617;5694.402087780806;5700.144978253295;5747.6838773867;6181.196444462281;6185.072239164161;6189.164462797555;6221.96889015552;6231.189945307081;4135.875923722293;4575.787416334674;4641.721496710208;5035.093683136997;5148;4455.732656040648;4464.2633965396;5210.244514545369;5267.710275934784;5283;6178.752849886134;6197.938020619736;6225.439710426083;6300.495960323255;6312.116303717483;6104.603200792112;6105.053716673922;6119.479844213113;6122.785702500391;6125.448709616156;6282.403171698681;6287.905681414874;6294.433500984934;6299;6306;5896.469317761422;5926.940730592639;5960.374160713236;5961.552883533839;5970.3432622412365;5485.067538518381;6065.150878876872;6067.605605635619;6094.725737341919;6108.72510737009;5576.414476479911;5997.70011499432;5998.970005149947;6013.428724271187;6019.668918209541;4862.586680132228;5727.8568035799435;5946.43508866657;5965.135055417027;5980.940190598212;4807.831725889577;5694.629849059798;5760.6255593386295;5775.768969241183;5866.5893387462465;5895.292564892069;5912.113183022581;5913.379095194942;5928.377520360473;5944.494717949023;5709.771609135588;5742.310922689304;5853.35613082552;5856.502197313106;5871.324797648154 09:54:44 INFO - PROCESS | 1998 | |1;ext.html;483.6203580189551;490.84783717047696;519.651833271708;524.763856264681;532.9493698098679;39133.41299880504;40313.79843100784;40407.39388909169;42691.359629605584;42785.71642850712;36903.708370207045;39071.99999999993;41572;42253.36619950703;42261.57738422615;9449.527523623809;9619.470929098898;9657.710268691915;9666.613335466573;9701.27240456965;9399.718008459757;9484.762880927963;9487.857682134774;9499.81000379992;9509.239260859114;9522.761930951712;9527;9532.475713835736;9534.28492863038;9608.423494590312;9491.95254023729;9542.475163865985;9548.47483388417;9568.712938611852;9577.425354478753;8078.636461359253;9446.197073248783;9527.190188833958;9544.856827147598;9546.140847323773;39372;39402.408963865564;39446.211075778614;39500.247476489974;39642.40536391956;3361.907380101477;3528.1708798432346;3540.982295088508;3705.184859330943;3989.5412027616617;29961.619413148444;30205.546916796266;30345.696543034508;30592.082237532908;31323.53014704781;3178.1300216239824;3191.1543440988157;3202.3595280943673;3242.91892702682;3314.9005529834144;495143;505947;509224;510452;511767.9999999963;57888.710556446946;58162.709186454646;58179.127313090336;58324.416755832746;58332;59301.11048334278;59555.70222148948;60315.69842150761;60925.39074609197;61051;12688.87311126877;12702.301373424365;14321;15183.468578599695;15402;9837.508124593742;11897.286162830258;11978.760424791455;12005.159638825373;12005.939970300267;13250.73498530024;15789;16059.678806423806;16325.285844986343;16361.672766544603;5913.793017244376;7046.365827075588;7059.799834028227;7110.857782844314;7145.785626431215;707.310372386929;954.6849539651898;970.5147426286857;1054.7428503003425;1107.851750375973;28873.42253154925;29627.703722962924;29630.40739185204;30041.94853180128;30155;849.9787505312416;988.6984469736656;1017.9032991865761;1037.159900480613;1041.250299784154;14368.784468232985;15325.693486130438;15374.53876383688;15391.692166156614;15561.533154005398;653622;677336;679639;680312;681102;56736;56798.71600642053;57421.42578574161;57572.42427575754;57622.42377576171;1375.5185685010367;1382.5575815739069;1398.776195808686;1401.7827236778317;1408.4507042253529;28815.135545933656;29676.10971670853;29916.401671966873;30303.242418939702;30545.389092218476;51012.23481647852;51658.74170629123;51719.2242116361;51730.74134629303;51861;630965;638843;639257;639402;642590.7870460618;41286.34854605782;41483.37774933439;42044.159116818104;42281.78859105685;42287.15425691407;46035.07929841318;46738.065238694355;47402.28896566623;47491.812704682656;47725.76137119292;38586.42120368253;38687.03282417962;38954.02614934536;39834.40248396334;40132.79933600313;37824.43263351107;38134;38713.61286387213;39541;39622;31806.36387272195;32508.512372313962;36014;37875.81062094672;38128.85613431602;33569.83215083909;33717.49423758597;34196.974090777316;34265.31469370649;34407.827960860035;25268.873655631603;25544.744552554235;25647.87176064108;26048.86975565186;26183.73816261813 09:54:44 INFO - PROCESS | 1998 | |2;jquery.html;331.68821307970506;349.23517496682274;366.51802879213847;377.95653499847526;397.78917173897827;18933.148008339624;18994.240230390784;19598.706019409703;19769.901150494265;19859.50351241216;19289;19326.903365483155;19861.602767944667;20140.89225092623;20161.09275082621;4775.570198682118;5049.747512624354;5586.469285417878;5875.735591898353;5887.4406931341455;4676.532346765313;5780.913286300709;5793.5365170786445;5796.391378905218;5806.912896306559;5741.253637027181;5749.712514374285;5756.942430575683;5768.451997060272;5779.566532510057;5616.5787565932515;6106.816795496142;6107.083937409379;6119.541034422392;6125.632462052291;4957.603391728653;5832.941670583282;5869.559783016291;5900.350961394286;5930.466258036798;12195.268283902995;12359.443825027894;12403.813942790865;12606.936965315206;12609;2300.9884950575306;2304.83866129371;2308.3998160478227;2327.476317828492;2487.1916627096266;9743.561539730728;10151.593936242542;10307.175425965905;12032.157748957576;14264.714705705932;1724.4223185232836;1801.4505575799376;1844.9631007379912;1851.4353122297694;1917.5589614388768;109192;117445;119280;119600.40199798945;119683.4015829924;11485.425728713531;11537.653870383901;11660.30038197711;11665.59170429031;11773.823392649118;14145.575632731034;14269.571912842632;14275.500357487437;14285.428582856777;14312.499062532761;8198.549079800548;8348.66605335792;8371.079181290053;8382.036065852382;8503.107173746792;7257.475930054642;7743.380529557622;8162.67349306033;8346.081930987586;8361.247487726012;3709.4435834625024;4357.564243575681;4427.313766366218;4448.822047118079;4507.661925355612;1908.7136929460692;1914.636219118363;1922.9903850480937;1929.7394851695121;1941.9708704369446;789.7551758954743;865.5209291914443;876.5441970175473;965.8406362950175;1012.2003617142523;19386.93371864561;20177.495562611053;20475;20778.376648700563;21725.56548869014;886.3972498700946;898.6899519665704;903.9050899655573;916.5188276154938;1020.9795804083876;10445.373277603216;11002.614908478165;11010.009099180952;11013.779724405467;11021.44892755359;571790;574553;578327;592117;593386;121425.39287303684;135810.32094839463;137767;138991;140887;990.5542505872386;997.9301448898508;1011.5397494140149;1011.898810118997;1025.9487025648837;16546.84172107941;17210.569735756708;18514.534955763284;18529;18556.350527731465;36349.45475817812;40989.59010409858;49254.75372623114;57481.114105301516;57897.84204315806;68388.31611683819;71348.64325678338;77767;85395.14604853872;86348.13651863401;6671.39957403836;7528.397728181622;7798.454108212371;8249.175082491704;8286.46138001028;12018.158728888893;12127.636170914886;12200.206986545845;12482.313472759086;12524.561640342545;9916.553755081182;10148.54331555067;10437.16502679799;10499.635047443784;11181.385023823443;8664.78338041554;10436;10768.676939691823;10770.353778773298;11147.331160130418;10811.6215932442;10879.78240435171;11283.210175287652;11424.971752542311;11533.673627532606;8014.519128852287;8059.717909873127;8143.267105960255;8206.974128233971;8283.420160588941;7594.8860767089645;10981.286216395909;10988.450577471254;11023.338599684044;11078.058365039062 09:54:44 INFO - PROCESS | 1998 | |3;mootools.html;1427.357689039932;1467.515719812462;1514.174774747763;1525.687234117006;1636.263681343395;7526.887096693554;7737.458377913535;7933.246341597546;8416.705415310465;8421.031581368137;6508.446782023534;8233.464824786384;8266.50400975942;8356.707515236967;8372.91627083729;2262.151693115082;2302.5394921015863;2306.5732839424677;2316.1198744477074;2316.316686577455;1727.7322015087682;2291.564602725477;2348.518553696497;2352.3178278299356;2357.787799098081;2291.2897001929373;2296.9655455168186;2304.3893368257427;2321.210788331967;2322.2452702871633;1871;2271.3640180749335;2290.954180916389;2296.150424342987;2305.8616483010987;2303.5047464794984;2311.3874823171873;2315.6526521021815;2321.6633588129794;2330.2310237621546;6830.897536536956;8081.151479094669;8147.02235731716;8183.754487365389;8185.79535511611;4165.333546632524;5170.353705786777;5173.120569503156;5180.559652429548;5188.429272779991;3226.451503244454;3301.422251106047;3541.3802584547857;3545.663161999606;3546.66306700863;901.4861528928514;1019.50553981319;1041.7968496143255;1087.2660953856196;1091.939943303118;10440.060394564525;10609.204309676728;10738.624148154855;10742.785144297148;10897.073748731287;4259.61663450291;4324.9135017300105;4384.868453946387;4419.977900110479;4434.046679963823;8481.006963363605;8547.95726021366;8562.78593035179;8569;8573.09982451846;4393.879560711998;4815.3258543803895;5011.223260394645;5038.949610503848;5053.797848086109;4259;4438.5561443856;4699.318598803155;4710.458297295855;4750;3549.165946002687;3572.7856328620364;3640.581333146669;3657.5918271465675;3667.6515731006048;1026.0662796854976;1102.2174256277972;1137.4483375562845;1149.7585507043614;1157.2940506291156;856.3406177243488;858.3948316436897;877.6138499060393;915.8671992561042;915.8671992561175;5544.3346798384455;5586.804461843816;5658.490735833795;5749.9425005750245;5853.385394533512;911.5487833522317;916.9816603667889;919.1589695428607;926.323783637948;972.7081875437341;3704.0369503929173;3721.292954338667;3758.981205094012;3819.2934307153264;3850.5186851643543;9302.069793020644;9718.854217186748;9727.951360243154;9741.415515069119;9751.219902407933;9676.854847177297;9688.12806847373;9710.417374957384;9712.077352651488;9727.464989425507;7732.6133693315105;7871.606419678993;7899.289063984154;7906.090799558009;7922.326602238759;4944.961558072845;5495.587830912617;5506.394296627448;5630.662160270397;5648.971755141362;7810.453268271166;9334.346595738232;9420.576074076545;9448.48033358172;9486.193673537551;8113.716019939274;9293.72118836436;9405.858912116188;9447.433154010781;9476.478793666414;6551.770688025897;6783.219929708147;6920.9653951729915;7011.474139439664;7191.352778249982;7537.283958023979;7860.135385107519;7882.408819338687;7902.24928631779;7909.604519773873;7070.222275549582;7196.460265480006;7225.674844632109;7262.6731797070315;7330.926690733238;6184.134221208944;6940.618265995418;7035.753748618774;7042.436605071684;7148.606826624586;5675.205471234113;6510.511711621552;6612.041254018237;6699.39705426514;6770.086038384755;4815.759212039454;4838.129136755418;4849.199882019428;4887.853364399074;4932.778024988812;4796.06476737033;4842.661013729146;4844.781984810763;4952.5542701157065;4983.551480366785 09:54:44 INFO - PROCESS | 1998 | |4;prototype.html;287.20587575354136;297.1131173447261;299.13848117421827;306.8404429696557;311.6400557356253;4178.937315940263;4325.891852703684;4535;4732.266498692704;5330.92003619946;4550.931736023954;4976.825811096613;5099.929014906865;5199.974000130003;5208.713520756357;3522.5420695309704;3694.9815250923707;4199.2441360555085;4199.874003779892;4219.493660760705;4125.133721918401;4210.768407737573;4250.681198910094;4252.574742525738;4253.8085786139545;3476.4090104682136;4166.020985068507;4184.95376155961;4187.916241675165;4189.601987811153;4176.979115104436;4178.811953462102;4186.162767446523;4211.620954114144;4221.91556168878;3645.2527231917393;3645.5260816094005;3674.4120940649636;3680.392735198689;3684.7471859567877;4427.6015158635555;5056.140456122468;5340.54605358545;5374.5700343972385;5442.2380866678695;3557.8576856925692;4124.546299907008;4376.715513491613;4596.816127354902;4665.183592871234;5076.64463487556;5370.570354371641;5709.343425506078;5839.598496360843;5859.912101318484;3031.5301128325145;3602.5496812898386;3855.1904100139004;3863.632954869283;3913.5695073541888;5059.721715305656;5239.869003274911;5882.264716910387;5977.282726072855;6024.578279520435;3227.0318904328606;3330.8501117449773;3897.9610203898164;3967.6627486663956;3977.0455090778005;3721.8648312264477;3964.960350396459;3990.341593637075;4009.699272554512;4025.355943049098;3976;4693.225617773098;4699;4705.529447055335;4728.38530990969;5881;5897.144913987448;5906.40935906406;5907.940920590825;5930.822075337746;1280.6798300424894;1293.2563775828935;1338.9799153012711;1351.6886124726827;1359.9596308823757;802.6147449224405;847.7244895409017;882.7175303902818;890.9688160914337;908.8682141089637;5441.7279136043835;5502.2296878437055;5512.751926163332;5514.5864060194845;5536.169574563767;4717.815474554731;5437.921558830877;5608.663480191201;5953.791617293374;5960.344362120163;4818.747345541746;5190.506901844319;5197.22041693749;5389.434109418533;5514.283143191359;2391.72495163055;2490.5267999080115;2623.317937336268;2623.790096792252;2650.5494066008823;4518.740629685158;4932.334134891816;4986.002799440126;5043.2687260347775;5137.40919794221;4406.537313582092;4934.2483418385955;5003.647556137396;5658.292713410824;6283.235376434354;5829.766809327664;5854.707264636836;5948.078047902582;6384.52116091295;6444.645544495004;5191.974040129775;5358.223057656696;5799.420057994167;6178.921911538543;6181.258249010148;4668.85993420198;4886.921239619017;4909.685961975723;5282.204050622807;5684.545236380997;5137.126688463045;5333.626536191357;5695.829125126253;5856.326522449973;6504.219493660791;3954.070793363615;4091.754494730326;4118.814653340667;4123.340265557496;4125.566815484331;5524.226608274765;6003;6045.848853778691;6067.302260240129;6074.145151778657;5620.915686264628;5823.7379317931645;5835.270591176103;5839.15332276809;5948.851278718067;4910.803567857246;5371.973140134274;5868.794592189253;5934.6142500737315;5934.732937017759;4986.925196121989;5178.404483484297;5429.429909859408;5736.42635736423;5795.913061304;4976.054549635558;5638.4925356718095;5914.911276330945;5916.822495325147;5975.25309336333;4621.6302695784925;5747;5755.417260253464;5761.423857614205;5797.246357973437 09:54:44 INFO - PROCESS | 1998 | |5;yui.html;678.0507289794291;678.2335960364787;733.9889901651476;737.8044818123199;822.6668199379252;14529.491467798629;14776.778348324784;15168.938174327788;15271.160086195256;15563.766543501857;13851.376688049037;14154.575362739108;14169.78745318821;14215.431382744679;14223.502177423792;662.2185820731535;693.5873155472486;832.625318606628;852.7271273192581;854.7179430787857;821.5029906906325;854.5171977832505;863.7840539865034;865.523961820996;866.4498043742205;857.9270761985239;903.7695387676166;906.7007887397143;907.1246247371286;913.808100298938;903.9875339619635;906.3519583497831;906.7461110888962;909.0863681999548;910.6994691751706;634.1819053421082;667.4626925325111;673.0678010954814;676.5534747066912;676.89169732843;14083.929580352033;14172.787408188886;14353.210573418457;14370.568882933529;14812.925935370255;13623.479566769853;13837.169769813843;13956;14054.648633784134;14190.361433735403;9444.622215111456;11364.829527557093;11462.369569673665;11557.364344961024;11692.766144677144;3682.263547290526;3726.5155529780955;3761.4357846322996;3857.633524815138;3869.941950870739;87131.56434217852;88653;89880;89963;90834.54582727044;10601.681949541371;10634.73413164677;10757.569697212024;10802.189835762349;11050.392228427352;17995.820041799678;20703.58592828135;20761;21013.579728405348;21285.78714212869;7708.229177082247;7743.92256077432;7833.64748586315;7877.448578599558;7955;4294.9785251073545;4307.633851122627;4329.134173165379;4342.413774140514;4347.456567929009;3374.8481318340732;3479.686828185425;3503.737219708481;3514.5606799150105;3532;522.9503197196336;618.7494064903722;630.8738252349549;639.1690801957436;643.3598569423453;504.772852216504;508.4000878962859;608.2518502242267;610.8028264601431;645.9031145328145;8891.19979201875;8973.19241268276;8997.32520060985;9140.725778226664;9372.484513351832;510.652756125838;519.6379425119471;582.8455459303289;608.2609629300421;614.0420943328332;4088.4684990950987;4126.587341265909;4241.809118589671;4430.911381772346;4552.271636538204;64332.035019474744;75175.62412187904;95211.04788952161;98667;102151.4892425548;59703;61425.38574614286;72368.63815680993;88346;90391;76282.61858690671;77484.22515774884;77873.22126778659;78376.82434763483;78828;7582.355499782359;8233.752987410388;9350.719478415658;9372.250219982521;9443.291753118407;51049.23426148536;52557.47442525679;53017;54600.72699636476;54781.72609136929;65307.06118224786;65594.68810623857;75019.24980750341;76870.23129768854;77249.22750772421;11872.168948173545;11969;12014.879851201376;12401.503939842667;12827.973762099196;11640.243384180001;13849.653758656113;13906.58280251594;14116.364763585869;14562.344694488562;12840.678983025498;13058.477660893837;13087.345632718136;13105.803412949004;13598.592042238748;12640.6839829005;12707.551022440895;12901.741965160832;13024.231826130403;13499.05506614567;12541.372931353213;13042.934785326013;13252.138610990254;13387.598372048855;13424.060315777802;7602.429817763579;9503.619855205714;9552.713418597454;10014.699559013241;10135.189184865341;8503.702370417006;9358.391704539183;10038.347507411994;10043.949780251345;10086.243531735296 09:54:44 INFO - PROCESS | 1998 | __end_tp_report 09:54:44 INFO - PROCESS | 1998 | __start_cc_report 09:54:44 INFO - PROCESS | 1998 | _x_x_mozilla_cycle_collect,379 09:54:44 INFO - PROCESS | 1998 | __end_cc_report 09:54:44 INFO - PROCESS | 1998 | __startTimestamp1478192084563__endTimestamp 09:54:44 INFO - PROCESS | 1998 | 09:54:44 INFO - PROCESS | 1998 | ------- Summary: start ------- 09:54:44 INFO - PROCESS | 1998 | Number of tests: 6 09:54:44 INFO - PROCESS | 1998 | 09:54:44 INFO - PROCESS | 1998 | [#0] dojo.html Cycles:165 Average:5556.84 Median:5747.68 stddev:669.48 (11.6%) stddev-sans-first:648.02 09:54:44 INFO - PROCESS | 1998 | Values: 3315.0 3317.1 3320.4 3325.9 3382.0 5451.9 5526.7 5534.2 5575.2 5596.2 5460.6 5527.2 5552.8 5562.6 5639.0 5099.8 5102.0 5121.2 5186.4 5190.6 5024.3 5199.7 5202.4 5228.1 5263.7 5001.5 5065.3 5168.3 5175.9 5185.5 5000.5 5035.8 5066.4 5066.5 5139.2 4387.4 5025.1 5071.7 5095.9 5146.9 4578.8 4987.2 5585.5 5603.4 5621.1 5954.9 5989.3 6084.1 6088.0 6091.5 6084.1 6099.9 6102.9 6110.9 6166.7 5543.8 5573.5 5639.8 5656.4 5659.5 6170.2 6213.2 6233.5 6304.4 6311.0 5923.9 5964.7 5972.7 5981.4 6013.8 5972.8 6122.9 6132.7 6138.5 6159.0 5911.3 5935.7 5989.1 6009.1 6086.0 5997.2 6003.1 6048.3 6062.4 6074.1 4818.5 4845.3 4880.0 4881.4 4909.0 4266.9 4268.2 4276.6 4301.5 4328.6 5337.8 5687.6 5694.4 5700.1 5747.7 6181.2 6185.1 6189.2 6222.0 6231.2 4135.9 4575.8 4641.7 5035.1 5148.0 4455.7 4464.3 5210.2 5267.7 5283.0 6178.8 6197.9 6225.4 6300.5 6312.1 6104.6 6105.1 6119.5 6122.8 6125.4 6282.4 6287.9 6294.4 6299.0 6306.0 5896.5 5926.9 5960.4 5961.6 5970.3 5485.1 6065.2 6067.6 6094.7 6108.7 5576.4 5997.7 5999.0 6013.4 6019.7 4862.6 5727.9 5946.4 5965.1 5980.9 4807.8 5694.6 5760.6 5775.8 5866.6 5895.3 5912.1 5913.4 5928.4 5944.5 5709.8 5742.3 5853.4 5856.5 5871.3 09:54:44 INFO - PROCESS | 1998 | 09:54:44 INFO - PROCESS | 1998 | [#1] ext.html Cycles:180 Average:73351.21 Median:41527.69 stddev:163507.48 (393.7%) stddev-sans-first:163874.63 09:54:44 INFO - PROCESS | 1998 | Values: 483.6 490.8 519.7 524.8 532.9 39133.4 40313.8 40407.4 42691.4 42785.7 36903.7 39072.0 41572.0 42253.4 42261.6 9449.5 9619.5 9657.7 9666.6 9701.3 9399.7 9484.8 9487.9 9499.8 9509.2 9522.8 9527.0 9532.5 9534.3 9608.4 9492.0 9542.5 9548.5 9568.7 9577.4 8078.6 9446.2 9527.2 9544.9 9546.1 39372.0 39402.4 39446.2 39500.2 39642.4 3361.9 3528.2 3541.0 3705.2 3989.5 29961.6 30205.5 30345.7 30592.1 31323.5 3178.1 3191.2 3202.4 3242.9 3314.9 495143.0 505947.0 509224.0 510452.0 511768.0 57888.7 58162.7 58179.1 58324.4 58332.0 59301.1 59555.7 60315.7 60925.4 61051.0 12688.9 12702.3 14321.0 15183.5 15402.0 9837.5 11897.3 11978.8 12005.2 12005.9 13250.7 15789.0 16059.7 16325.3 16361.7 5913.8 7046.4 7059.8 7110.9 7145.8 707.3 954.7 970.5 1054.7 1107.9 28873.4 29627.7 29630.4 30041.9 30155.0 850.0 988.7 1017.9 1037.2 1041.3 14368.8 15325.7 15374.5 15391.7 15561.5 653622.0 677336.0 679639.0 680312.0 681102.0 56736.0 56798.7 57421.4 57572.4 57622.4 1375.5 1382.6 1398.8 1401.8 1408.5 28815.1 29676.1 29916.4 30303.2 30545.4 51012.2 51658.7 51719.2 51730.7 51861.0 630965.0 638843.0 639257.0 639402.0 642590.8 41286.3 41483.4 42044.2 42281.8 42287.2 46035.1 46738.1 47402.3 47491.8 47725.8 38586.4 38687.0 38954.0 39834.4 40132.8 37824.4 38134.0 38713.6 39541.0 39622.0 31806.4 32508.5 36014.0 37875.8 38128.9 33569.8 33717.5 34197.0 34265.3 34407.8 25268.9 25544.7 25647.9 26048.9 26183.7 09:54:44 INFO - PROCESS | 1998 | 09:54:44 INFO - PROCESS | 1998 | [#2] jquery.html Cycles:180 Average:34089.19 Median:12013.28 stddev:97572.76 (812.2%) stddev-sans-first:97813.55 09:54:44 INFO - PROCESS | 1998 | Values: 331.7 349.2 366.5 378.0 397.8 18933.1 18994.2 19598.7 19769.9 19859.5 19289.0 19326.9 19861.6 20140.9 20161.1 4775.6 5049.7 5586.5 5875.7 5887.4 4676.5 5780.9 5793.5 5796.4 5806.9 5741.3 5749.7 5756.9 5768.5 5779.6 5616.6 6106.8 6107.1 6119.5 6125.6 4957.6 5832.9 5869.6 5900.4 5930.5 12195.3 12359.4 12403.8 12606.9 12609.0 2301.0 2304.8 2308.4 2327.5 2487.2 9743.6 10151.6 10307.2 12032.2 14264.7 1724.4 1801.5 1845.0 1851.4 1917.6 109192.0 117445.0 119280.0 119600.4 119683.4 11485.4 11537.7 11660.3 11665.6 11773.8 14145.6 14269.6 14275.5 14285.4 14312.5 8198.5 8348.7 8371.1 8382.0 8503.1 7257.5 7743.4 8162.7 8346.1 8361.2 3709.4 4357.6 4427.3 4448.8 4507.7 1908.7 1914.6 1923.0 1929.7 1942.0 789.8 865.5 876.5 965.8 1012.2 19386.9 20177.5 20475.0 20778.4 21725.6 886.4 898.7 903.9 916.5 1021.0 10445.4 11002.6 11010.0 11013.8 11021.4 571790.0 574553.0 578327.0 592117.0 593386.0 121425.4 135810.3 137767.0 138991.0 140887.0 990.6 997.9 1011.5 1011.9 1025.9 16546.8 17210.6 18514.5 18529.0 18556.4 36349.5 40989.6 49254.8 57481.1 57897.8 68388.3 71348.6 77767.0 85395.1 86348.1 6671.4 7528.4 7798.5 8249.2 8286.5 12018.2 12127.6 12200.2 12482.3 12524.6 9916.6 10148.5 10437.2 10499.6 11181.4 8664.8 10436.0 10768.7 10770.4 11147.3 10811.6 10879.8 11283.2 11425.0 11533.7 8014.5 8059.7 8143.3 8207.0 8283.4 7594.9 10981.3 10988.5 11023.3 11078.1 09:54:44 INFO - PROCESS | 1998 | 09:54:44 INFO - PROCESS | 1998 | [#3] mootools.html Cycles:180 Average:5307.64 Median:5500.99 stddev:2890.29 (52.5%) stddev-sans-first:2883.69 09:54:44 INFO - PROCESS | 1998 | Values: 1427.4 1467.5 1514.2 1525.7 1636.3 7526.9 7737.5 7933.2 8416.7 8421.0 6508.4 8233.5 8266.5 8356.7 8372.9 2262.2 2302.5 2306.6 2316.1 2316.3 1727.7 2291.6 2348.5 2352.3 2357.8 2291.3 2297.0 2304.4 2321.2 2322.2 1871.0 2271.4 2291.0 2296.2 2305.9 2303.5 2311.4 2315.7 2321.7 2330.2 6830.9 8081.2 8147.0 8183.8 8185.8 4165.3 5170.4 5173.1 5180.6 5188.4 3226.5 3301.4 3541.4 3545.7 3546.7 901.5 1019.5 1041.8 1087.3 1091.9 10440.1 10609.2 10738.6 10742.8 10897.1 4259.6 4324.9 4384.9 4420.0 4434.0 8481.0 8548.0 8562.8 8569.0 8573.1 4393.9 4815.3 5011.2 5038.9 5053.8 4259.0 4438.6 4699.3 4710.5 4750.0 3549.2 3572.8 3640.6 3657.6 3667.7 1026.1 1102.2 1137.4 1149.8 1157.3 856.3 858.4 877.6 915.9 915.9 5544.3 5586.8 5658.5 5749.9 5853.4 911.5 917.0 919.2 926.3 972.7 3704.0 3721.3 3759.0 3819.3 3850.5 9302.1 9718.9 9728.0 9741.4 9751.2 9676.9 9688.1 9710.4 9712.1 9727.5 7732.6 7871.6 7899.3 7906.1 7922.3 4945.0 5495.6 5506.4 5630.7 5649.0 7810.5 9334.3 9420.6 9448.5 9486.2 8113.7 9293.7 9405.9 9447.4 9476.5 6551.8 6783.2 6921.0 7011.5 7191.4 7537.3 7860.1 7882.4 7902.2 7909.6 7070.2 7196.5 7225.7 7262.7 7330.9 6184.1 6940.6 7035.8 7042.4 7148.6 5675.2 6510.5 6612.0 6699.4 6770.1 4815.8 4838.1 4849.2 4887.9 4932.8 4796.1 4842.7 4844.8 4952.6 4983.6 09:54:44 INFO - PROCESS | 1998 | 09:54:44 INFO - PROCESS | 1998 | [#4] prototype.html Cycles:180 Average:4562.80 Median:4995.29 stddev:1435.64 (28.7%) stddev-sans-first:1403.34 09:54:44 INFO - PROCESS | 1998 | Values: 287.2 297.1 299.1 306.8 311.6 4178.9 4325.9 4535.0 4732.3 5330.9 4550.9 4976.8 5099.9 5200.0 5208.7 3522.5 3695.0 4199.2 4199.9 4219.5 4125.1 4210.8 4250.7 4252.6 4253.8 3476.4 4166.0 4185.0 4187.9 4189.6 4177.0 4178.8 4186.2 4211.6 4221.9 3645.3 3645.5 3674.4 3680.4 3684.7 4427.6 5056.1 5340.5 5374.6 5442.2 3557.9 4124.5 4376.7 4596.8 4665.2 5076.6 5370.6 5709.3 5839.6 5859.9 3031.5 3602.5 3855.2 3863.6 3913.6 5059.7 5239.9 5882.3 5977.3 6024.6 3227.0 3330.9 3898.0 3967.7 3977.0 3721.9 3965.0 3990.3 4009.7 4025.4 3976.0 4693.2 4699.0 4705.5 4728.4 5881.0 5897.1 5906.4 5907.9 5930.8 1280.7 1293.3 1339.0 1351.7 1360.0 802.6 847.7 882.7 891.0 908.9 5441.7 5502.2 5512.8 5514.6 5536.2 4717.8 5437.9 5608.7 5953.8 5960.3 4818.7 5190.5 5197.2 5389.4 5514.3 2391.7 2490.5 2623.3 2623.8 2650.5 4518.7 4932.3 4986.0 5043.3 5137.4 4406.5 4934.2 5003.6 5658.3 6283.2 5829.8 5854.7 5948.1 6384.5 6444.6 5192.0 5358.2 5799.4 6178.9 6181.3 4668.9 4886.9 4909.7 5282.2 5684.5 5137.1 5333.6 5695.8 5856.3 6504.2 3954.1 4091.8 4118.8 4123.3 4125.6 5524.2 6003.0 6045.8 6067.3 6074.1 5620.9 5823.7 5835.3 5839.2 5948.9 4910.8 5372.0 5868.8 5934.6 5934.7 4986.9 5178.4 5429.4 5736.4 5795.9 4976.1 5638.5 5914.9 5916.8 5975.3 4621.6 5747.0 5755.4 5761.4 5797.2 09:54:44 INFO - PROCESS | 1998 | 09:54:44 INFO - PROCESS | 1998 | [#5] yui.html Cycles:180 Average:19047.37 Median:26540.21 stddev:26598.10 (100.2%) stddev-sans-first:26636.96 09:54:44 INFO - PROCESS | 1998 | Values: 678.1 678.2 734.0 737.8 822.7 14529.5 14776.8 15168.9 15271.2 15563.8 13851.4 14154.6 14169.8 14215.4 14223.5 662.2 693.6 832.6 852.7 854.7 821.5 854.5 863.8 865.5 866.4 857.9 903.8 906.7 907.1 913.8 904.0 906.4 906.7 909.1 910.7 634.2 667.5 673.1 676.6 676.9 14083.9 14172.8 14353.2 14370.6 14812.9 13623.5 13837.2 13956.0 14054.6 14190.4 9444.6 11364.8 11462.4 11557.4 11692.8 3682.3 3726.5 3761.4 3857.6 3869.9 87131.6 88653.0 89880.0 89963.0 90834.5 10601.7 10634.7 10757.6 10802.2 11050.4 17995.8 20703.6 20761.0 21013.6 21285.8 7708.2 7743.9 7833.6 7877.4 7955.0 4295.0 4307.6 4329.1 4342.4 4347.5 3374.8 3479.7 3503.7 3514.6 3532.0 523.0 618.7 630.9 639.2 643.4 504.8 508.4 608.3 610.8 645.9 8891.2 8973.2 8997.3 9140.7 9372.5 510.7 519.6 582.8 608.3 614.0 4088.5 4126.6 4241.8 4430.9 4552.3 64332.0 75175.6 95211.0 98667.0 102151.5 59703.0 61425.4 72368.6 88346.0 90391.0 76282.6 77484.2 77873.2 78376.8 78828.0 7582.4 8233.8 9350.7 9372.3 9443.3 51049.2 52557.5 53017.0 54600.7 54781.7 65307.1 65594.7 75019.2 76870.2 77249.2 11872.2 11969.0 12014.9 12401.5 12828.0 11640.2 13849.7 13906.6 14116.4 14562.3 12840.7 13058.5 13087.3 13105.8 13598.6 12640.7 12707.6 12901.7 13024.2 13499.1 12541.4 13042.9 13252.1 13387.6 13424.1 7602.4 9503.6 9552.7 10014.7 10135.2 8503.7 9358.4 10038.3 10043.9 10086.2 09:54:44 INFO - PROCESS | 1998 | -------- Summary: end -------- 09:54:44 INFO - PROCESS | 1998 | 09:54:45 INFO - TEST-INFO | 1998: exit 0 09:54:45 INFO - TEST-OK | dromaeo_css | took 1116068ms 09:54:45 INFO - TEST-START | kraken 09:54:45 INFO - operating with platform_type : mac_ 09:54:45 INFO - Initialising browser for kraken test... 09:54:45 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpMbmro4/profile http://localhost:49664/getInfo.html) 09:54:48 INFO - PROCESS | 2004 | 2016-11-03 09:54:48.266 plugin-container[2006:15842] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8733, name = 'com.apple.tsm.portname' 09:54:48 INFO - PROCESS | 2004 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:54:48 INFO - PROCESS | 2004 | 2016-11-03 09:54:48.268 plugin-container[2006:15842] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.CFPasteboardClient' 09:54:48 INFO - PROCESS | 2004 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:54:48 INFO - PROCESS | 2004 | 2016-11-03 09:54:48.268 plugin-container[2006:15842] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:54:48 INFO - PROCESS | 2004 | __metrics Screen width/height:1600/1200 09:54:48 INFO - PROCESS | 2004 | colorDepth:24 09:54:48 INFO - PROCESS | 2004 | Browser inner width/height: 1024/689 09:54:48 INFO - PROCESS | 2004 | __metrics 09:54:48 ERROR - PROCESS | 2004 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 09:54:49 INFO - TEST-INFO | 2004: exit 0 09:54:49 INFO - Browser initialized. 09:54:49 INFO - Running cycle 1/1 for kraken test... 09:54:49 INFO - TEST-INFO | started process 2007 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpMbmro4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:54:51 INFO - PROCESS | 2007 | 2016-11-03 09:54:51.745 plugin-container[2008:15950] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4f, name = 'com.apple.tsm.portname' 09:54:51 INFO - PROCESS | 2007 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:54:51 INFO - PROCESS | 2007 | 2016-11-03 09:54:51.746 plugin-container[2008:15950] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 09:54:51 INFO - PROCESS | 2007 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:54:51 INFO - PROCESS | 2007 | 2016-11-03 09:54:51.746 plugin-container[2008:15950] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:55:01 INFO - PROCESS | 2007 | RSS: Main: 238952448 09:55:01 INFO - PROCESS | 2007 | 09:55:04 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49664/tests/kraken/driver.html?testName=audio-beat-detection) 09:55:05 INFO - PROCESS | 2007 | RSS: Main: 251392000 09:55:05 INFO - PROCESS | 2007 | 09:55:08 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49664/tests/kraken/driver.html?testName=audio-dft) 09:55:08 INFO - PROCESS | 2007 | RSS: Main: 259006464 09:55:08 INFO - PROCESS | 2007 | 09:55:12 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49664/tests/kraken/driver.html?testName=audio-fft) 09:55:13 INFO - PROCESS | 2007 | RSS: Main: 262213632 09:55:13 INFO - PROCESS | 2007 | 09:55:15 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49664/tests/kraken/driver.html?testName=audio-oscillator) 09:55:15 INFO - PROCESS | 2007 | RSS: Main: 263200768 09:55:15 INFO - PROCESS | 2007 | 09:55:17 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49664/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:55:18 INFO - PROCESS | 2007 | RSS: Main: 263503872 09:55:18 INFO - PROCESS | 2007 | 09:55:21 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49664/tests/kraken/driver.html?testName=imaging-darkroom) 09:55:22 INFO - PROCESS | 2007 | RSS: Main: 264867840 09:55:22 INFO - PROCESS | 2007 | 09:55:25 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49664/tests/kraken/driver.html?testName=imaging-desaturate) 09:55:25 INFO - PROCESS | 2007 | RSS: Main: 265437184 09:55:25 INFO - PROCESS | 2007 | 09:55:28 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49664/tests/kraken/driver.html?testName=json-parse-financial) 09:55:29 INFO - PROCESS | 2007 | RSS: Main: 265318400 09:55:29 INFO - PROCESS | 2007 | 09:55:31 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49664/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:55:31 INFO - PROCESS | 2007 | RSS: Main: 265039872 09:55:31 INFO - PROCESS | 2007 | 09:55:33 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49664/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:55:34 INFO - PROCESS | 2007 | RSS: Main: 265064448 09:55:34 INFO - PROCESS | 2007 | 09:55:36 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49664/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:55:37 INFO - PROCESS | 2007 | RSS: Main: 265113600 09:55:37 INFO - PROCESS | 2007 | 09:55:40 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:55:41 INFO - PROCESS | 2007 | RSS: Main: 265441280 09:55:41 INFO - PROCESS | 2007 | 09:55:44 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:55:45 INFO - PROCESS | 2007 | RSS: Main: 265527296 09:55:45 INFO - PROCESS | 2007 | 09:55:46 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49664/tests/kraken/driver.html?testName=ai-astar) 09:55:47 INFO - PROCESS | 2007 | RSS: Main: 267956224 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - PROCESS | 2007 | __start_tp_report 09:55:47 INFO - PROCESS | 2007 | _x_x_mozilla_page_load 09:55:47 INFO - PROCESS | 2007 | _x_x_mozilla_page_load_details 09:55:47 INFO - PROCESS | 2007 | |i|pagename|runs| 09:55:47 INFO - PROCESS | 2007 | |0;ai-astar;125;171;116;117;118;119;118;117;118;118 09:55:47 INFO - PROCESS | 2007 | |1;audio-beat-detection;156;124;151;181;145;136;145;144;159;112 09:55:47 INFO - PROCESS | 2007 | |2;audio-dft;263;275;241;275;206;195;197;198;196;198 09:55:47 INFO - PROCESS | 2007 | |3;audio-fft;82;55;53;76;60;86;86;87;107;61 09:55:47 INFO - PROCESS | 2007 | |4;audio-oscillator;85;72;89;94;102;106;126;71;65;108 09:55:47 INFO - PROCESS | 2007 | |5;imaging-gaussian-blur;101;74;86;132;134;105;91;87;90;87 09:55:47 INFO - PROCESS | 2007 | |6;imaging-darkroom;95;96;112;151;123;95;96;96;96;96 09:55:47 INFO - PROCESS | 2007 | |7;imaging-desaturate;88;79;137;138;88;109;146;115;87;87 09:55:47 INFO - PROCESS | 2007 | |8;json-parse-financial;58;58;57;57;57;72;89;89;89;91 09:55:47 INFO - PROCESS | 2007 | |9;json-stringify-tinderbox;70;77;69;82;75;72;72;69;90;109 09:55:47 INFO - PROCESS | 2007 | |10;stanford-crypto-aes;89;107;125;114;111;88;90;89;86;86 09:55:47 INFO - PROCESS | 2007 | |11;stanford-crypto-ccm;150;148;153;150;161;151;140;162;227;164 09:55:47 INFO - PROCESS | 2007 | |12;stanford-crypto-pbkdf2;239;189;242;241;189;177;177;174;211;180 09:55:47 INFO - PROCESS | 2007 | |13;stanford-crypto-sha256-iterative;70;89;90;94;81;68;67;69;71;71 09:55:47 INFO - PROCESS | 2007 | __end_tp_report 09:55:47 INFO - PROCESS | 2007 | __start_cc_report 09:55:47 INFO - PROCESS | 2007 | _x_x_mozilla_cycle_collect,983 09:55:47 INFO - PROCESS | 2007 | __end_cc_report 09:55:47 INFO - PROCESS | 2007 | __startTimestamp1478192147082__endTimestamp 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - PROCESS | 2007 | ------- Summary: start ------- 09:55:47 INFO - PROCESS | 2007 | Number of tests: 14 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - PROCESS | 2007 | [#0] ai-astar Cycles:10 Average:123.70 Median:118.00 stddev:16.80 (14.2%) stddev-sans-first:17.81 09:55:47 INFO - PROCESS | 2007 | Values: 125.0 171.0 116.0 117.0 118.0 119.0 118.0 117.0 118.0 118.0 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - PROCESS | 2007 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:148.00 stddev:19.03 (12.9%) stddev-sans-first:19.79 09:55:47 INFO - PROCESS | 2007 | Values: 156.0 124.0 151.0 181.0 145.0 136.0 145.0 144.0 159.0 112.0 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - PROCESS | 2007 | [#2] audio-dft Cycles:10 Average:224.40 Median:223.50 stddev:35.02 (15.7%) stddev-sans-first:34.25 09:55:47 INFO - PROCESS | 2007 | Values: 263.0 275.0 241.0 275.0 206.0 195.0 197.0 198.0 196.0 198.0 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - PROCESS | 2007 | [#3] audio-fft Cycles:10 Average:75.30 Median:79.00 stddev:17.52 (22.2%) stddev-sans-first:18.42 09:55:47 INFO - PROCESS | 2007 | Values: 82.0 55.0 53.0 76.0 60.0 86.0 86.0 87.0 107.0 61.0 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - PROCESS | 2007 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:71.50 stddev:19.26 (26.9%) stddev-sans-first:20.27 09:55:47 INFO - PROCESS | 2007 | Values: 85.0 72.0 89.0 94.0 102.0 106.0 126.0 71.0 65.0 108.0 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - PROCESS | 2007 | [#5] imaging-gaussian-blur Cycles:10 Average:98.70 Median:86.50 stddev:19.94 (23.1%) stddev-sans-first:21.14 09:55:47 INFO - PROCESS | 2007 | Values: 101.0 74.0 86.0 132.0 134.0 105.0 91.0 87.0 90.0 87.0 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - PROCESS | 2007 | [#6] imaging-darkroom Cycles:10 Average:105.60 Median:96.00 stddev:18.53 (19.3%) stddev-sans-first:19.25 09:55:47 INFO - PROCESS | 2007 | Values: 95.0 96.0 112.0 151.0 123.0 95.0 96.0 96.0 96.0 96.0 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - PROCESS | 2007 | [#7] imaging-desaturate Cycles:10 Average:107.40 Median:83.00 stddev:25.29 (30.5%) stddev-sans-first:25.83 09:55:47 INFO - PROCESS | 2007 | Values: 88.0 79.0 137.0 138.0 88.0 109.0 146.0 115.0 87.0 87.0 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - PROCESS | 2007 | [#8] json-parse-financial Cycles:10 Average:71.70 Median:80.50 stddev:15.97 (19.8%) stddev-sans-first:16.15 09:55:47 INFO - PROCESS | 2007 | Values: 58.0 58.0 57.0 57.0 57.0 72.0 89.0 89.0 89.0 91.0 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - PROCESS | 2007 | [#9] json-stringify-tinderbox Cycles:10 Average:78.50 Median:73.50 stddev:12.59 (17.1%) stddev-sans-first:12.97 09:55:47 INFO - PROCESS | 2007 | Values: 70.0 77.0 69.0 82.0 75.0 72.0 72.0 69.0 90.0 109.0 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - PROCESS | 2007 | [#10] stanford-crypto-aes Cycles:10 Average:98.50 Median:87.00 stddev:14.32 (16.5%) stddev-sans-first:14.77 09:55:47 INFO - PROCESS | 2007 | Values: 89.0 107.0 125.0 114.0 111.0 88.0 90.0 89.0 86.0 86.0 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - PROCESS | 2007 | [#11] stanford-crypto-ccm Cycles:10 Average:160.60 Median:157.00 stddev:24.45 (15.6%) stddev-sans-first:25.63 09:55:47 INFO - PROCESS | 2007 | Values: 150.0 148.0 153.0 150.0 161.0 151.0 140.0 162.0 227.0 164.0 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - PROCESS | 2007 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.90 Median:200.00 stddev:28.73 (14.4%) stddev-sans-first:27.15 09:55:47 INFO - PROCESS | 2007 | Values: 239.0 189.0 242.0 241.0 189.0 177.0 177.0 174.0 211.0 180.0 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - PROCESS | 2007 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.00 Median:76.00 stddev:10.46 (13.8%) stddev-sans-first:10.78 09:55:47 INFO - PROCESS | 2007 | Values: 70.0 89.0 90.0 94.0 81.0 68.0 67.0 69.0 71.0 71.0 09:55:47 INFO - PROCESS | 2007 | -------- Summary: end -------- 09:55:47 INFO - PROCESS | 2007 | 09:55:47 INFO - TEST-INFO | 2007: exit 0 09:55:47 INFO - TEST-OK | kraken | took 62755ms 09:55:47 INFO - SUITE-END | took 1178s 09:55:48 INFO - Completed test suite (00:19:39) 09:55:48 INFO - javascript benchmark 09:55:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7092.617337159881, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3314.950275745864, 3317.10438181691, 3320.4189266878293, 3325.8503367348467, 3382.0361197058814, 5451.945480545193, 5526.723663816808, 5534.169874518824, 5575.2473416088815, 5596.188552659862, 5460.590455715827, 5527.170924361348, 5552.750126244318, 5562.610617256793, 5638.971805140979, 5099.821506247282, 5101.9744901275535, 5121.206213036985, 5186.403563590179, 5190.558802501791, 5024.346834911456, 5199.714015729152, 5202.4277329493725, 5228.0850851101095, 5263.736813159327, 5001.499850015006, 5065.341505604285, 5168.302279192299, 5175.870603234912, 5185.481451854822, 5000.549950504472, 5035.77339019745, 5066.36670416198, 5066.468020857794, 5139.203423469368, 4387.407699960497, 5025.0954828130925, 5071.695698258116, 5095.8980820383385, 5146.922796158024, 4578.771061446948, 4987.202047672391, 5585.497305242548, 5603.439656034405, 5621.100623900156, 5954.880902381971, 5989.2812862456785, 6084.056971169432, 6087.969560152171, 6091.482224010964, 6084.117802918597, 6099.908501372439, 6102.908456373158, 6110.908336374958, 6166.660833654148, 5543.833684989457, 5573.498385145356, 5639.759252964301, 5656.4060773619, 5659.51894089003, 6170.167027451326, 6213.2233470816145, 6233.501319894398, 6304.3695630437505, 6311.0, 5923.881522369528, 5964.701764911737, 5972.718318127054, 5981.431763982415, 6013.819585412444, 5972.790952316648, 6122.938770612326, 6132.6627035513475, 6138.478229350466, 6159.0, 5911.3201981772645, 5935.73289201987, 5989.071693887455, 6009.128676341906, 6085.96957015221, 5997.160397544348, 6003.099535069775, 6048.274207095089, 6062.42406971337, 6074.119252708332, 4818.469968303484, 4845.297431872359, 4880.0, 4881.414230292387, 4909.042736666387, 4266.914661706748, 4268.210381079511, 4276.636485898671, 4301.483821941387, 4328.61042506176, 5337.759800808895, 5687.573431992617, 5694.402087780806, 5700.144978253295, 5747.6838773867, 6181.196444462281, 6185.072239164161, 6189.164462797555, 6221.96889015552, 6231.189945307081, 4135.875923722293, 4575.787416334674, 4641.721496710208, 5035.093683136997, 5148.0, 4455.732656040648, 4464.2633965396, 5210.244514545369, 5267.710275934784, 5283.0, 6178.752849886134, 6197.938020619736, 6225.439710426083, 6300.495960323255, 6312.116303717483, 6104.603200792112, 6105.053716673922, 6119.479844213113, 6122.785702500391, 6125.448709616156, 6282.403171698681, 6287.905681414874, 6294.433500984934, 6299.0, 6306.0, 5896.469317761422, 5926.940730592639, 5960.374160713236, 5961.552883533839, 5970.3432622412365, 5485.067538518381, 6065.150878876872, 6067.605605635619, 6094.725737341919, 6108.72510737009, 5576.414476479911, 5997.70011499432, 5998.970005149947, 6013.428724271187, 6019.668918209541, 4862.586680132228, 5727.8568035799435, 5946.43508866657, 5965.135055417027, 5980.940190598212, 4807.831725889577, 5694.629849059798, 5760.6255593386295, 5775.768969241183, 5866.5893387462465, 5895.292564892069, 5912.113183022581, 5913.379095194942, 5928.377520360473, 5944.494717949023, 5709.771609135588, 5742.310922689304, 5853.35613082552, 5856.502197313106, 5871.324797648154], "value": 5513.85154782837, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.6203580189551, 490.84783717047696, 519.651833271708, 524.763856264681, 532.9493698098679, 39133.41299880504, 40313.79843100784, 40407.39388909169, 42691.359629605584, 42785.71642850712, 36903.708370207045, 39071.99999999993, 41572.0, 42253.36619950703, 42261.57738422615, 9449.527523623809, 9619.470929098898, 9657.710268691915, 9666.613335466573, 9701.27240456965, 9399.718008459757, 9484.762880927963, 9487.857682134774, 9499.81000379992, 9509.239260859114, 9522.761930951712, 9527.0, 9532.475713835736, 9534.28492863038, 9608.423494590312, 9491.95254023729, 9542.475163865985, 9548.47483388417, 9568.712938611852, 9577.425354478753, 8078.636461359253, 9446.197073248783, 9527.190188833958, 9544.856827147598, 9546.140847323773, 39372.0, 39402.408963865564, 39446.211075778614, 39500.247476489974, 39642.40536391956, 3361.907380101477, 3528.1708798432346, 3540.982295088508, 3705.184859330943, 3989.5412027616617, 29961.619413148444, 30205.546916796266, 30345.696543034508, 30592.082237532908, 31323.53014704781, 3178.1300216239824, 3191.1543440988157, 3202.3595280943673, 3242.91892702682, 3314.9005529834144, 495143.0, 505947.0, 509224.0, 510452.0, 511767.9999999963, 57888.710556446946, 58162.709186454646, 58179.127313090336, 58324.416755832746, 58332.0, 59301.11048334278, 59555.70222148948, 60315.69842150761, 60925.39074609197, 61051.0, 12688.87311126877, 12702.301373424365, 14321.0, 15183.468578599695, 15402.0, 9837.508124593742, 11897.286162830258, 11978.760424791455, 12005.159638825373, 12005.939970300267, 13250.73498530024, 15789.0, 16059.678806423806, 16325.285844986343, 16361.672766544603, 5913.793017244376, 7046.365827075588, 7059.799834028227, 7110.857782844314, 7145.785626431215, 707.310372386929, 954.6849539651898, 970.5147426286857, 1054.7428503003425, 1107.851750375973, 28873.42253154925, 29627.703722962924, 29630.40739185204, 30041.94853180128, 30155.0, 849.9787505312416, 988.6984469736656, 1017.9032991865761, 1037.159900480613, 1041.250299784154, 14368.784468232985, 15325.693486130438, 15374.53876383688, 15391.692166156614, 15561.533154005398, 653622.0, 677336.0, 679639.0, 680312.0, 681102.0, 56736.0, 56798.71600642053, 57421.42578574161, 57572.42427575754, 57622.42377576171, 1375.5185685010367, 1382.5575815739069, 1398.776195808686, 1401.7827236778317, 1408.4507042253529, 28815.135545933656, 29676.10971670853, 29916.401671966873, 30303.242418939702, 30545.389092218476, 51012.23481647852, 51658.74170629123, 51719.2242116361, 51730.74134629303, 51861.0, 630965.0, 638843.0, 639257.0, 639402.0, 642590.7870460618, 41286.34854605782, 41483.37774933439, 42044.159116818104, 42281.78859105685, 42287.15425691407, 46035.07929841318, 46738.065238694355, 47402.28896566623, 47491.812704682656, 47725.76137119292, 38586.42120368253, 38687.03282417962, 38954.02614934536, 39834.40248396334, 40132.79933600313, 37824.43263351107, 38134.0, 38713.61286387213, 39541.0, 39622.0, 31806.36387272195, 32508.512372313962, 36014.0, 37875.81062094672, 38128.85613431602, 33569.83215083909, 33717.49423758597, 34196.974090777316, 34265.31469370649, 34407.827960860035, 25268.873655631603, 25544.744552554235, 25647.87176064108, 26048.86975565186, 26183.73816261813], "value": 19915.26514360387, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.68821307970506, 349.23517496682274, 366.51802879213847, 377.95653499847526, 397.78917173897827, 18933.148008339624, 18994.240230390784, 19598.706019409703, 19769.901150494265, 19859.50351241216, 19289.0, 19326.903365483155, 19861.602767944667, 20140.89225092623, 20161.09275082621, 4775.570198682118, 5049.747512624354, 5586.469285417878, 5875.735591898353, 5887.4406931341455, 4676.532346765313, 5780.913286300709, 5793.5365170786445, 5796.391378905218, 5806.912896306559, 5741.253637027181, 5749.712514374285, 5756.942430575683, 5768.451997060272, 5779.566532510057, 5616.5787565932515, 6106.816795496142, 6107.083937409379, 6119.541034422392, 6125.632462052291, 4957.603391728653, 5832.941670583282, 5869.559783016291, 5900.350961394286, 5930.466258036798, 12195.268283902995, 12359.443825027894, 12403.813942790865, 12606.936965315206, 12609.0, 2300.9884950575306, 2304.83866129371, 2308.3998160478227, 2327.476317828492, 2487.1916627096266, 9743.561539730728, 10151.593936242542, 10307.175425965905, 12032.157748957576, 14264.714705705932, 1724.4223185232836, 1801.4505575799376, 1844.9631007379912, 1851.4353122297694, 1917.5589614388768, 109192.0, 117445.0, 119280.0, 119600.40199798945, 119683.4015829924, 11485.425728713531, 11537.653870383901, 11660.30038197711, 11665.59170429031, 11773.823392649118, 14145.575632731034, 14269.571912842632, 14275.500357487437, 14285.428582856777, 14312.499062532761, 8198.549079800548, 8348.66605335792, 8371.079181290053, 8382.036065852382, 8503.107173746792, 7257.475930054642, 7743.380529557622, 8162.67349306033, 8346.081930987586, 8361.247487726012, 3709.4435834625024, 4357.564243575681, 4427.313766366218, 4448.822047118079, 4507.661925355612, 1908.7136929460692, 1914.636219118363, 1922.9903850480937, 1929.7394851695121, 1941.9708704369446, 789.7551758954743, 865.5209291914443, 876.5441970175473, 965.8406362950175, 1012.2003617142523, 19386.93371864561, 20177.495562611053, 20475.0, 20778.376648700563, 21725.56548869014, 886.3972498700946, 898.6899519665704, 903.9050899655573, 916.5188276154938, 1020.9795804083876, 10445.373277603216, 11002.614908478165, 11010.009099180952, 11013.779724405467, 11021.44892755359, 571790.0, 574553.0, 578327.0, 592117.0, 593386.0, 121425.39287303684, 135810.32094839463, 137767.0, 138991.0, 140887.0, 990.5542505872386, 997.9301448898508, 1011.5397494140149, 1011.898810118997, 1025.9487025648837, 16546.84172107941, 17210.569735756708, 18514.534955763284, 18529.0, 18556.350527731465, 36349.45475817812, 40989.59010409858, 49254.75372623114, 57481.114105301516, 57897.84204315806, 68388.31611683819, 71348.64325678338, 77767.0, 85395.14604853872, 86348.13651863401, 6671.39957403836, 7528.397728181622, 7798.454108212371, 8249.175082491704, 8286.46138001028, 12018.158728888893, 12127.636170914886, 12200.206986545845, 12482.313472759086, 12524.561640342545, 9916.553755081182, 10148.54331555067, 10437.16502679799, 10499.635047443784, 11181.385023823443, 8664.78338041554, 10436.0, 10768.676939691823, 10770.353778773298, 11147.331160130418, 10811.6215932442, 10879.78240435171, 11283.210175287652, 11424.971752542311, 11533.673627532606, 8014.519128852287, 8059.717909873127, 8143.267105960255, 8206.974128233971, 8283.420160588941, 7594.8860767089645, 10981.286216395909, 10988.450577471254, 11023.338599684044, 11078.058365039062], "value": 9210.47692122738, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.357689039932, 1467.515719812462, 1514.174774747763, 1525.687234117006, 1636.263681343395, 7526.887096693554, 7737.458377913535, 7933.246341597546, 8416.705415310465, 8421.031581368137, 6508.446782023534, 8233.464824786384, 8266.50400975942, 8356.707515236967, 8372.91627083729, 2262.151693115082, 2302.5394921015863, 2306.5732839424677, 2316.1198744477074, 2316.316686577455, 1727.7322015087682, 2291.564602725477, 2348.518553696497, 2352.3178278299356, 2357.787799098081, 2291.2897001929373, 2296.9655455168186, 2304.3893368257427, 2321.210788331967, 2322.2452702871633, 1871.0, 2271.3640180749335, 2290.954180916389, 2296.150424342987, 2305.8616483010987, 2303.5047464794984, 2311.3874823171873, 2315.6526521021815, 2321.6633588129794, 2330.2310237621546, 6830.897536536956, 8081.151479094669, 8147.02235731716, 8183.754487365389, 8185.79535511611, 4165.333546632524, 5170.353705786777, 5173.120569503156, 5180.559652429548, 5188.429272779991, 3226.451503244454, 3301.422251106047, 3541.3802584547857, 3545.663161999606, 3546.66306700863, 901.4861528928514, 1019.50553981319, 1041.7968496143255, 1087.2660953856196, 1091.939943303118, 10440.060394564525, 10609.204309676728, 10738.624148154855, 10742.785144297148, 10897.073748731287, 4259.61663450291, 4324.9135017300105, 4384.868453946387, 4419.977900110479, 4434.046679963823, 8481.006963363605, 8547.95726021366, 8562.78593035179, 8569.0, 8573.09982451846, 4393.879560711998, 4815.3258543803895, 5011.223260394645, 5038.949610503848, 5053.797848086109, 4259.0, 4438.5561443856, 4699.318598803155, 4710.458297295855, 4750.0, 3549.165946002687, 3572.7856328620364, 3640.581333146669, 3657.5918271465675, 3667.6515731006048, 1026.0662796854976, 1102.2174256277972, 1137.4483375562845, 1149.7585507043614, 1157.2940506291156, 856.3406177243488, 858.3948316436897, 877.6138499060393, 915.8671992561042, 915.8671992561175, 5544.3346798384455, 5586.804461843816, 5658.490735833795, 5749.9425005750245, 5853.385394533512, 911.5487833522317, 916.9816603667889, 919.1589695428607, 926.323783637948, 972.7081875437341, 3704.0369503929173, 3721.292954338667, 3758.981205094012, 3819.2934307153264, 3850.5186851643543, 9302.069793020644, 9718.854217186748, 9727.951360243154, 9741.415515069119, 9751.219902407933, 9676.854847177297, 9688.12806847373, 9710.417374957384, 9712.077352651488, 9727.464989425507, 7732.6133693315105, 7871.606419678993, 7899.289063984154, 7906.090799558009, 7922.326602238759, 4944.961558072845, 5495.587830912617, 5506.394296627448, 5630.662160270397, 5648.971755141362, 7810.453268271166, 9334.346595738232, 9420.576074076545, 9448.48033358172, 9486.193673537551, 8113.716019939274, 9293.72118836436, 9405.858912116188, 9447.433154010781, 9476.478793666414, 6551.770688025897, 6783.219929708147, 6920.9653951729915, 7011.474139439664, 7191.352778249982, 7537.283958023979, 7860.135385107519, 7882.408819338687, 7902.24928631779, 7909.604519773873, 7070.222275549582, 7196.460265480006, 7225.674844632109, 7262.6731797070315, 7330.926690733238, 6184.134221208944, 6940.618265995418, 7035.753748618774, 7042.436605071684, 7148.606826624586, 5675.205471234113, 6510.511711621552, 6612.041254018237, 6699.39705426514, 6770.086038384755, 4815.759212039454, 4838.129136755418, 4849.199882019428, 4887.853364399074, 4932.778024988812, 4796.06476737033, 4842.661013729146, 4844.781984810763, 4952.5542701157065, 4983.551480366785], "value": 4309.7520432286665, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.20587575354136, 297.1131173447261, 299.13848117421827, 306.8404429696557, 311.6400557356253, 4178.937315940263, 4325.891852703684, 4535.0, 4732.266498692704, 5330.92003619946, 4550.931736023954, 4976.825811096613, 5099.929014906865, 5199.974000130003, 5208.713520756357, 3522.5420695309704, 3694.9815250923707, 4199.2441360555085, 4199.874003779892, 4219.493660760705, 4125.133721918401, 4210.768407737573, 4250.681198910094, 4252.574742525738, 4253.8085786139545, 3476.4090104682136, 4166.020985068507, 4184.95376155961, 4187.916241675165, 4189.601987811153, 4176.979115104436, 4178.811953462102, 4186.162767446523, 4211.620954114144, 4221.91556168878, 3645.2527231917393, 3645.5260816094005, 3674.4120940649636, 3680.392735198689, 3684.7471859567877, 4427.6015158635555, 5056.140456122468, 5340.54605358545, 5374.5700343972385, 5442.2380866678695, 3557.8576856925692, 4124.546299907008, 4376.715513491613, 4596.816127354902, 4665.183592871234, 5076.64463487556, 5370.570354371641, 5709.343425506078, 5839.598496360843, 5859.912101318484, 3031.5301128325145, 3602.5496812898386, 3855.1904100139004, 3863.632954869283, 3913.5695073541888, 5059.721715305656, 5239.869003274911, 5882.264716910387, 5977.282726072855, 6024.578279520435, 3227.0318904328606, 3330.8501117449773, 3897.9610203898164, 3967.6627486663956, 3977.0455090778005, 3721.8648312264477, 3964.960350396459, 3990.341593637075, 4009.699272554512, 4025.355943049098, 3976.0, 4693.225617773098, 4699.0, 4705.529447055335, 4728.38530990969, 5881.0, 5897.144913987448, 5906.40935906406, 5907.940920590825, 5930.822075337746, 1280.6798300424894, 1293.2563775828935, 1338.9799153012711, 1351.6886124726827, 1359.9596308823757, 802.6147449224405, 847.7244895409017, 882.7175303902818, 890.9688160914337, 908.8682141089637, 5441.7279136043835, 5502.2296878437055, 5512.751926163332, 5514.5864060194845, 5536.169574563767, 4717.815474554731, 5437.921558830877, 5608.663480191201, 5953.791617293374, 5960.344362120163, 4818.747345541746, 5190.506901844319, 5197.22041693749, 5389.434109418533, 5514.283143191359, 2391.72495163055, 2490.5267999080115, 2623.317937336268, 2623.790096792252, 2650.5494066008823, 4518.740629685158, 4932.334134891816, 4986.002799440126, 5043.2687260347775, 5137.40919794221, 4406.537313582092, 4934.2483418385955, 5003.647556137396, 5658.292713410824, 6283.235376434354, 5829.766809327664, 5854.707264636836, 5948.078047902582, 6384.52116091295, 6444.645544495004, 5191.974040129775, 5358.223057656696, 5799.420057994167, 6178.921911538543, 6181.258249010148, 4668.85993420198, 4886.921239619017, 4909.685961975723, 5282.204050622807, 5684.545236380997, 5137.126688463045, 5333.626536191357, 5695.829125126253, 5856.326522449973, 6504.219493660791, 3954.070793363615, 4091.754494730326, 4118.814653340667, 4123.340265557496, 4125.566815484331, 5524.226608274765, 6003.0, 6045.848853778691, 6067.302260240129, 6074.145151778657, 5620.915686264628, 5823.7379317931645, 5835.270591176103, 5839.15332276809, 5948.851278718067, 4910.803567857246, 5371.973140134274, 5868.794592189253, 5934.6142500737315, 5934.732937017759, 4986.925196121989, 5178.404483484297, 5429.429909859408, 5736.42635736423, 5795.913061304, 4976.054549635558, 5638.4925356718095, 5914.911276330945, 5916.822495325147, 5975.25309336333, 4621.6302695784925, 5747.0, 5755.417260253464, 5761.423857614205, 5797.246357973437], "value": 4102.7597782386365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.0507289794291, 678.2335960364787, 733.9889901651476, 737.8044818123199, 822.6668199379252, 14529.491467798629, 14776.778348324784, 15168.938174327788, 15271.160086195256, 15563.766543501857, 13851.376688049037, 14154.575362739108, 14169.78745318821, 14215.431382744679, 14223.502177423792, 662.2185820731535, 693.5873155472486, 832.625318606628, 852.7271273192581, 854.7179430787857, 821.5029906906325, 854.5171977832505, 863.7840539865034, 865.523961820996, 866.4498043742205, 857.9270761985239, 903.7695387676166, 906.7007887397143, 907.1246247371286, 913.808100298938, 903.9875339619635, 906.3519583497831, 906.7461110888962, 909.0863681999548, 910.6994691751706, 634.1819053421082, 667.4626925325111, 673.0678010954814, 676.5534747066912, 676.89169732843, 14083.929580352033, 14172.787408188886, 14353.210573418457, 14370.568882933529, 14812.925935370255, 13623.479566769853, 13837.169769813843, 13956.0, 14054.648633784134, 14190.361433735403, 9444.622215111456, 11364.829527557093, 11462.369569673665, 11557.364344961024, 11692.766144677144, 3682.263547290526, 3726.5155529780955, 3761.4357846322996, 3857.633524815138, 3869.941950870739, 87131.56434217852, 88653.0, 89880.0, 89963.0, 90834.54582727044, 10601.681949541371, 10634.73413164677, 10757.569697212024, 10802.189835762349, 11050.392228427352, 17995.820041799678, 20703.58592828135, 20761.0, 21013.579728405348, 21285.78714212869, 7708.229177082247, 7743.92256077432, 7833.64748586315, 7877.448578599558, 7955.0, 4294.9785251073545, 4307.633851122627, 4329.134173165379, 4342.413774140514, 4347.456567929009, 3374.8481318340732, 3479.686828185425, 3503.737219708481, 3514.5606799150105, 3532.0, 522.9503197196336, 618.7494064903722, 630.8738252349549, 639.1690801957436, 643.3598569423453, 504.772852216504, 508.4000878962859, 608.2518502242267, 610.8028264601431, 645.9031145328145, 8891.19979201875, 8973.19241268276, 8997.32520060985, 9140.725778226664, 9372.484513351832, 510.652756125838, 519.6379425119471, 582.8455459303289, 608.2609629300421, 614.0420943328332, 4088.4684990950987, 4126.587341265909, 4241.809118589671, 4430.911381772346, 4552.271636538204, 64332.035019474744, 75175.62412187904, 95211.04788952161, 98667.0, 102151.4892425548, 59703.0, 61425.38574614286, 72368.63815680993, 88346.0, 90391.0, 76282.61858690671, 77484.22515774884, 77873.22126778659, 78376.82434763483, 78828.0, 7582.355499782359, 8233.752987410388, 9350.719478415658, 9372.250219982521, 9443.291753118407, 51049.23426148536, 52557.47442525679, 53017.0, 54600.72699636476, 54781.72609136929, 65307.06118224786, 65594.68810623857, 75019.24980750341, 76870.23129768854, 77249.22750772421, 11872.168948173545, 11969.0, 12014.879851201376, 12401.503939842667, 12827.973762099196, 11640.243384180001, 13849.653758656113, 13906.58280251594, 14116.364763585869, 14562.344694488562, 12840.678983025498, 13058.477660893837, 13087.345632718136, 13105.803412949004, 13598.592042238748, 12640.6839829005, 12707.551022440895, 12901.741965160832, 13024.231826130403, 13499.05506614567, 12541.372931353213, 13042.934785326013, 13252.138610990254, 13387.598372048855, 13424.060315777802, 7602.429817763579, 9503.619855205714, 9552.713418597454, 10014.699559013241, 10135.189184865341, 8503.702370417006, 9358.391704539183, 10038.347507411994, 10043.949780251345, 10086.243531735296], "value": 7117.698082291577, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1660.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 171.0, 116.0, 117.0, 118.0, 119.0, 118.0, 117.0, 118.0, 118.0], "value": 123.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 151.0, 181.0, 145.0, 136.0, 145.0, 144.0, 159.0, 112.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [263.0, 275.0, 241.0, 275.0, 206.0, 195.0, 197.0, 198.0, 196.0, 198.0], "value": 224.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 55.0, 53.0, 76.0, 60.0, 86.0, 86.0, 87.0, 107.0, 61.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 89.0, 94.0, 102.0, 106.0, 126.0, 71.0, 65.0, 108.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 74.0, 86.0, 132.0, 134.0, 105.0, 91.0, 87.0, 90.0, 87.0], "value": 98.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 112.0, 151.0, 123.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 105.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 79.0, 137.0, 138.0, 88.0, 109.0, 146.0, 115.0, 87.0, 87.0], "value": 107.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 57.0, 57.0, 72.0, 89.0, 89.0, 89.0, 91.0], "value": 71.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 77.0, 69.0, 82.0, 75.0, 72.0, 72.0, 69.0, 90.0, 109.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 107.0, 125.0, 114.0, 111.0, 88.0, 90.0, 89.0, 86.0, 86.0], "value": 98.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 153.0, 150.0, 161.0, 151.0, 140.0, 162.0, 227.0, 164.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [239.0, 189.0, 242.0, 241.0, 189.0, 177.0, 177.0, 174.0, 211.0, 180.0], "value": 201.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 89.0, 90.0, 94.0, 81.0, 68.0, 67.0, 69.0, 71.0, 71.0], "value": 77.0, "unit": "score"}]}]} 09:55:48 INFO - Return code: 0 09:55:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:55:48 ERROR - # TBPL SUCCESS # 09:55:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:55:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:55:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:55:48 INFO - 2016-11-03 09:55:48.422 screenresolution[2012:16338] starting screenresolution argv=screenresolution get 09:55:48 INFO - 2016-11-03 09:55:48.425 screenresolution[2012:16338] Display 0: 1600x1200x32@60 09:55:48 INFO - 2016-11-03 09:55:48.431 screenresolution[2013:16341] starting screenresolution argv=screenresolution list 09:55:48 INFO - Available Modes on Display 0 09:55:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:55:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:55:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:55:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:55:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:55:48 INFO - Intel Iris: 09:55:48 INFO - Chipset Model: Intel Iris 09:55:48 INFO - Type: GPU 09:55:48 INFO - Bus: Built-In 09:55:48 INFO - VRAM (Dynamic, Max): 1536 MB 09:55:48 INFO - Vendor: Intel (0x8086) 09:55:48 INFO - Device ID: 0x0a2e 09:55:48 INFO - Revision ID: 0x0009 09:55:48 INFO - Displays: 09:55:48 INFO - Display: 09:55:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:55:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:55:48 INFO - Display Serial Number: 1600x1200 60 09:55:48 INFO - Main Display: Yes 09:55:48 INFO - Mirror: Off 09:55:48 INFO - Online: Yes 09:55:48 INFO - Rotation: Supported 09:55:48 INFO - Return code: 0 09:55:48 INFO - Running post-action listener: _resource_record_post_action 09:55:48 INFO - [mozharness: 2016-11-03 16:55:48.669880Z] Finished run-tests step (success) 09:55:48 INFO - Running post-run listener: _resource_record_post_run 09:55:48 INFO - Total resource usage - Wall time: 1214s; CPU: 55.0%; Read bytes: 3026944; Write bytes: 711976448; Read time: 21; Write time: 2090 09:55:48 INFO - TinderboxPrint: CPU usage
54.6% 09:55:48 INFO - TinderboxPrint: I/O read bytes / time
3,026,944 / 21 09:55:48 INFO - TinderboxPrint: I/O write bytes / time
711,976,448 / 2,090 09:55:48 INFO - TinderboxPrint: CPU idle
2,205.3 (45.4%) 09:55:48 INFO - TinderboxPrint: CPU system
988.1 (20.3%) 09:55:48 INFO - TinderboxPrint: CPU user
1,664.3 (34.3%) 09:55:48 INFO - TinderboxPrint: Swap in / out
408,858,624 / 0 09:55:48 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398717440; Write bytes: 393385472; Read time: 29492; Write time: 904 09:55:48 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 3026944; Write bytes: 300702208; Read time: 21; Write time: 1133 09:55:49 INFO - Running post-run listener: _upload_blobber_files 09:55:49 INFO - Blob upload gear active. 09:55:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:55:49 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 09:55:49 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'] 09:55:49 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 09:55:49 INFO - (blobuploader) - INFO - Open directory for files ... 09:55:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:55:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:55:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:55:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:55:50 INFO - (blobuploader) - INFO - Done attempting. 09:55:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:55:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:55:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:55:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:55:51 INFO - (blobuploader) - INFO - Done attempting. 09:55:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:55:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:55:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:55:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:55:54 INFO - (blobuploader) - INFO - Done attempting. 09:55:54 INFO - (blobuploader) - INFO - Iteration through files over. 09:55:54 INFO - Return code: 0 09:55:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:55:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:55:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0a07101a36b0019c813d0346f21a57e0054bfeb1de3fc09c8e5c8c8f2b408156807cbc03156a6c0e995657a62f30096c4a9cef3d1a8781ec041a35502b680d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/252b4777ef799f8fc557e8d663e435c9a8ea1d0ec69e0b65d51d62492e73e0e47f3903425c9dc9062e053322255458676f692cac5c658ec1cec24003a53a81bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb0691b07c120402eadfe059fa2c0373a6dcfb888ec20b0260793e0b7debe393ceea6311bb1af0a3f3b16b77b7146718813c14b99e2e2a232f2f9a19eeaea71a"} 09:55:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:55:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:55:54 INFO - Contents: 09:55:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0a07101a36b0019c813d0346f21a57e0054bfeb1de3fc09c8e5c8c8f2b408156807cbc03156a6c0e995657a62f30096c4a9cef3d1a8781ec041a35502b680d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/252b4777ef799f8fc557e8d663e435c9a8ea1d0ec69e0b65d51d62492e73e0e47f3903425c9dc9062e053322255458676f692cac5c658ec1cec24003a53a81bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb0691b07c120402eadfe059fa2c0373a6dcfb888ec20b0260793e0b7debe393ceea6311bb1af0a3f3b16b77b7146718813c14b99e2e2a232f2f9a19eeaea71a"} 09:55:54 INFO - Running post-run listener: copy_logs_to_upload_dir 09:55:54 INFO - Copying logs to upload dir... 09:55:54 INFO - mkdir: /builds/slave/test/build/upload/logs 09:55:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1336.226027 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 16 secs) (at 2016-11-03 09:55:54.176637) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 09:55:54.180230) ========= 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.Se26TZsVHi/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.pLB3dkTHG0/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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/c0a07101a36b0019c813d0346f21a57e0054bfeb1de3fc09c8e5c8c8f2b408156807cbc03156a6c0e995657a62f30096c4a9cef3d1a8781ec041a35502b680d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/252b4777ef799f8fc557e8d663e435c9a8ea1d0ec69e0b65d51d62492e73e0e47f3903425c9dc9062e053322255458676f692cac5c658ec1cec24003a53a81bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb0691b07c120402eadfe059fa2c0373a6dcfb888ec20b0260793e0b7debe393ceea6311bb1af0a3f3b16b77b7146718813c14b99e2e2a232f2f9a19eeaea71a"} build_url:https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010766 build_url: 'https://queue.taskcluster.net/v1/task/A-hk7bvuTnWbKRgRyAVXeg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0a07101a36b0019c813d0346f21a57e0054bfeb1de3fc09c8e5c8c8f2b408156807cbc03156a6c0e995657a62f30096c4a9cef3d1a8781ec041a35502b680d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/252b4777ef799f8fc557e8d663e435c9a8ea1d0ec69e0b65d51d62492e73e0e47f3903425c9dc9062e053322255458676f692cac5c658ec1cec24003a53a81bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb0691b07c120402eadfe059fa2c0373a6dcfb888ec20b0260793e0b7debe393ceea6311bb1af0a3f3b16b77b7146718813c14b99e2e2a232f2f9a19eeaea71a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 09:55:54.215329) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 09:55:54.215658) ========= 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.Se26TZsVHi/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.pLB3dkTHG0/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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.005289 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 09:55:54.264818) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 09:55:54.265131) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 09:55:54.265438) ========= ========= Total master_lag: 0.19 =========